builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0066 starttime: 1459340460.72 results: success (0) buildid: 20160330030326 builduid: 0c5e38b63ef04aa8a520b9b40bbea151 revision: d5d53a3b4e50b94cdf85d20690526e5a00d5b63e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:00.715322) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:00.715747) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:00.716049) ========= 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.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.005679 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:00.738615) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:00.738924) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:00.755557) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:00.755886) ========= 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.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.005382 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:00.804697) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:00.805014) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:00.805384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:00.805655) ========= 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.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-30 05:21:00-- 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% 161M=0s 2016-03-30 05:21:00 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102540 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:00.924411) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:00.924717) ========= 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.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.019929 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:00.972495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-30 05:21:00.972830) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d5d53a3b4e50b94cdf85d20690526e5a00d5b63e --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 d5d53a3b4e50b94cdf85d20690526e5a00d5b63e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-30 05:21:01,055 truncating revision to first 12 chars 2016-03-30 05:21:01,056 Setting DEBUG logging. 2016-03-30 05:21:01,056 attempt 1/10 2016-03-30 05:21:01,056 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d5d53a3b4e50?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-30 05:21:02,255 unpacking tar archive at: mozilla-central-d5d53a3b4e50/testing/mozharness/ program finished with exit code 0 elapsedTime=1.451030 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-30 05:21:02.446640) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:02.450132) ========= echo d5d53a3b4e50b94cdf85d20690526e5a00d5b63e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd5d53a3b4e50b94cdf85d20690526e5a00d5b63e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 d5d53a3b4e50b94cdf85d20690526e5a00d5b63e program finished with exit code 0 elapsedTime=0.004325 script_repo_revision: 'd5d53a3b4e50b94cdf85d20690526e5a00d5b63e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:02.502949) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:02.503374) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-30 05:21:02.518029) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-30 05:21:02.518329) ========= /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.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:21:02 INFO - MultiFileLogger online at 20160330 05:21:02 in /builds/slave/test 05:21:02 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 05:21:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:21:02 INFO - {'append_to_log': False, 05:21:02 INFO - 'base_work_dir': '/builds/slave/test', 05:21:02 INFO - 'blob_upload_branch': 'Firefox', 05:21:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:21:02 INFO - 'branch': 'Firefox', 05:21:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:21:02 INFO - 'config_files': ('talos/mac_config.py',), 05:21:02 INFO - 'default_actions': ('clobber', 05:21:02 INFO - 'read-buildbot-config', 05:21:02 INFO - 'download-and-extract', 05:21:02 INFO - 'populate-webroot', 05:21:02 INFO - 'create-virtualenv', 05:21:02 INFO - 'install', 05:21:02 INFO - 'run-tests'), 05:21:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:21:02 INFO - 'download_minidump_stackwalk': True, 05:21:02 INFO - 'download_symbols': 'ondemand', 05:21:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:21:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:21:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:21:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:21:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:21:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:21:02 INFO - 'installer_path': 'installer.exe', 05:21:02 INFO - 'log_level': 'info', 05:21:02 INFO - 'log_name': 'talos', 05:21:02 INFO - 'log_to_console': True, 05:21:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:21:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:21:02 INFO - 'opt_config_files': (), 05:21:02 INFO - 'pip_index': False, 05:21:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:21:02 INFO - 'cmd': ('bash', 05:21:02 INFO - '-c', 05:21:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:21:02 INFO - 'enabled': True, 05:21:02 INFO - 'halt_on_failure': False, 05:21:02 INFO - 'name': 'check_screen_resolution'},), 05:21:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:21:02 INFO - 'cmd': ('bash', 05:21:02 INFO - '-c', 05:21:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:21:02 INFO - 'enabled': True, 05:21:02 INFO - 'halt_on_failure': False, 05:21:02 INFO - 'name': 'check_screen_resolution'},), 05:21:02 INFO - 'run_cmd_checks_enabled': True, 05:21:02 INFO - 'sps_profile': False, 05:21:02 INFO - 'sps_profile_interval': 0, 05:21:02 INFO - 'suite': 'dromaeojs', 05:21:02 INFO - 'system_bits': '32', 05:21:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:21:02 INFO - 'title': 't-yosemite-r7-0066', 05:21:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:21:02 INFO - 'use_talos_json': True, 05:21:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:21:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:21:02 INFO - 'work_dir': 'build'} 05:21:02 INFO - ##### 05:21:02 INFO - ##### Running clobber step. 05:21:02 INFO - ##### 05:21:02 INFO - Running pre-action listener: _resource_record_pre_action 05:21:02 INFO - Running main action method: clobber 05:21:02 INFO - rmtree: /builds/slave/test/build 05:21:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:21:03 INFO - Running post-action listener: _resource_record_post_action 05:21:03 INFO - ##### 05:21:03 INFO - ##### Running read-buildbot-config step. 05:21:03 INFO - ##### 05:21:03 INFO - Running pre-action listener: _resource_record_pre_action 05:21:03 INFO - Running main action method: read_buildbot_config 05:21:03 INFO - Using buildbot properties: 05:21:03 INFO - { 05:21:03 INFO - "project": "", 05:21:03 INFO - "product": "firefox", 05:21:03 INFO - "script_repo_revision": "production", 05:21:03 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:21:03 INFO - "repository": "", 05:21:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:21:03 INFO - "buildid": "20160330030326", 05:21:03 INFO - "stage_platform": "macosx64", 05:21:03 INFO - "basedir": "/builds/slave/test", 05:21:03 INFO - "nightly_build": "True", 05:21:03 INFO - "buildnumber": 191, 05:21:03 INFO - "slavename": "t-yosemite-r7-0066", 05:21:03 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:21:03 INFO - "platform": "yosemite_r7", 05:21:03 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:21:03 INFO - "branch": "mozilla-central", 05:21:03 INFO - "repo_path": "mozilla-central", 05:21:03 INFO - "revision": "d5d53a3b4e50b94cdf85d20690526e5a00d5b63e", 05:21:03 INFO - "pgo_build": "False", 05:21:03 INFO - "builduid": "0c5e38b63ef04aa8a520b9b40bbea151", 05:21:03 INFO - "slavebuilddir": "test" 05:21:03 INFO - } 05:21:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:21:03 INFO - Running post-action listener: _resource_record_post_action 05:21:03 INFO - ##### 05:21:03 INFO - ##### Running download-and-extract step. 05:21:03 INFO - ##### 05:21:03 INFO - Running pre-action listener: _resource_record_pre_action 05:21:03 INFO - Running main action method: download_and_extract 05:21:03 INFO - mkdir: /builds/slave/test/build/tests 05:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:03 INFO - https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:21:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:21:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:21:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:21:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:21:05 INFO - Downloaded 1199 bytes. 05:21:05 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:21:05 INFO - Using the following test package requirements: 05:21:05 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:21:05 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:05 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:21:05 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:05 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:21:05 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:05 INFO - u'jsshell-mac.zip'], 05:21:05 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:05 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:21:05 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:21:05 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:05 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:21:05 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:05 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:21:05 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:05 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:21:05 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:21:05 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:21:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:21: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')]} 05:21:05 INFO - https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:21:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:21:06 INFO - Downloaded 17944949 bytes. 05:21:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:21:09 INFO - Return code: 0 05:21:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:09 INFO - https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:21:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:21:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:21:10 INFO - Downloaded 17944949 bytes. 05:21:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:21:14 INFO - Return code: 0 05:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:14 INFO - https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:21:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:21:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:21:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:21:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:21:16 INFO - Downloaded 10847531 bytes. 05:21:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:21:16 INFO - Return code: 0 05:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:16 INFO - https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:21:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:21:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:21:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:21:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:21:19 INFO - Downloaded 111535949 bytes. 05:21:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:21:19 INFO - mkdir: /builds/slave/test/properties 05:21:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:21:19 INFO - Writing to file /builds/slave/test/properties/build_url 05:21:19 INFO - Contents: 05:21:19 INFO - build_url:https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:21:20 INFO - Running post-action listener: _resource_record_post_action 05:21:20 INFO - Running post-action listener: set_extra_try_arguments 05:21:20 INFO - ##### 05:21:20 INFO - ##### Running populate-webroot step. 05:21:20 INFO - ##### 05:21:20 INFO - Running pre-action listener: _resource_record_pre_action 05:21:20 INFO - Running main action method: populate_webroot 05:21:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:21:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:21:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:21:20 INFO - '--tppagecycles', 05:21:20 INFO - '7'], 05:21:20 INFO - 'tests': ['tsvgm']}}, 05:21:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:21:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:21:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:21:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:21:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:21:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:21:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:20 INFO - 'talos_options': ['--e10s'], 05:21:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:20 INFO - 'tests': ['damp', 'tps']}, 05:21:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:20 INFO - 'talos_options': ['--e10s'], 05:21:20 INFO - 'tests': ['damp', 'tps']}, 05:21:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:21:20 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 05:21:20 INFO - 'tests': ['dromaeo_dom']}, 05:21:20 INFO - 'other': {'tests': ['a11yr', 05:21:20 INFO - 'ts_paint', 05:21:20 INFO - 'tpaint', 05:21:20 INFO - 'sessionrestore', 05:21:20 INFO - 'sessionrestore_no_auto_restore', 05:21:20 INFO - 'tabpaint']}, 05:21:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:21:20 INFO - 'tests': ['a11yr', 05:21:20 INFO - 'ts_paint', 05:21:20 INFO - 'tpaint', 05:21:20 INFO - 'sessionrestore', 05:21:20 INFO - 'sessionrestore_no_auto_restore', 05:21:20 INFO - 'tabpaint']}, 05:21:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:21:20 INFO - 'tests': ['a11yr', 05:21:20 INFO - 'ts_paint', 05:21:20 INFO - 'tpaint', 05:21:20 INFO - 'sessionrestore', 05:21:20 INFO - 'sessionrestore_no_auto_restore', 05:21:20 INFO - 'tabpaint']}, 05:21:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:21:20 INFO - 'tests': ['a11yr', 05:21:20 INFO - 'ts_paint', 05:21:20 INFO - 'tpaint', 05:21:20 INFO - 'sessionrestore', 05:21:20 INFO - 'sessionrestore_no_auto_restore', 05:21:20 INFO - 'tabpaint']}, 05:21:20 INFO - 'other_l64': {'tests': ['a11yr', 05:21:20 INFO - 'ts_paint', 05:21:20 INFO - 'tpaint', 05:21:20 INFO - 'sessionrestore', 05:21:20 INFO - 'sessionrestore_no_auto_restore', 05:21:20 INFO - 'tabpaint']}, 05:21:20 INFO - 'other_nol64': {'tests': ['a11yr', 05:21:20 INFO - 'ts_paint', 05:21:20 INFO - 'tpaint', 05:21:20 INFO - 'sessionrestore', 05:21:20 INFO - 'sessionrestore_no_auto_restore', 05:21:20 INFO - 'tabpaint']}, 05:21:20 INFO - 'svgr': {'tests': ['tsvgx', 05:21:20 INFO - 'tsvgr_opacity', 05:21:20 INFO - 'tart', 05:21:20 INFO - 'tscrollx', 05:21:20 INFO - 'cart']}, 05:21:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:21:20 INFO - 'tests': ['tsvgx', 05:21:20 INFO - 'tsvgr_opacity', 05:21:20 INFO - 'tart', 05:21:20 INFO - 'tscrollx', 05:21:20 INFO - 'cart']}, 05:21:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:20 INFO - 'tests': ['tp5o']}, 05:21:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:20 INFO - 'talos_options': ['--e10s'], 05:21:20 INFO - 'tests': ['tp5o']}, 05:21:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:20 INFO - 'talos_options': ['--xperf_path', 05:21:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:20 INFO - 'tests': ['tp5n']}, 05:21:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:20 INFO - 'talos_options': ['--e10s', 05:21:20 INFO - '--xperf_path', 05:21:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:20 INFO - 'tests': ['tp5n']}}, 05:21:20 INFO - 'talos.zip': {'path': '', 05:21:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:21:20 INFO - Running post-action listener: _resource_record_post_action 05:21:20 INFO - ##### 05:21:20 INFO - ##### Running create-virtualenv step. 05:21:20 INFO - ##### 05:21:20 INFO - Running pre-action listener: _resource_record_pre_action 05:21:20 INFO - Running main action method: create_virtualenv 05:21:20 INFO - Creating virtualenv /builds/slave/test/build/venv 05:21:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:21:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:21:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:21:20 INFO - Using real prefix '/tools/python27' 05:21:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:21:21 INFO - Installing distribute.............................................................................................................................................................................................done. 05:21:24 INFO - Installing pip.................done. 05:21:24 INFO - Return code: 0 05:21:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1045daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045ea420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff472cb0dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104479e00>, '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 0x1042a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104474b20>, '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.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:21:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VsFU8EwzbZ/Render', 05:21:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:24 INFO - 'HOME': '/Users/cltbld', 05:21:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:24 INFO - 'LOGNAME': 'cltbld', 05:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:24 INFO - 'MOZ_NO_REMOTE': '1', 05:21:24 INFO - 'NO_EM_RESTART': '1', 05:21:24 INFO - 'PAGER': '/bin/cat', 05:21:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:24 INFO - 'PWD': '/builds/slave/test', 05:21:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:24 INFO - 'SHELL': '/bin/bash', 05:21:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBqCxhKBhj/Listeners', 05:21:24 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:21:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:24 INFO - 'USER': 'cltbld', 05:21:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:24 INFO - 'XPC_FLAGS': '0x0', 05:21:24 INFO - 'XPC_SERVICE_NAME': '0', 05:21:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:21:24 INFO - Cleaning up... 05:21:24 INFO - Return code: 0 05:21:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1045daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045ea420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff472cb0dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104479e00>, '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 0x1042a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104474b20>, '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.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:21:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VsFU8EwzbZ/Render', 05:21:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:24 INFO - 'HOME': '/Users/cltbld', 05:21:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:24 INFO - 'LOGNAME': 'cltbld', 05:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:24 INFO - 'MOZ_NO_REMOTE': '1', 05:21:24 INFO - 'NO_EM_RESTART': '1', 05:21:24 INFO - 'PAGER': '/bin/cat', 05:21:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:24 INFO - 'PWD': '/builds/slave/test', 05:21:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:24 INFO - 'SHELL': '/bin/bash', 05:21:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBqCxhKBhj/Listeners', 05:21:24 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:21:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:24 INFO - 'USER': 'cltbld', 05:21:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:24 INFO - 'XPC_FLAGS': '0x0', 05:21:24 INFO - 'XPC_SERVICE_NAME': '0', 05:21:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:25 INFO - Downloading/unpacking psutil>=0.7.1 05:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:21:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:27 INFO - Installing collected packages: psutil 05:21:27 INFO - Running setup.py install for psutil 05:21:27 INFO - building 'psutil._psutil_osx' extension 05:21:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:21:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:21:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:21:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:21:28 INFO - building 'psutil._psutil_posix' extension 05:21:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:21:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:21:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:21:28 INFO - ^ 05:21:28 INFO - 1 warning generated. 05:21:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:21:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:28 INFO - Successfully installed psutil 05:21:28 INFO - Cleaning up... 05:21:28 INFO - Return code: 0 05:21:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:28 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 0x1045daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045ea420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff472cb0dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104479e00>, '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 0x1042a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104474b20>, '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.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:21:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VsFU8EwzbZ/Render', 05:21:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:28 INFO - 'HOME': '/Users/cltbld', 05:21:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:28 INFO - 'LOGNAME': 'cltbld', 05:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:28 INFO - 'MOZ_NO_REMOTE': '1', 05:21:28 INFO - 'NO_EM_RESTART': '1', 05:21:28 INFO - 'PAGER': '/bin/cat', 05:21:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:28 INFO - 'PWD': '/builds/slave/test', 05:21:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:28 INFO - 'SHELL': '/bin/bash', 05:21:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBqCxhKBhj/Listeners', 05:21:28 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:21:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:28 INFO - 'USER': 'cltbld', 05:21:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:28 INFO - 'XPC_FLAGS': '0x0', 05:21:28 INFO - 'XPC_SERVICE_NAME': '0', 05:21:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:21:31 INFO - Installing collected packages: mozsystemmonitor 05:21:31 INFO - Running setup.py install for mozsystemmonitor 05:21:31 INFO - Successfully installed mozsystemmonitor 05:21:31 INFO - Cleaning up... 05:21:31 INFO - Return code: 0 05:21:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:31 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 0x1045daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045ea420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff472cb0dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104479e00>, '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 0x1042a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104474b20>, '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.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:21:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VsFU8EwzbZ/Render', 05:21:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:31 INFO - 'HOME': '/Users/cltbld', 05:21:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:31 INFO - 'LOGNAME': 'cltbld', 05:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:31 INFO - 'MOZ_NO_REMOTE': '1', 05:21:31 INFO - 'NO_EM_RESTART': '1', 05:21:31 INFO - 'PAGER': '/bin/cat', 05:21:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:31 INFO - 'PWD': '/builds/slave/test', 05:21:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:31 INFO - 'SHELL': '/bin/bash', 05:21:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBqCxhKBhj/Listeners', 05:21:31 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:21:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:31 INFO - 'USER': 'cltbld', 05:21:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:31 INFO - 'XPC_FLAGS': '0x0', 05:21:31 INFO - 'XPC_SERVICE_NAME': '0', 05:21:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:31 INFO - Downloading/unpacking blobuploader==1.2.4 05:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:33 INFO - Downloading blobuploader-1.2.4.tar.gz 05:21:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:21:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:21:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21:35 INFO - Downloading docopt-0.6.1.tar.gz 05:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:21:35 INFO - Installing collected packages: blobuploader, requests, docopt 05:21:35 INFO - Running setup.py install for blobuploader 05:21:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:21:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:21:35 INFO - Running setup.py install for requests 05:21:35 INFO - Running setup.py install for docopt 05:21:36 INFO - Successfully installed blobuploader requests docopt 05:21:36 INFO - Cleaning up... 05:21:36 INFO - Return code: 0 05:21:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:36 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 0x1045daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045ea420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff472cb0dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104479e00>, '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 0x1042a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104474b20>, '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.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VsFU8EwzbZ/Render', 05:21:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:36 INFO - 'HOME': '/Users/cltbld', 05:21:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:36 INFO - 'LOGNAME': 'cltbld', 05:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:36 INFO - 'MOZ_NO_REMOTE': '1', 05:21:36 INFO - 'NO_EM_RESTART': '1', 05:21:36 INFO - 'PAGER': '/bin/cat', 05:21:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:36 INFO - 'PWD': '/builds/slave/test', 05:21:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:36 INFO - 'SHELL': '/bin/bash', 05:21:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBqCxhKBhj/Listeners', 05:21:36 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:21:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:36 INFO - 'USER': 'cltbld', 05:21:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:36 INFO - 'XPC_FLAGS': '0x0', 05:21:36 INFO - 'XPC_SERVICE_NAME': '0', 05:21:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:36 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-y43JZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:36 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-oYFK5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:36 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-z5svJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:36 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-3Co51n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:36 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-PaBgCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:36 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-wTEh58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:36 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-eziG16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:37 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-u4QWl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:37 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-BLtTCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:37 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-ffrVHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:37 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-QASfeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:37 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-s1M2oT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:37 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-TvHKrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:37 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-hxkBwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:37 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-jeGVzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:37 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Zd1hGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:38 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-F81Y6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:21:38 INFO - Running setup.py install for manifestparser 05:21:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:21:38 INFO - Running setup.py install for mozcrash 05:21:38 INFO - Running setup.py install for mozdebug 05:21:38 INFO - Running setup.py install for mozdevice 05:21:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:21:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:21:38 INFO - Running setup.py install for mozfile 05:21:38 INFO - Running setup.py install for mozhttpd 05:21:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:21:39 INFO - Running setup.py install for mozinfo 05:21:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:21:39 INFO - Running setup.py install for mozInstall 05:21:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:21:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:21:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:21:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:21:39 INFO - Running setup.py install for mozleak 05:21:39 INFO - Running setup.py install for mozlog 05:21:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:21:39 INFO - Running setup.py install for moznetwork 05:21:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:21:39 INFO - Running setup.py install for mozprocess 05:21:39 INFO - Running setup.py install for mozprofile 05:21:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:21:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:21:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:21:40 INFO - Running setup.py install for mozrunner 05:21:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:21:40 INFO - Running setup.py install for mozscreenshot 05:21:40 INFO - Running setup.py install for moztest 05:21:40 INFO - Running setup.py install for mozversion 05:21:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:21:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:21:40 INFO - Cleaning up... 05:21:40 INFO - Return code: 0 05:21:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:40 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 0x1045daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045ea420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff472cb0dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104479e00>, '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 0x1042a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104474b20>, '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.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:21:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VsFU8EwzbZ/Render', 05:21:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:40 INFO - 'HOME': '/Users/cltbld', 05:21:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:40 INFO - 'LOGNAME': 'cltbld', 05:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:40 INFO - 'MOZ_NO_REMOTE': '1', 05:21:40 INFO - 'NO_EM_RESTART': '1', 05:21:40 INFO - 'PAGER': '/bin/cat', 05:21:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:40 INFO - 'PWD': '/builds/slave/test', 05:21:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:40 INFO - 'SHELL': '/bin/bash', 05:21:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBqCxhKBhj/Listeners', 05:21:40 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:21:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:40 INFO - 'USER': 'cltbld', 05:21:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:40 INFO - 'XPC_FLAGS': '0x0', 05:21:40 INFO - 'XPC_SERVICE_NAME': '0', 05:21:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:40 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-ydh5Wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:41 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-JtPLeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:41 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-3f0pGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:41 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-om5ZJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:41 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-YqYoQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:41 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-PAeF8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:41 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-ocxdAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:41 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-rLbipz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:41 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-UA7wzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:41 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-mERc8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:42 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-h60ZN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:42 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-EDD7kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:42 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Sf4GqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:42 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-f4Uu90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:42 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-j1Wtdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:42 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-qSsDro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:42 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-aEjIiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:45 INFO - Downloading blessings-1.6.tar.gz 05:21:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:21:45 INFO - Installing collected packages: blessings 05:21:45 INFO - Running setup.py install for blessings 05:21:45 INFO - Successfully installed blessings 05:21:45 INFO - Cleaning up... 05:21:45 INFO - Return code: 0 05:21:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:21:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:45 INFO - Reading from file tmpfile_stdout 05:21:45 INFO - Current package versions: 05:21:45 INFO - blessings == 1.6 05:21:45 INFO - blobuploader == 1.2.4 05:21:45 INFO - docopt == 0.6.1 05:21:45 INFO - manifestparser == 1.1 05:21:45 INFO - mozInstall == 1.12 05:21:45 INFO - mozcrash == 0.17 05:21:45 INFO - mozdebug == 0.1 05:21:45 INFO - mozdevice == 0.48 05:21:45 INFO - mozfile == 1.2 05:21:45 INFO - mozhttpd == 0.7 05:21:45 INFO - mozinfo == 0.9 05:21:45 INFO - mozleak == 0.1 05:21:45 INFO - mozlog == 3.1 05:21:45 INFO - moznetwork == 0.27 05:21:45 INFO - mozprocess == 0.22 05:21:45 INFO - mozprofile == 0.28 05:21:45 INFO - mozrunner == 6.11 05:21:45 INFO - mozscreenshot == 0.1 05:21:45 INFO - mozsystemmonitor == 0.0 05:21:45 INFO - moztest == 0.7 05:21:45 INFO - mozversion == 1.4 05:21:45 INFO - psutil == 3.1.1 05:21:45 INFO - requests == 1.2.3 05:21:45 INFO - wsgiref == 0.1.2 05:21:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:45 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 0x1045daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045ea420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff472cb0dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104479e00>, '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 0x1042a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104474b20>, '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.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VsFU8EwzbZ/Render', 05:21:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:45 INFO - 'HOME': '/Users/cltbld', 05:21:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:45 INFO - 'LOGNAME': 'cltbld', 05:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:45 INFO - 'MOZ_NO_REMOTE': '1', 05:21:45 INFO - 'NO_EM_RESTART': '1', 05:21:45 INFO - 'PAGER': '/bin/cat', 05:21:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:45 INFO - 'PWD': '/builds/slave/test', 05:21:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:45 INFO - 'SHELL': '/bin/bash', 05:21:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBqCxhKBhj/Listeners', 05:21:45 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:21:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:45 INFO - 'USER': 'cltbld', 05:21:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:45 INFO - 'XPC_FLAGS': '0x0', 05:21:45 INFO - 'XPC_SERVICE_NAME': '0', 05:21:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:21:46 INFO - Cleaning up... 05:21:46 INFO - Return code: 0 05:21:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:46 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 0x1045daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045ea420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff472cb0dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104479e00>, '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 0x1042a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104474b20>, '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.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:21:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VsFU8EwzbZ/Render', 05:21:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:46 INFO - 'HOME': '/Users/cltbld', 05:21:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:46 INFO - 'LOGNAME': 'cltbld', 05:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:46 INFO - 'MOZ_NO_REMOTE': '1', 05:21:46 INFO - 'NO_EM_RESTART': '1', 05:21:46 INFO - 'PAGER': '/bin/cat', 05:21:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:46 INFO - 'PWD': '/builds/slave/test', 05:21:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:46 INFO - 'SHELL': '/bin/bash', 05:21:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBqCxhKBhj/Listeners', 05:21:46 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:21:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:46 INFO - 'USER': 'cltbld', 05:21:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:46 INFO - 'XPC_FLAGS': '0x0', 05:21:46 INFO - 'XPC_SERVICE_NAME': '0', 05:21:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:46 INFO - Downloading/unpacking jsonschema 05:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:21:48 INFO - Downloading/unpacking functools32 (from jsonschema) 05:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:49 INFO - Downloading functools32-3.2.3-2.tar.gz 05:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:21:49 INFO - warning: no files found matching '*.txt' 05:21:49 INFO - no previously-included directories found matching 'build' 05:21:49 INFO - no previously-included directories found matching 'dist' 05:21:49 INFO - no previously-included directories found matching '.git*' 05:21:49 INFO - Installing collected packages: jsonschema, functools32 05:21:49 INFO - Running setup.py install for functools32 05:21:49 INFO - warning: no files found matching '*.txt' 05:21:49 INFO - no previously-included directories found matching 'build' 05:21:49 INFO - no previously-included directories found matching 'dist' 05:21:49 INFO - no previously-included directories found matching '.git*' 05:21:49 INFO - Successfully installed jsonschema functools32 05:21:49 INFO - Cleaning up... 05:21:49 INFO - Return code: 0 05:21:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:49 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 0x1045daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045ea420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff472cb0dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104479e00>, '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 0x1042a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104474b20>, '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.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:21:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:21:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VsFU8EwzbZ/Render', 05:21:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:21:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:21:49 INFO - 'HOME': '/Users/cltbld', 05:21:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:21:49 INFO - 'LOGNAME': 'cltbld', 05:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:49 INFO - 'MOZ_NO_REMOTE': '1', 05:21:49 INFO - 'NO_EM_RESTART': '1', 05:21:49 INFO - 'PAGER': '/bin/cat', 05:21:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:49 INFO - 'PWD': '/builds/slave/test', 05:21:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:21:49 INFO - 'SHELL': '/bin/bash', 05:21:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBqCxhKBhj/Listeners', 05:21:49 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:21:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:21:49 INFO - 'USER': 'cltbld', 05:21:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:21:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:49 INFO - 'XPC_FLAGS': '0x0', 05:21:49 INFO - 'XPC_SERVICE_NAME': '0', 05:21:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:49 INFO - Downloading/unpacking flake8 05:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:21:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:21:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:21:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:53 INFO - no previously-included directories found matching 'docs/_build' 05:21:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:21:53 INFO - Running setup.py install for pep8 05:21:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:53 INFO - no previously-included directories found matching 'docs/_build' 05:21:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:21:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:21:53 INFO - Cleaning up... 05:21:53 INFO - Return code: 0 05:21:53 INFO - Running post-action listener: _resource_record_post_action 05:21:53 INFO - Running post-action listener: _start_resource_monitoring 05:21:53 INFO - Starting resource monitoring. 05:21:53 INFO - ##### 05:21:53 INFO - ##### Running install step. 05:21:53 INFO - ##### 05:21:53 INFO - Running pre-action listener: _resource_record_pre_action 05:21:53 INFO - Running main action method: install 05:21:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:54 INFO - Reading from file tmpfile_stdout 05:21:54 INFO - Detecting whether we're running mozinstall >=1.0... 05:21:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:21:54 INFO - Reading from file tmpfile_stdout 05:21:54 INFO - Output received: 05:21:54 INFO - Usage: mozinstall [options] installer 05:21:54 INFO - Options: 05:21:54 INFO - -h, --help show this help message and exit 05:21:54 INFO - -d DEST, --destination=DEST 05:21:54 INFO - Directory to install application into. [default: 05:21:54 INFO - "/builds/slave/test"] 05:21:54 INFO - --app=APP Application being installed. [default: firefox] 05:21:54 INFO - mkdir: /builds/slave/test/build/application 05:21:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:21:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:22:28 INFO - Reading from file tmpfile_stdout 05:22:28 INFO - Output received: 05:22:28 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:22:28 INFO - Running post-action listener: _resource_record_post_action 05:22:28 INFO - ##### 05:22:28 INFO - ##### Running run-tests step. 05:22:28 INFO - ##### 05:22:28 INFO - Running pre-action listener: _resource_record_pre_action 05:22:28 INFO - Running main action method: run_tests 05:22:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:22:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:22:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:22:28 INFO - 2016-03-30 05:22:28.394 screenresolution[1946:11785] starting screenresolution argv=screenresolution get 05:22:28 INFO - 2016-03-30 05:22:28.396 screenresolution[1946:11785] Display 0: 1600x1200x32@60 05:22:28 INFO - 2016-03-30 05:22:28.402 screenresolution[1947:11787] starting screenresolution argv=screenresolution list 05:22:28 INFO - Available Modes on Display 0 05:22:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:22:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:22:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:22:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:22:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:22:28 INFO - Intel Iris: 05:22:28 INFO - Chipset Model: Intel Iris 05:22:28 INFO - Type: GPU 05:22:28 INFO - Bus: Built-In 05:22:28 INFO - VRAM (Dynamic, Max): 1536 MB 05:22:28 INFO - Vendor: Intel (0x8086) 05:22:28 INFO - Device ID: 0x0a2e 05:22:28 INFO - Revision ID: 0x0009 05:22:28 INFO - Displays: 05:22:28 INFO - Display: 05:22:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:22:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:22:28 INFO - Display Serial Number: 1600x1200 60 05:22:28 INFO - Main Display: Yes 05:22:28 INFO - Mirror: Off 05:22:28 INFO - Online: Yes 05:22:28 INFO - Rotation: Supported 05:22:28 INFO - Return code: 0 05:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:22:28 INFO - Python 2.7.3 05:22:28 INFO - Return code: 0 05:22:28 INFO - grabbing minidump binary from tooltool 05:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:28 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 0x104479e00>, '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 0x1042a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104474b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:22:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:22:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:22:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:22:28 INFO - Return code: 0 05:22:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:22:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:22:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:22:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:22:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:22:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:22:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:22:29 INFO - Return code: 0 05:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 05:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0066 --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 05:22:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VsFU8EwzbZ/Render', 05:22:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:29 INFO - 'HOME': '/Users/cltbld', 05:22:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:29 INFO - 'LOGNAME': 'cltbld', 05:22:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:22:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:22:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:29 INFO - 'MOZ_NO_REMOTE': '1', 05:22:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:22:29 INFO - 'NO_EM_RESTART': '1', 05:22:29 INFO - 'PAGER': '/bin/cat', 05:22:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:29 INFO - 'PWD': '/builds/slave/test', 05:22:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:22:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:29 INFO - 'SHELL': '/bin/bash', 05:22:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KBqCxhKBhj/Listeners', 05:22:29 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 05:22:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:29 INFO - 'USER': 'cltbld', 05:22:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:29 INFO - 'XPC_FLAGS': '0x0', 05:22:29 INFO - 'XPC_SERVICE_NAME': '0', 05:22:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 05:22:30 INFO - mozversion application_buildid: 20160330030326 05:22:30 INFO - mozversion application_changeset: d5d53a3b4e50b94cdf85d20690526e5a00d5b63e 05:22:30 INFO - mozversion application_display_name: Nightly 05:22:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:22:30 INFO - mozversion application_name: Firefox 05:22:30 INFO - mozversion application_remotingname: firefox 05:22:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:22:30 INFO - mozversion application_vendor: Mozilla 05:22:30 INFO - mozversion application_version: 48.0a1 05:22:30 INFO - mozversion platform_buildid: 20160330030326 05:22:30 INFO - mozversion platform_changeset: d5d53a3b4e50b94cdf85d20690526e5a00d5b63e 05:22:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:22:30 INFO - mozversion platform_version: 48.0a1 05:22:30 INFO - using testdate: 1459340550 05:22:30 INFO - actual date: 1459340550 05:22:30 INFO - starting webserver on 'localhost:51294' 05:22:30 INFO - SUITE-START | Running 2 tests 05:22:30 INFO - TEST-START | dromaeo_css 05:22:30 INFO - operating with platform_type : mac_ 05:22:30 INFO - Initialising browser for dromaeo_css test... 05:22:30 INFO - TEST-INFO | started process 1965 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmppHChXl/profile http://localhost:51294/getInfo.html) 05:22:32 INFO - PROCESS | 1965 | __metrics Screen width/height:1600/1200 05:22:32 INFO - PROCESS | 1965 | colorDepth:24 05:22:32 INFO - PROCESS | 1965 | Browser inner width/height: 1024/689 05:22:32 INFO - PROCESS | 1965 | __metrics 05:22:32 INFO - PROCESS | 1965 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:22:32 ERROR - PROCESS | 1965 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:22:33 INFO - TEST-INFO | 1965: exit 0 05:22:33 INFO - Browser initialized. 05:22:33 INFO - Running cycle 1/1 for dromaeo_css test... 05:22:33 INFO - TEST-INFO | started process 1969 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmppHChXl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:45 INFO - PROCESS | 1969 | RSS: Main: 244789248 05:22:45 INFO - PROCESS | 1969 | 05:23:36 INFO - PROCESS | 1969 | 1459340616162 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:25:46 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:51294/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51294/tests/dromaeo/cssquery-ext.html) 05:25:47 INFO - PROCESS | 1969 | RSS: Main: 341872640 05:25:47 INFO - PROCESS | 1969 | 05:28:50 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:51294/tests/dromaeo/cssquery-ext.html (next: http://localhost:51294/tests/dromaeo/cssquery-jquery.html) 05:28:51 INFO - PROCESS | 1969 | RSS: Main: 374927360 05:28:51 INFO - PROCESS | 1969 | 05:31:52 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:51294/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51294/tests/dromaeo/cssquery-mootools.html) 05:31:53 INFO - PROCESS | 1969 | RSS: Main: 374702080 05:31:53 INFO - PROCESS | 1969 | 05:34:55 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:51294/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51294/tests/dromaeo/cssquery-prototype.html) 05:34:56 INFO - PROCESS | 1969 | RSS: Main: 338722816 05:34:56 INFO - PROCESS | 1969 | 05:37:59 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:51294/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51294/tests/dromaeo/cssquery-yui.html) 05:37:59 INFO - PROCESS | 1969 | RSS: Main: 338309120 05:37:59 INFO - PROCESS | 1969 | 05:41:02 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:51294/tests/dromaeo/cssquery-yui.html (next: http://localhost:51294/tests/dromaeo/cssquery-dojo.html) 05:41:02 INFO - PROCESS | 1969 | RSS: Main: 420651008 05:41:02 INFO - PROCESS | 1969 | 05:41:02 INFO - PROCESS | 1969 | __start_tp_report 05:41:02 INFO - PROCESS | 1969 | _x_x_mozilla_page_load 05:41:02 INFO - PROCESS | 1969 | _x_x_mozilla_page_load_details 05:41:02 INFO - PROCESS | 1969 | |i|pagename|runs| 05:41:02 INFO - PROCESS | 1969 | |0;dojo.html;3386.2211691311;3458.325626502833;3474.496198051281;3485.867093194712;3536.982315088424;5554.638948468357;5623.184638227454;5638.069718496448;5650.519705825005;5664.263645726055;5397.568194544437;5417.810376636819;5668.886622267552;5797.101449275358;5804.622699524528;4927.6550641455115;5077.492250774921;5092.083424983502;5105.18317069269;5191.636585439021;5188.533032027117;5213.374395072597;5231.503007214308;5261.789528418859;5293.708846013467;5051.924221136667;5077.441481437039;5152;5159.7678104485385;5176.896462070757;5161.561267292284;5166.276721259027;5183.844484665466;5225.190095535198;5236.371635403738;5071.264666623356;5102.260172275037;5104.591632669378;5129;5170.96580683861;5041.596672266247;5240.711760853152;5403.972980135113;5574.60977731559;5596.496315331639;6086.080695666055;6087.889601477322;6091.664958427285;6134.754609815602;6138.969305153446;6148.262208534959;6169.136320915076;6201.534884883652;6269.3730626937395;6284.214473190851;5644.689542075225;5689.743961521742;5713.485786279255;5715.371309155989;5771.68255745938;6176.413240742122;6248.187735594343;6259.906101408483;6279.058141278845;6299.244090709052;4790.353302304145;5949.405059494016;6051.818445446644;6055;6122.245686735438;6156.445919867234;6235.532335074797;6238.189035425366;6245.594036387621;6260.46786023184;6116.480099191618;6175.752969881154;6181.690915454209;6188.566800323934;6198.907016394758;6046.486048685911;6117.340260877713;6130.203073600493;6171.321154672983;6184.319724830265;4784.928226076611;4802.063597598504;4811.133995880775;4832.734199618984;4844.878878028007;4319.222539942778;4338.197433474817;4339.804708788112;4374.103308821684;4394.055278115156;5546.334439867242;5594.41258667834;5661.179129026268;5687.77248910039;5692.31692196939;6202.878342712088;6225.906611400833;6232.657203853832;6239.282482514478;6251.499880009588;5660.264165658438;5668.064769313017;5680.091185410397;5682.914756278659;5691.203231547586;5094.439611642716;5181.5854731621375;5289.497497737709;5374.48942350476;5384.461553844584;6259.436650701458;6260.749570017239;6264.59280146789;6268.153799237045;6275.058741188767;5130.384353877558;6207.088698282489;6213.254409470893;6251.124842521959;6262.780802671885;6130.795626845359;6202.968985155046;6278.686065696788;6328.272248691459;6346.111544383883;6110.938890611214;6127.601705889103;6160.815175544741;6162.044883043135;6179.011358182849;6110.388961104032;6183.938160618516;6223.937760622336;6243.125962365363;6246.250449946036;5975.492083172805;6027.879442411039;6090.177825993434;6092.512598992159;6112.17485639433;5961.105834124916;5988.4909782668965;5989.550783691154;5992.5205983520345;6006.429389208019;5054.974725126351;5749.367569567428;5837.328707198726;5877;5903.911441328298;5997.520198384206;6027.336992930862;6092.603980741238;6114.054656999343;6115.7247923844425;5837.328707198557;5852;5876.41235876409;5887.587868849139;5900.881982360414 05:41:02 INFO - PROCESS | 1969 | |1;ext.html;457;486.09343574234066;590.7902694543437;610.6366711806475;643.7103303513419;30021.699783002165;30335.393292134144;30350.54474182889;36823.4476482853;37404.43893341602;40772.18455630886;40930.38604420936;40985;41047;41316.58683413165;9647.903520964806;9874.1113299803;9875.950620246924;9879.407235565888;9894.455804930725;8028.357731381476;9777.46223957682;9781.559829807677;9783.119519243266;9791.608335666564;9829.459379734111;9895.208383329353;9914.256430767686;9917.652882149127;9980.800383992315;9848;9887.653932112413;9910.55402506889;9913.157381622535;9914.55384507699;9745.756356091084;9779.51102444875;9785.168260697848;9800.411975281506;9841;39891.80054099711;40286.597134028576;40398;40399.59600403988;40530.79734601308;3206.7915585486867;3353.6814002669707;3461.671141241578;3652.8721494747556;3842.50047493824;28472.00695951284;29071.273218169503;29825.70174298251;29969.700302997127;29992.70007299943;2699;2744.163030275765;2767.6540432445945;2833.6174616426724;2930.3260250142375;358902;359921;360650;360677;361560;62787.05819412712;62935.6853215731;62937.68531157315;63134.0529892052;63160.684196578724;65289;65376.67311663411;65459.34540654628;65544;65587.67206163939;15239.238038098272;17030.233639486254;17193.828061719472;17220.741688874677;17247.396341128253;11775.587854425054;11845.76308473843;11861.76276474483;11874.1094417919;13039.348032598333;14862.42858990243;18897.716534252;19381;19389.90305048494;19420.51448713765;8364.623591938378;8479.872801907977;8511.829763404698;8563.314934805201;8582.442141260799;942.40157499988;996.6860438961849;1006.9949650251848;1039.6517166749225;1051.7370657335666;28615.9984400545;28881.71118288832;28890.411027393697;29532.114036578936;29769.553456698166;1100.9889901100887;1102.2780079048237;1111.927724697892;1191.6484637031922;1194.3669854976877;14522;14770.764053246905;14846.40614375413;15108.39566417353;15140.772888406682;523737;531303;531446;531726;533566;55975;57755.71122144363;57977;58022;58247.70876145592;1356.837179538442;1376.1399125546534;1377.7451171533098;1378.6415531961761;1471.5291106845707;24861;29238.55842374361;29459;29784;30513.542296865122;51468.227976579634;54268.45731542634;55257;55328;55350;310376;312632.43683781434;350026;351090;362201;27711.722882770915;31274;31661.8416907914;31751.88868389595;31831.726730930503;41173.79413102915;43047.354289685056;44262.778686106365;44300.33549496825;44329;34196.37910121453;34710.30579388449;35727.28545429129;36345;36778.26443471169;32253.838730807136;33982.49026264559;34790.47814282737;35567;35914;28613.856930715214;30679.2330191747;32006.35987280288;35604.28791424105;36058;29646.851765741896;30851.537226942062;30854.228644283176;30858.845705771328;30951.84524077365;20703.689444658645;21116.155353785678;23671.408214794767;24008.39979000539;24333 05:41:02 INFO - PROCESS | 1969 | |2;jquery.html;309.9256178517156;367.4176430357883;370.18928546483215;373.2572181359096;376.2568926370417;18311.542211444703;19573;20247.898760506196;20317.390478285673;20377.18491260348;19092.904535477304;19595.608087838234;20081;20181.697274540893;20183.19267229309;5683.403242659513;5865.530757539408;5906.202662640531;5908.350081491032;5912.231409916705;5566.471185237417;5775.1337299405;5778.393268706788;5877.588568800185;5893.911591326134;5686.545076393899;5721.656700597957;5725.599208055438;5726.971365143168;5729.111987641902;5640;5697.401772813857;5711.885762284773;5711.942880571203;5782.132680097977;4400.559944005574;4900.313956046157;4972.03045406146;5064.721440320781;5071.2139618359215;25326.733663316943;25487;25511.48977020449;25555.361115972064;26045.869770651214;2301.160076572056;2310.3415526575013;2350.4123969007746;2652.4827658606578;2862.885484580635;14606.853931460762;14808.481703140445;15081.94426390153;15557.377704891791;15561.533154005398;1753.5528440247783;1798.1638538079856;1800.333876465703;1803.0353760737942;1812.6012277298973;98622;99605.5019724904;100644.99355006503;100935.49532252365;101225.4938725309;10138;10226.28416010872;10472.528736206888;10485.37087774736;10530.473476326153;12867.742645147044;12870.806937895939;12888.80666789999;12909.935450322688;12913.483460661657;8424.705135320357;8572.528510931834;8600.182982616641;8682.52246126469;8741.213290803858;8025.678972841138;8792.340574456814;8812.942446906412;8896.332775041898;8910.287177025823;5498.890022199534;6062.999210260604;6091.451769340781;6111.786087486917;6140.324564297924;1597.7777000594554;1781.4744650328184;1788.195312109556;1797.9640407192044;1799.7750281214849;901.3735453859505;927.4064598656865;934.3412893909777;1030.124394264869;1076.6500887211687;20146.294879679434;21358.466038349165;21520.784792151877;21692.674609880865;21835;924.9537523123817;975.9560819763128;984.8768903887014;1050.858134151895;1051.3691784929135;8901.821963560822;10709.089727373104;11036.779264414827;11102.278351907262;11112.888871111185;609299;613772;618331;633193;633291;113194.43402782934;115838;116236;117109.82890171159;117739;967.4485543240426;1073.302353470235;1075.7902209069314;1149.5459293579156;1149.8735139134687;17999.550011249823;17999.910000449912;18208.99850508235;18220.635587288445;18515.444536663923;50087.49912500828;51035;51400.48599513957;52108;53093.469065308855;71033.28966710267;71673.92489112563;71838.64080679564;73059.63470182614;75379.62310188414;7557.886631700419;7791.220877912164;7898.368130549427;7942.761717148494;8212.425130240827;8503;11766.470508826953;12105.576304829288;12157.75684486323;12577.182483138567;10287.119606510189;10725.30285531438;10844.511996960313;11075.280106793032;11146.944265278946;10396.272260941661;10458.790824183627;10670.89329106699;10850.511726972147;10850.945745271223;10884.945575272073;10947.671569852917;11140.832887506533;11215;11326.546938122383;7542.509736867086;7812.101608315116;7830.373570114263;7907.84184316299;7940.205979402013;10706.89293107059;10730.570777168827;10986.670399888017;11040.668779936615;11047.116230701686 05:41:02 INFO - PROCESS | 1969 | |3;mootools.html;1458.314592141693;1471.7792331150329;1652.7438247071705;1908.3702378215191;2060.1141509151057;7252.927470725291;8209.466384684998;9028.638854445831;9028.90971090289;9044.231240344563;8664.220220180183;8949.194572488475;8965.551722413886;8975.640974361035;9009.279257659387;2082.0422605601443;2088.4778805298674;2430.331658793837;2461.298529918969;2494.5759220932487;2502.074232533965;2506.1980166346775;2506.6240063990367;2510.134003768697;2510.1716433576876;2437.5124975004983;2497.2882728422405;2513.723490416062;2515.949681006379;2518.156417600106;2429.441228517442;2491.813114016438;2493.8379005364773;2497.3756560859783;2507.5862482690336;2457.127719659513;2485.689288838895;2512.271441282026;2522.0794410040385;2522.092046863128;8931.866022009675;9059;9066.637334506611;9070.047644997312;9087;5504.284443022381;5644.181593668895;5672.092465205547;5674.687892165929;5680.772769089232;3199.520071989197;3571.23218508022;3576.91057723559;3638.1268495560876;3737.906552336186;915.9587818548115;1001.8547310639916;1011.1657882247175;1082.929609575375;1085.1210519479248;12454.315012674298;12473.625791226277;12475.875241247562;12499.187552809039;12515.687107822287;4873.342098816614;4913.877153071202;5013.172826483662;5021.723805190676;5038.143515602356;10378.06597406222;10382.792344153075;10386.844197337046;10388.636397726043;10407.959204079683;5584.497395234448;5606.439356064361;5609.775608975595;5619.943800562024;5635.887282254332;4481.955180448219;4606.262997920317;4854.150523658345;5007.974960125176;5035.697858128524;3326.866925323008;3847.076701591598;3935.980320098381;3972.56301806801;4022.014606421387;1295.1387327427155;1309.9869001310055;1312.5471712259255;1321.6497628128554;1322.9140105893086;1372.6019454358325;1400.1459109942928;1424.4302279088447;1425.059460755917;1425.4868247430916;8341.374396920255;8668.653253869901;8683.305335573139;8686.261667758185;8687.305015598737;1065.3607835298915;1154.9951542158376;1192.4276347353318;1193.8268951002055;1232.9136960412864;5261.842144735664;6417.839554011187;6428.8071357859335;6449.451796597342;6462.965925451905;10361.015703508154;10710.089642380484;10819;10833.187510936554;10917.39954302521;10261.333013354108;10658.307210031324;10701.892981070245;10706.892931070746;10707.839382409271;6678.732850686015;8408.41141120128;8412.074671786098;8471.449355791854;8473.49159050459;8176.059753128228;8275.089740128702;8329.541875196923;8351.457155284887;8449.155084491502;9657.806843863224;9942.701718948443;9953.601855925972;9975.401475911469;10058.497075146068;10049.89950100519;10371.58513659445;10402.583896644352;10507.579696812347;10539.42033188182;6778.084958530732;6796.402845331244;7694.038245219348;7709.537427754352;7835.608219588884;8488.872666910125;8498.660053598034;8552.828943421222;8553.914460855562;8557.57212139403;7394.704211831467;7469.551826890404;7557.659905304385;7567.8108047297055;7585.734499292498;7303.598302093435;7367.8158046049275;7389.926100738924;7527.8118047049265;7538.170801211972;7931.405144614062;7970.601469926596;7993.800154996172;8032.357411407191;8038.959805201171;7137.393321567725;7208.315210055036;7222.277772222736;7227.891581626385;7260;7310.415166786538;7330.780076597711;7376.299251571092;7391.704331826667;7401.814954625962 05:41:02 INFO - PROCESS | 1969 | |4;prototype.html;327.9393312237236;329.1901921273667;331.56564899981043;335.68948722431753;335.7381242630749;5811.38980407057;5851.912221316684;6410.358964103587;6447.484201263899;6466.3533646635315;6380.712867920943;6404.327545607714;6405.711742971565;6469.223693156828;6487.610743355402;4563.634909207272;4628.884277893063;4682.6956247843955;4758.191107511731;4809.422869255677;4001.8799436016966;4264.78676066197;4426.380306757057;4765.0946320199055;4828;4690.57784799368;4764.642651801111;4768.809247630108;4785.473597904228;4789.976050119744;4554;4585.747783871902;4702.3416721659;4711.481737008926;4740.454847692525;4052.5542190359038;4057.3711074783455;4072.7352722073265;4076.5515793262716;4077.103037331782;6088.9391106088815;6156.722947467375;6172.4136207060255;6196.10156527301;6202.62784232943;5603.579731520112;5614.29821272341;5623.156526521014;5635.267415235993;5637.43625637433;6806.319368063204;6818.727250909958;6828.487863410264;6829.282925292872;6872.725090996354;4276.593723596285;4426.756528390937;4452.821887124511;4454.2873140297725;4465.799039043251;7026.332498412643;7146.2496437874315;7166.964165179193;7171.641417929135;7176.425885929113;4501.167284052461;4503.54964503547;4506.414166158378;4509.346144808985;4513.661475389359;4562.178807814559;4563.703359281636;4574.74838883858;4575.771211439482;4579.473360563511;5407.432219616962;5410.864728381822;5414.29614150158;5419.295491586068;5422.240886275925;5713.428657134336;6335.461485773761;6789.592624442549;6794.320567943265;6845.486588505882;1570.7722380255027;1578.6053486628343;1606.5822886049712;1607.6302450436465;1610.7664388663577;962.3215632978734;989.9059589339001;1014.2393205096178;1016.8373060310315;1040.1210976724656;6298.401651843067;6335.239771227482;6377.17096777416;6585.967070164618;6625.536212465177;6555.475561955032;7193.712251509881;7200.747973820891;7235.457340699469;7254.238304977901;6463.903041454382;6523.608583485006;6551.934480655133;6557.868842623121;6692.698828552727;3257.4788033914933;3613.8193090345376;3765.359888818907;3785.375413056815;3795.2409518096492;7151.531507218994;7433.10802703679;7436.73971410998;7473.215312392121;7476.401887848959;6369.331220221903;7345.632718364061;7350.228226036189;7376.004239427716;7389.926100739031;5986.61087029333;7429.257074292527;7431.516951398142;7434.553926764412;7461;6882.655867206719;7123.967024781274;7130.2869713028285;7130.821729456805;7148.749793757193;5323.6273460857365;6911.861762764817;6976.058232138596;7028.789136325919;7078.044463997295;7370.299821516947;7450.0687414073245;7453.552786832807;7468.141163766237;7487.475876688797;3823.063349479284;4477.955220447754;4551.817927283004;4564.817407303671;4566.771661416849;7115.786526404217;7126.465515086493;7144.821379465555;7154.67803948834;7171.03191069199;6555.3772391622715;6884.65576721152;6920.688569014305;6951.652417379212;6974.721011159497;6847.965760171167;6915.377616014583;6933.168019837652;6937.924621683647;6942;6761.290064543152;6762.594244345355;6763.415389843391;6790.5925644461495;6811.89782153278;6891.3797758202;6907.654617269016;6912.861742765016;6919.930800691928;6938.202106757787;5501.257330260523;6567;6599.142111525471;6650.700718467778;6740.898886516804 05:41:02 INFO - PROCESS | 1969 | |5;yui.html;591.1015256809652;685.9657017149142;738.8817789153735;772.5480593852596;797.9838331829101;15252;15537.689246215068;15557.455489057886;15558.611034724137;15566.143862087582;14141.010129290953;14309.785353219684;14583.979121461476;14803.40786368544;14888.106713597192;750.0923882102662;939.2439086535336;946.9526523673788;964.9131578157965;965.888922773883;716.2801384608488;764.1288930619098;947.9146876781089;948.4309414351403;952.2524818017857;998.6804222648756;1000.0649392817702;1003.8945910679347;1004.036125319694;1007;779.1001393390586;972.5672075926216;989.806987637411;991.479473276532;991.6083147156869;733.101950111115;735.3308489274788;737.6791095873259;737.977860664181;738.0589748071199;15092.698146037017;15124.470643527424;15156.393744250217;15163.924180379137;15167.544973650809;12521.186122901981;12546.498140074385;12668.113232073758;12781.233126012468;13061.281629510373;9694.660686875995;9964;10098.64654737088;10102.9494852526;10505.107065899409;3499.30013997199;3539.3098345822573;3550.2721942001826;3578.4632305154173;3636.9272614547563;75604.62197689031;76996;77002;77025;77890;9589.712308630753;9709.951450242845;9724.151022569427;9747.707568772948;10007.549660265306;22806.543869122524;22836;22851.542969140857;22860.542789144456;22875.542489150124;7319.34125928669;7359.521631093961;7412.407007439392;7444.367228785614;7626.4661473697415;4021.557628660845;4088.2436749201493;4093.4269202311702;4094.406311084876;4097.89755256115;3662.761920475214;3698.112453011258;3699.2231631357176;3706.0179052551093;3713.721470889694;654.201873714068;685.4208194076098;691.7198534593498;711.7260104413043;717.9102612173479;476.532997662286;493.8320970869921;546.6911195174714;589.6874656432097;631.8072987738692;7890.053193616803;8072.717454889168;8165.387595930329;8187.4678145920325;8368.539730314891;578.8350320158735;608.6895683201599;612.4916319454842;613.365167052099;621.0932039222695;3354.329134173175;3559.911002224965;3864.439656249828;3870.574236833946;3874.341361968472;91759.08240917505;92545;92840;94229.5288523553;94606.52696736473;76663.61668191735;77762;78016.60991695005;78806.60596697095;79041.20958790454;65585.67207164029;67409.3259067403;69796.6510167446;70316;70611.2938870615;7038.929610703827;7149.892751608626;7672.5012874163;7977.282044616012;7987.800304992422;32550.674493254763;45428;45976;46079;46713.59859204229;58197.70901145467;66071.33928660651;66594.33514162185;67089.66455167693;67429.32570674231;10155.187584993035;10271.794564108526;10280.434576098387;10312.690619281433;10640.201984851012;10763.461826908466;11257.493412796608;11395.259308144945;12008.879911200776;12009.759804804029;10324.277300588887;10414.947925260325;10735.355878647306;10739.409332486788;11259.605913792979;10661.840072398765;10704.678859634223;10736;10778.946105269424;10794.406307653155;8821.647134114564;10588.417637030037;10610.734731631772;10670.413127278074;10704.357738535713;8755.950224110611;9017.188453039258;9111.271098311987;9155.13026262504;9217;8526.914730852612;8593.785155371166;8597.484150950962;8758;9085.409448385833 05:41:02 INFO - PROCESS | 1969 | __end_tp_report 05:41:02 INFO - PROCESS | 1969 | __start_cc_report 05:41:02 INFO - PROCESS | 1969 | _x_x_mozilla_cycle_collect,1295 05:41:02 INFO - PROCESS | 1969 | __end_cc_report 05:41:02 INFO - PROCESS | 1969 | __startTimestamp1459341662723__endTimestamp 05:41:02 INFO - PROCESS | 1969 | 05:41:02 INFO - PROCESS | 1969 | ------- Summary: start ------- 05:41:02 INFO - PROCESS | 1969 | Number of tests: 6 05:41:02 INFO - PROCESS | 1969 | 05:41:02 INFO - PROCESS | 1969 | [#0] dojo.html Cycles:165 Average:5665.84 Median:5876.41 stddev:637.76 (10.9%) stddev-sans-first:614.14 05:41:02 INFO - PROCESS | 1969 | Values: 3386.2 3458.3 3474.5 3485.9 3537.0 5554.6 5623.2 5638.1 5650.5 5664.3 5397.6 5417.8 5668.9 5797.1 5804.6 4927.7 5077.5 5092.1 5105.2 5191.6 5188.5 5213.4 5231.5 5261.8 5293.7 5051.9 5077.4 5152.0 5159.8 5176.9 5161.6 5166.3 5183.8 5225.2 5236.4 5071.3 5102.3 5104.6 5129.0 5171.0 5041.6 5240.7 5404.0 5574.6 5596.5 6086.1 6087.9 6091.7 6134.8 6139.0 6148.3 6169.1 6201.5 6269.4 6284.2 5644.7 5689.7 5713.5 5715.4 5771.7 6176.4 6248.2 6259.9 6279.1 6299.2 4790.4 5949.4 6051.8 6055.0 6122.2 6156.4 6235.5 6238.2 6245.6 6260.5 6116.5 6175.8 6181.7 6188.6 6198.9 6046.5 6117.3 6130.2 6171.3 6184.3 4784.9 4802.1 4811.1 4832.7 4844.9 4319.2 4338.2 4339.8 4374.1 4394.1 5546.3 5594.4 5661.2 5687.8 5692.3 6202.9 6225.9 6232.7 6239.3 6251.5 5660.3 5668.1 5680.1 5682.9 5691.2 5094.4 5181.6 5289.5 5374.5 5384.5 6259.4 6260.7 6264.6 6268.2 6275.1 5130.4 6207.1 6213.3 6251.1 6262.8 6130.8 6203.0 6278.7 6328.3 6346.1 6110.9 6127.6 6160.8 6162.0 6179.0 6110.4 6183.9 6223.9 6243.1 6246.3 5975.5 6027.9 6090.2 6092.5 6112.2 5961.1 5988.5 5989.6 5992.5 6006.4 5055.0 5749.4 5837.3 5877.0 5903.9 5997.5 6027.3 6092.6 6114.1 6115.7 5837.3 5852.0 5876.4 5887.6 5900.9 05:41:02 INFO - PROCESS | 1969 | 05:41:02 INFO - PROCESS | 1969 | [#1] ext.html Cycles:180 Average:56394.77 Median:197917.50 stddev:111079.61 (56.1%) stddev-sans-first:111311.82 05:41:02 INFO - PROCESS | 1969 | Values: 457.0 486.1 590.8 610.6 643.7 30021.7 30335.4 30350.5 36823.4 37404.4 40772.2 40930.4 40985.0 41047.0 41316.6 9647.9 9874.1 9876.0 9879.4 9894.5 8028.4 9777.5 9781.6 9783.1 9791.6 9829.5 9895.2 9914.3 9917.7 9980.8 9848.0 9887.7 9910.6 9913.2 9914.6 9745.8 9779.5 9785.2 9800.4 9841.0 39891.8 40286.6 40398.0 40399.6 40530.8 3206.8 3353.7 3461.7 3652.9 3842.5 28472.0 29071.3 29825.7 29969.7 29992.7 2699.0 2744.2 2767.7 2833.6 2930.3 358902.0 359921.0 360650.0 360677.0 361560.0 62787.1 62935.7 62937.7 63134.1 63160.7 65289.0 65376.7 65459.3 65544.0 65587.7 15239.2 17030.2 17193.8 17220.7 17247.4 11775.6 11845.8 11861.8 11874.1 13039.3 14862.4 18897.7 19381.0 19389.9 19420.5 8364.6 8479.9 8511.8 8563.3 8582.4 942.4 996.7 1007.0 1039.7 1051.7 28616.0 28881.7 28890.4 29532.1 29769.6 1101.0 1102.3 1111.9 1191.6 1194.4 14522.0 14770.8 14846.4 15108.4 15140.8 523737.0 531303.0 531446.0 531726.0 533566.0 55975.0 57755.7 57977.0 58022.0 58247.7 1356.8 1376.1 1377.7 1378.6 1471.5 24861.0 29238.6 29459.0 29784.0 30513.5 51468.2 54268.5 55257.0 55328.0 55350.0 310376.0 312632.4 350026.0 351090.0 362201.0 27711.7 31274.0 31661.8 31751.9 31831.7 41173.8 43047.4 44262.8 44300.3 44329.0 34196.4 34710.3 35727.3 36345.0 36778.3 32253.8 33982.5 34790.5 35567.0 35914.0 28613.9 30679.2 32006.4 35604.3 36058.0 29646.9 30851.5 30854.2 30858.8 30951.8 20703.7 21116.2 23671.4 24008.4 24333.0 05:41:02 INFO - PROCESS | 1969 | 05:41:02 INFO - PROCESS | 1969 | [#2] jquery.html Cycles:180 Average:34634.16 Median:2330.38 stddev:102841.91 (4413.1%) stddev-sans-first:103098.12 05:41:02 INFO - PROCESS | 1969 | Values: 309.9 367.4 370.2 373.3 376.3 18311.5 19573.0 20247.9 20317.4 20377.2 19092.9 19595.6 20081.0 20181.7 20183.2 5683.4 5865.5 5906.2 5908.4 5912.2 5566.5 5775.1 5778.4 5877.6 5893.9 5686.5 5721.7 5725.6 5727.0 5729.1 5640.0 5697.4 5711.9 5711.9 5782.1 4400.6 4900.3 4972.0 5064.7 5071.2 25326.7 25487.0 25511.5 25555.4 26045.9 2301.2 2310.3 2350.4 2652.5 2862.9 14606.9 14808.5 15081.9 15557.4 15561.5 1753.6 1798.2 1800.3 1803.0 1812.6 98622.0 99605.5 100645.0 100935.5 101225.5 10138.0 10226.3 10472.5 10485.4 10530.5 12867.7 12870.8 12888.8 12909.9 12913.5 8424.7 8572.5 8600.2 8682.5 8741.2 8025.7 8792.3 8812.9 8896.3 8910.3 5498.9 6063.0 6091.5 6111.8 6140.3 1597.8 1781.5 1788.2 1798.0 1799.8 901.4 927.4 934.3 1030.1 1076.7 20146.3 21358.5 21520.8 21692.7 21835.0 925.0 976.0 984.9 1050.9 1051.4 8901.8 10709.1 11036.8 11102.3 11112.9 609299.0 613772.0 618331.0 633193.0 633291.0 113194.4 115838.0 116236.0 117109.8 117739.0 967.4 1073.3 1075.8 1149.5 1149.9 17999.6 17999.9 18209.0 18220.6 18515.4 50087.5 51035.0 51400.5 52108.0 53093.5 71033.3 71673.9 71838.6 73059.6 75379.6 7557.9 7791.2 7898.4 7942.8 8212.4 8503.0 11766.5 12105.6 12157.8 12577.2 10287.1 10725.3 10844.5 11075.3 11146.9 10396.3 10458.8 10670.9 10850.5 10850.9 10884.9 10947.7 11140.8 11215.0 11326.5 7542.5 7812.1 7830.4 7907.8 7940.2 10706.9 10730.6 10986.7 11040.7 11047.1 05:41:02 INFO - PROCESS | 1969 | 05:41:02 INFO - PROCESS | 1969 | [#3] mootools.html Cycles:180 Average:6191.42 Median:5010.57 stddev:3285.01 (65.6%) stddev-sans-first:3274.96 05:41:02 INFO - PROCESS | 1969 | Values: 1458.3 1471.8 1652.7 1908.4 2060.1 7252.9 8209.5 9028.6 9028.9 9044.2 8664.2 8949.2 8965.6 8975.6 9009.3 2082.0 2088.5 2430.3 2461.3 2494.6 2502.1 2506.2 2506.6 2510.1 2510.2 2437.5 2497.3 2513.7 2515.9 2518.2 2429.4 2491.8 2493.8 2497.4 2507.6 2457.1 2485.7 2512.3 2522.1 2522.1 8931.9 9059.0 9066.6 9070.0 9087.0 5504.3 5644.2 5672.1 5674.7 5680.8 3199.5 3571.2 3576.9 3638.1 3737.9 916.0 1001.9 1011.2 1082.9 1085.1 12454.3 12473.6 12475.9 12499.2 12515.7 4873.3 4913.9 5013.2 5021.7 5038.1 10378.1 10382.8 10386.8 10388.6 10408.0 5584.5 5606.4 5609.8 5619.9 5635.9 4482.0 4606.3 4854.2 5008.0 5035.7 3326.9 3847.1 3936.0 3972.6 4022.0 1295.1 1310.0 1312.5 1321.6 1322.9 1372.6 1400.1 1424.4 1425.1 1425.5 8341.4 8668.7 8683.3 8686.3 8687.3 1065.4 1155.0 1192.4 1193.8 1232.9 5261.8 6417.8 6428.8 6449.5 6463.0 10361.0 10710.1 10819.0 10833.2 10917.4 10261.3 10658.3 10701.9 10706.9 10707.8 6678.7 8408.4 8412.1 8471.4 8473.5 8176.1 8275.1 8329.5 8351.5 8449.2 9657.8 9942.7 9953.6 9975.4 10058.5 10049.9 10371.6 10402.6 10507.6 10539.4 6778.1 6796.4 7694.0 7709.5 7835.6 8488.9 8498.7 8552.8 8553.9 8557.6 7394.7 7469.6 7557.7 7567.8 7585.7 7303.6 7367.8 7389.9 7527.8 7538.2 7931.4 7970.6 7993.8 8032.4 8039.0 7137.4 7208.3 7222.3 7227.9 7260.0 7310.4 7330.8 7376.3 7391.7 7401.8 05:41:02 INFO - PROCESS | 1969 | 05:41:02 INFO - PROCESS | 1969 | [#4] prototype.html Cycles:180 Average:5594.46 Median:6405.02 stddev:1799.66 (28.1%) stddev-sans-first:1760.76 05:41:02 INFO - PROCESS | 1969 | Values: 327.9 329.2 331.6 335.7 335.7 5811.4 5851.9 6410.4 6447.5 6466.4 6380.7 6404.3 6405.7 6469.2 6487.6 4563.6 4628.9 4682.7 4758.2 4809.4 4001.9 4264.8 4426.4 4765.1 4828.0 4690.6 4764.6 4768.8 4785.5 4790.0 4554.0 4585.7 4702.3 4711.5 4740.5 4052.6 4057.4 4072.7 4076.6 4077.1 6088.9 6156.7 6172.4 6196.1 6202.6 5603.6 5614.3 5623.2 5635.3 5637.4 6806.3 6818.7 6828.5 6829.3 6872.7 4276.6 4426.8 4452.8 4454.3 4465.8 7026.3 7146.2 7167.0 7171.6 7176.4 4501.2 4503.5 4506.4 4509.3 4513.7 4562.2 4563.7 4574.7 4575.8 4579.5 5407.4 5410.9 5414.3 5419.3 5422.2 5713.4 6335.5 6789.6 6794.3 6845.5 1570.8 1578.6 1606.6 1607.6 1610.8 962.3 989.9 1014.2 1016.8 1040.1 6298.4 6335.2 6377.2 6586.0 6625.5 6555.5 7193.7 7200.7 7235.5 7254.2 6463.9 6523.6 6551.9 6557.9 6692.7 3257.5 3613.8 3765.4 3785.4 3795.2 7151.5 7433.1 7436.7 7473.2 7476.4 6369.3 7345.6 7350.2 7376.0 7389.9 5986.6 7429.3 7431.5 7434.6 7461.0 6882.7 7124.0 7130.3 7130.8 7148.7 5323.6 6911.9 6976.1 7028.8 7078.0 7370.3 7450.1 7453.6 7468.1 7487.5 3823.1 4478.0 4551.8 4564.8 4566.8 7115.8 7126.5 7144.8 7154.7 7171.0 6555.4 6884.7 6920.7 6951.7 6974.7 6848.0 6915.4 6933.2 6937.9 6942.0 6761.3 6762.6 6763.4 6790.6 6811.9 6891.4 6907.7 6912.9 6919.9 6938.2 5501.3 6567.0 6599.1 6650.7 6740.9 05:41:02 INFO - PROCESS | 1969 | 05:41:02 INFO - PROCESS | 1969 | [#5] yui.html Cycles:180 Average:17844.24 Median:612.93 stddev:25154.58 (4104.0%) stddev-sans-first:25191.78 05:41:02 INFO - PROCESS | 1969 | Values: 591.1 686.0 738.9 772.5 798.0 15252.0 15537.7 15557.5 15558.6 15566.1 14141.0 14309.8 14584.0 14803.4 14888.1 750.1 939.2 947.0 964.9 965.9 716.3 764.1 947.9 948.4 952.3 998.7 1000.1 1003.9 1004.0 1007.0 779.1 972.6 989.8 991.5 991.6 733.1 735.3 737.7 738.0 738.1 15092.7 15124.5 15156.4 15163.9 15167.5 12521.2 12546.5 12668.1 12781.2 13061.3 9694.7 9964.0 10098.6 10102.9 10505.1 3499.3 3539.3 3550.3 3578.5 3636.9 75604.6 76996.0 77002.0 77025.0 77890.0 9589.7 9710.0 9724.2 9747.7 10007.5 22806.5 22836.0 22851.5 22860.5 22875.5 7319.3 7359.5 7412.4 7444.4 7626.5 4021.6 4088.2 4093.4 4094.4 4097.9 3662.8 3698.1 3699.2 3706.0 3713.7 654.2 685.4 691.7 711.7 717.9 476.5 493.8 546.7 589.7 631.8 7890.1 8072.7 8165.4 8187.5 8368.5 578.8 608.7 612.5 613.4 621.1 3354.3 3559.9 3864.4 3870.6 3874.3 91759.1 92545.0 92840.0 94229.5 94606.5 76663.6 77762.0 78016.6 78806.6 79041.2 65585.7 67409.3 69796.7 70316.0 70611.3 7038.9 7149.9 7672.5 7977.3 7987.8 32550.7 45428.0 45976.0 46079.0 46713.6 58197.7 66071.3 66594.3 67089.7 67429.3 10155.2 10271.8 10280.4 10312.7 10640.2 10763.5 11257.5 11395.3 12008.9 12009.8 10324.3 10414.9 10735.4 10739.4 11259.6 10661.8 10704.7 10736.0 10778.9 10794.4 8821.6 10588.4 10610.7 10670.4 10704.4 8756.0 9017.2 9111.3 9155.1 9217.0 8526.9 8593.8 8597.5 8758.0 9085.4 05:41:02 INFO - PROCESS | 1969 | -------- Summary: end -------- 05:41:02 INFO - PROCESS | 1969 | 05:41:03 INFO - TEST-INFO | 1969: exit 0 05:41:03 INFO - TEST-OK | dromaeo_css | took 1113230ms 05:41:03 INFO - TEST-START | kraken 05:41:03 INFO - operating with platform_type : mac_ 05:41:03 INFO - Initialising browser for kraken test... 05:41:03 INFO - TEST-INFO | started process 1974 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpR87X91/profile http://localhost:51294/getInfo.html) 05:41:05 INFO - PROCESS | 1974 | __metrics Screen width/height:1600/1200 05:41:05 INFO - PROCESS | 1974 | colorDepth:24 05:41:05 INFO - PROCESS | 1974 | Browser inner width/height: 1024/689 05:41:05 INFO - PROCESS | 1974 | __metrics 05:41:06 INFO - PROCESS | 1974 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:41:06 ERROR - PROCESS | 1974 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:41:06 INFO - TEST-INFO | 1974: exit 0 05:41:06 INFO - Browser initialized. 05:41:06 INFO - Running cycle 1/1 for kraken test... 05:41:06 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpR87X91/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:18 INFO - PROCESS | 1977 | RSS: Main: 244748288 05:41:18 INFO - PROCESS | 1977 | 05:41:21 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:51294/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51294/tests/kraken/driver.html?testName=audio-beat-detection) 05:41:21 INFO - PROCESS | 1977 | RSS: Main: 291913728 05:41:21 INFO - PROCESS | 1977 | 05:41:24 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:51294/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51294/tests/kraken/driver.html?testName=audio-dft) 05:41:25 INFO - PROCESS | 1977 | RSS: Main: 302276608 05:41:25 INFO - PROCESS | 1977 | 05:41:28 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:51294/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51294/tests/kraken/driver.html?testName=audio-fft) 05:41:29 INFO - PROCESS | 1977 | RSS: Main: 287342592 05:41:29 INFO - PROCESS | 1977 | 05:41:31 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:51294/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51294/tests/kraken/driver.html?testName=audio-oscillator) 05:41:31 INFO - PROCESS | 1977 | RSS: Main: 290193408 05:41:31 INFO - PROCESS | 1977 | 05:41:34 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:51294/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51294/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:41:34 INFO - PROCESS | 1977 | RSS: Main: 290164736 05:41:34 INFO - PROCESS | 1977 | 05:41:37 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:51294/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51294/tests/kraken/driver.html?testName=imaging-darkroom) 05:41:37 INFO - PROCESS | 1977 | RSS: Main: 290582528 05:41:37 INFO - PROCESS | 1977 | 05:41:40 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:51294/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51294/tests/kraken/driver.html?testName=imaging-desaturate) 05:41:41 INFO - PROCESS | 1977 | RSS: Main: 290578432 05:41:41 INFO - PROCESS | 1977 | 05:41:44 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:51294/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51294/tests/kraken/driver.html?testName=json-parse-financial) 05:41:44 INFO - PROCESS | 1977 | RSS: Main: 291119104 05:41:44 INFO - PROCESS | 1977 | 05:41:46 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:51294/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51294/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:41:46 INFO - PROCESS | 1977 | RSS: Main: 326520832 05:41:46 INFO - PROCESS | 1977 | 05:41:48 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:51294/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51294/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:41:49 INFO - PROCESS | 1977 | RSS: Main: 323694592 05:41:49 INFO - PROCESS | 1977 | 05:41:51 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:51294/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51294/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:41:51 INFO - PROCESS | 1977 | RSS: Main: 331767808 05:41:51 INFO - PROCESS | 1977 | 05:41:54 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:51294/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:41:55 INFO - PROCESS | 1977 | RSS: Main: 333705216 05:41:55 INFO - PROCESS | 1977 | 05:41:57 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:51294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:41:58 INFO - PROCESS | 1977 | RSS: Main: 333434880 05:41:58 INFO - PROCESS | 1977 | 05:41:59 INFO - PROCESS | 1977 | Cycle 1(1): loaded http://localhost:51294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51294/tests/kraken/driver.html?testName=ai-astar) 05:42:00 INFO - PROCESS | 1977 | RSS: Main: 396926976 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - PROCESS | 1977 | __start_tp_report 05:42:00 INFO - PROCESS | 1977 | _x_x_mozilla_page_load 05:42:00 INFO - PROCESS | 1977 | _x_x_mozilla_page_load_details 05:42:00 INFO - PROCESS | 1977 | |i|pagename|runs| 05:42:00 INFO - PROCESS | 1977 | |0;ai-astar;111;110;108;110;111;111;117;111;112;111 05:42:00 INFO - PROCESS | 1977 | |1;audio-beat-detection;162;119;145;162;119;146;140;119;162;120 05:42:00 INFO - PROCESS | 1977 | |2;audio-dft;187;184;198;261;184;184;200;264;186;180 05:42:00 INFO - PROCESS | 1977 | |3;audio-fft;75;72;97;108;83;47;52;66;79;71 05:42:00 INFO - PROCESS | 1977 | |4;audio-oscillator;96;94;127;78;77;85;112;79;79;121 05:42:00 INFO - PROCESS | 1977 | |5;imaging-gaussian-blur;87;84;86;83;87;84;87;87;86;83 05:42:00 INFO - PROCESS | 1977 | |6;imaging-darkroom;93;93;94;93;93;92;94;93;93;93 05:42:00 INFO - PROCESS | 1977 | |7;imaging-desaturate;85;86;85;85;86;88;83;85;86;86 05:42:00 INFO - PROCESS | 1977 | |8;json-parse-financial;56;56;55;55;55;55;54;64;53;53 05:42:00 INFO - PROCESS | 1977 | |9;json-stringify-tinderbox;64;63;69;79;74;71;67;69;67;68 05:42:00 INFO - PROCESS | 1977 | |10;stanford-crypto-aes;84;83;82;84;83;83;84;83;85;82 05:42:00 INFO - PROCESS | 1977 | |11;stanford-crypto-ccm;123;126;141;110;132;135;136;140;122;129 05:42:00 INFO - PROCESS | 1977 | |12;stanford-crypto-pbkdf2;137;172;135;141;141;126;139;138;138;137 05:42:00 INFO - PROCESS | 1977 | |13;stanford-crypto-sha256-iterative;68;67;68;73;67;68;68;67;67;66 05:42:00 INFO - PROCESS | 1977 | __end_tp_report 05:42:00 INFO - PROCESS | 1977 | __start_cc_report 05:42:00 INFO - PROCESS | 1977 | _x_x_mozilla_cycle_collect,1246 05:42:00 INFO - PROCESS | 1977 | __end_cc_report 05:42:00 INFO - PROCESS | 1977 | __startTimestamp1459341720243__endTimestamp 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - PROCESS | 1977 | ------- Summary: start ------- 05:42:00 INFO - PROCESS | 1977 | Number of tests: 14 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - PROCESS | 1977 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:2.30 (2.1%) stddev-sans-first:2.44 05:42:00 INFO - PROCESS | 1977 | Values: 111.0 110.0 108.0 110.0 111.0 111.0 117.0 111.0 112.0 111.0 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - PROCESS | 1977 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:145.50 stddev:18.95 (13.0%) stddev-sans-first:18.25 05:42:00 INFO - PROCESS | 1977 | Values: 162.0 119.0 145.0 162.0 119.0 146.0 140.0 119.0 162.0 120.0 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - PROCESS | 1977 | [#2] audio-dft Cycles:10 Average:202.80 Median:192.50 stddev:32.10 (16.7%) stddev-sans-first:33.54 05:42:00 INFO - PROCESS | 1977 | Values: 187.0 184.0 198.0 261.0 184.0 184.0 200.0 264.0 186.0 180.0 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - PROCESS | 1977 | [#3] audio-fft Cycles:10 Average:75.00 Median:73.50 stddev:18.48 (25.1%) stddev-sans-first:19.60 05:42:00 INFO - PROCESS | 1977 | Values: 75.0 72.0 97.0 108.0 83.0 47.0 52.0 66.0 79.0 71.0 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - PROCESS | 1977 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:79.00 stddev:18.90 (23.9%) stddev-sans-first:20.04 05:42:00 INFO - PROCESS | 1977 | Values: 96.0 94.0 127.0 78.0 77.0 85.0 112.0 79.0 79.0 121.0 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - PROCESS | 1977 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.50 stddev:1.71 (2.0%) stddev-sans-first:1.72 05:42:00 INFO - PROCESS | 1977 | Values: 87.0 84.0 86.0 83.0 87.0 84.0 87.0 87.0 86.0 83.0 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - PROCESS | 1977 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:42:00 INFO - PROCESS | 1977 | Values: 93.0 93.0 94.0 93.0 93.0 92.0 94.0 93.0 93.0 93.0 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - PROCESS | 1977 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:1.27 (1.5%) stddev-sans-first:1.33 05:42:00 INFO - PROCESS | 1977 | Values: 85.0 86.0 85.0 85.0 86.0 88.0 83.0 85.0 86.0 86.0 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - PROCESS | 1977 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:3.13 (5.7%) stddev-sans-first:3.32 05:42:00 INFO - PROCESS | 1977 | Values: 56.0 56.0 55.0 55.0 55.0 55.0 54.0 64.0 53.0 53.0 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - PROCESS | 1977 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:4.70 (6.8%) stddev-sans-first:4.61 05:42:00 INFO - PROCESS | 1977 | Values: 64.0 63.0 69.0 79.0 74.0 71.0 67.0 69.0 67.0 68.0 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - PROCESS | 1977 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:0.95 (1.1%) stddev-sans-first:0.97 05:42:00 INFO - PROCESS | 1977 | Values: 84.0 83.0 82.0 84.0 83.0 83.0 84.0 83.0 85.0 82.0 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - PROCESS | 1977 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:133.50 stddev:9.50 (7.1%) stddev-sans-first:9.79 05:42:00 INFO - PROCESS | 1977 | Values: 123.0 126.0 141.0 110.0 132.0 135.0 136.0 140.0 122.0 129.0 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - PROCESS | 1977 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.40 Median:138.50 stddev:11.89 (8.6%) stddev-sans-first:12.55 05:42:00 INFO - PROCESS | 1977 | Values: 137.0 172.0 135.0 141.0 141.0 126.0 139.0 138.0 138.0 137.0 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - PROCESS | 1977 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.91 (2.8%) stddev-sans-first:2.03 05:42:00 INFO - PROCESS | 1977 | Values: 68.0 67.0 68.0 73.0 67.0 68.0 68.0 67.0 67.0 66.0 05:42:00 INFO - PROCESS | 1977 | -------- Summary: end -------- 05:42:00 INFO - PROCESS | 1977 | 05:42:00 INFO - TEST-INFO | 1977: exit 0 05:42:01 INFO - TEST-OK | kraken | took 57650ms 05:42:01 INFO - SUITE-END | took 1170s 05:42:01 INFO - Completed test suite (00:19:31) 05:42:01 INFO - javascript benchmark 05:42:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3386.2211691311, 3458.325626502833, 3474.496198051281, 3485.867093194712, 3536.982315088424, 5554.638948468357, 5623.184638227454, 5638.069718496448, 5650.519705825005, 5664.263645726055, 5397.568194544437, 5417.810376636819, 5668.886622267552, 5797.101449275358, 5804.622699524528, 4927.6550641455115, 5077.492250774921, 5092.083424983502, 5105.18317069269, 5191.636585439021, 5188.533032027117, 5213.374395072597, 5231.503007214308, 5261.789528418859, 5293.708846013467, 5051.924221136667, 5077.441481437039, 5152.0, 5159.7678104485385, 5176.896462070757, 5161.561267292284, 5166.276721259027, 5183.844484665466, 5225.190095535198, 5236.371635403738, 5071.264666623356, 5102.260172275037, 5104.591632669378, 5129.0, 5170.96580683861, 5041.596672266247, 5240.711760853152, 5403.972980135113, 5574.60977731559, 5596.496315331639, 6086.080695666055, 6087.889601477322, 6091.664958427285, 6134.754609815602, 6138.969305153446, 6148.262208534959, 6169.136320915076, 6201.534884883652, 6269.3730626937395, 6284.214473190851, 5644.689542075225, 5689.743961521742, 5713.485786279255, 5715.371309155989, 5771.68255745938, 6176.413240742122, 6248.187735594343, 6259.906101408483, 6279.058141278845, 6299.244090709052, 4790.353302304145, 5949.405059494016, 6051.818445446644, 6055.0, 6122.245686735438, 6156.445919867234, 6235.532335074797, 6238.189035425366, 6245.594036387621, 6260.46786023184, 6116.480099191618, 6175.752969881154, 6181.690915454209, 6188.566800323934, 6198.907016394758, 6046.486048685911, 6117.340260877713, 6130.203073600493, 6171.321154672983, 6184.319724830265, 4784.928226076611, 4802.063597598504, 4811.133995880775, 4832.734199618984, 4844.878878028007, 4319.222539942778, 4338.197433474817, 4339.804708788112, 4374.103308821684, 4394.055278115156, 5546.334439867242, 5594.41258667834, 5661.179129026268, 5687.77248910039, 5692.31692196939, 6202.878342712088, 6225.906611400833, 6232.657203853832, 6239.282482514478, 6251.499880009588, 5660.264165658438, 5668.064769313017, 5680.091185410397, 5682.914756278659, 5691.203231547586, 5094.439611642716, 5181.5854731621375, 5289.497497737709, 5374.48942350476, 5384.461553844584, 6259.436650701458, 6260.749570017239, 6264.59280146789, 6268.153799237045, 6275.058741188767, 5130.384353877558, 6207.088698282489, 6213.254409470893, 6251.124842521959, 6262.780802671885, 6130.795626845359, 6202.968985155046, 6278.686065696788, 6328.272248691459, 6346.111544383883, 6110.938890611214, 6127.601705889103, 6160.815175544741, 6162.044883043135, 6179.011358182849, 6110.388961104032, 6183.938160618516, 6223.937760622336, 6243.125962365363, 6246.250449946036, 5975.492083172805, 6027.879442411039, 6090.177825993434, 6092.512598992159, 6112.17485639433, 5961.105834124916, 5988.4909782668965, 5989.550783691154, 5992.5205983520345, 6006.429389208019, 5054.974725126351, 5749.367569567428, 5837.328707198726, 5877.0, 5903.911441328298, 5997.520198384206, 6027.336992930862, 6092.603980741238, 6114.054656999343, 6115.7247923844425, 5837.328707198557, 5852.0, 5876.41235876409, 5887.587868849139, 5900.881982360414], "unit": "score", "name": "dojo.html", "value": 5626.61267890457}, {"lowerIsBetter": false, "replicates": [457.0, 486.09343574234066, 590.7902694543437, 610.6366711806475, 643.7103303513419, 30021.699783002165, 30335.393292134144, 30350.54474182889, 36823.4476482853, 37404.43893341602, 40772.18455630886, 40930.38604420936, 40985.0, 41047.0, 41316.58683413165, 9647.903520964806, 9874.1113299803, 9875.950620246924, 9879.407235565888, 9894.455804930725, 8028.357731381476, 9777.46223957682, 9781.559829807677, 9783.119519243266, 9791.608335666564, 9829.459379734111, 9895.208383329353, 9914.256430767686, 9917.652882149127, 9980.800383992315, 9848.0, 9887.653932112413, 9910.55402506889, 9913.157381622535, 9914.55384507699, 9745.756356091084, 9779.51102444875, 9785.168260697848, 9800.411975281506, 9841.0, 39891.80054099711, 40286.597134028576, 40398.0, 40399.59600403988, 40530.79734601308, 3206.7915585486867, 3353.6814002669707, 3461.671141241578, 3652.8721494747556, 3842.50047493824, 28472.00695951284, 29071.273218169503, 29825.70174298251, 29969.700302997127, 29992.70007299943, 2699.0, 2744.163030275765, 2767.6540432445945, 2833.6174616426724, 2930.3260250142375, 358902.0, 359921.0, 360650.0, 360677.0, 361560.0, 62787.05819412712, 62935.6853215731, 62937.68531157315, 63134.0529892052, 63160.684196578724, 65289.0, 65376.67311663411, 65459.34540654628, 65544.0, 65587.67206163939, 15239.238038098272, 17030.233639486254, 17193.828061719472, 17220.741688874677, 17247.396341128253, 11775.587854425054, 11845.76308473843, 11861.76276474483, 11874.1094417919, 13039.348032598333, 14862.42858990243, 18897.716534252, 19381.0, 19389.90305048494, 19420.51448713765, 8364.623591938378, 8479.872801907977, 8511.829763404698, 8563.314934805201, 8582.442141260799, 942.40157499988, 996.6860438961849, 1006.9949650251848, 1039.6517166749225, 1051.7370657335666, 28615.9984400545, 28881.71118288832, 28890.411027393697, 29532.114036578936, 29769.553456698166, 1100.9889901100887, 1102.2780079048237, 1111.927724697892, 1191.6484637031922, 1194.3669854976877, 14522.0, 14770.764053246905, 14846.40614375413, 15108.39566417353, 15140.772888406682, 523737.0, 531303.0, 531446.0, 531726.0, 533566.0, 55975.0, 57755.71122144363, 57977.0, 58022.0, 58247.70876145592, 1356.837179538442, 1376.1399125546534, 1377.7451171533098, 1378.6415531961761, 1471.5291106845707, 24861.0, 29238.55842374361, 29459.0, 29784.0, 30513.542296865122, 51468.227976579634, 54268.45731542634, 55257.0, 55328.0, 55350.0, 310376.0, 312632.43683781434, 350026.0, 351090.0, 362201.0, 27711.722882770915, 31274.0, 31661.8416907914, 31751.88868389595, 31831.726730930503, 41173.79413102915, 43047.354289685056, 44262.778686106365, 44300.33549496825, 44329.0, 34196.37910121453, 34710.30579388449, 35727.28545429129, 36345.0, 36778.26443471169, 32253.838730807136, 33982.49026264559, 34790.47814282737, 35567.0, 35914.0, 28613.856930715214, 30679.2330191747, 32006.35987280288, 35604.28791424105, 36058.0, 29646.851765741896, 30851.537226942062, 30854.228644283176, 30858.845705771328, 30951.84524077365, 20703.689444658645, 21116.155353785678, 23671.408214794767, 24008.39979000539, 24333.0], "unit": "score", "name": "ext.html", "value": 19186.263216957726}, {"lowerIsBetter": false, "replicates": [309.9256178517156, 367.4176430357883, 370.18928546483215, 373.2572181359096, 376.2568926370417, 18311.542211444703, 19573.0, 20247.898760506196, 20317.390478285673, 20377.18491260348, 19092.904535477304, 19595.608087838234, 20081.0, 20181.697274540893, 20183.19267229309, 5683.403242659513, 5865.530757539408, 5906.202662640531, 5908.350081491032, 5912.231409916705, 5566.471185237417, 5775.1337299405, 5778.393268706788, 5877.588568800185, 5893.911591326134, 5686.545076393899, 5721.656700597957, 5725.599208055438, 5726.971365143168, 5729.111987641902, 5640.0, 5697.401772813857, 5711.885762284773, 5711.942880571203, 5782.132680097977, 4400.559944005574, 4900.313956046157, 4972.03045406146, 5064.721440320781, 5071.2139618359215, 25326.733663316943, 25487.0, 25511.48977020449, 25555.361115972064, 26045.869770651214, 2301.160076572056, 2310.3415526575013, 2350.4123969007746, 2652.4827658606578, 2862.885484580635, 14606.853931460762, 14808.481703140445, 15081.94426390153, 15557.377704891791, 15561.533154005398, 1753.5528440247783, 1798.1638538079856, 1800.333876465703, 1803.0353760737942, 1812.6012277298973, 98622.0, 99605.5019724904, 100644.99355006503, 100935.49532252365, 101225.4938725309, 10138.0, 10226.28416010872, 10472.528736206888, 10485.37087774736, 10530.473476326153, 12867.742645147044, 12870.806937895939, 12888.80666789999, 12909.935450322688, 12913.483460661657, 8424.705135320357, 8572.528510931834, 8600.182982616641, 8682.52246126469, 8741.213290803858, 8025.678972841138, 8792.340574456814, 8812.942446906412, 8896.332775041898, 8910.287177025823, 5498.890022199534, 6062.999210260604, 6091.451769340781, 6111.786087486917, 6140.324564297924, 1597.7777000594554, 1781.4744650328184, 1788.195312109556, 1797.9640407192044, 1799.7750281214849, 901.3735453859505, 927.4064598656865, 934.3412893909777, 1030.124394264869, 1076.6500887211687, 20146.294879679434, 21358.466038349165, 21520.784792151877, 21692.674609880865, 21835.0, 924.9537523123817, 975.9560819763128, 984.8768903887014, 1050.858134151895, 1051.3691784929135, 8901.821963560822, 10709.089727373104, 11036.779264414827, 11102.278351907262, 11112.888871111185, 609299.0, 613772.0, 618331.0, 633193.0, 633291.0, 113194.43402782934, 115838.0, 116236.0, 117109.82890171159, 117739.0, 967.4485543240426, 1073.302353470235, 1075.7902209069314, 1149.5459293579156, 1149.8735139134687, 17999.550011249823, 17999.910000449912, 18208.99850508235, 18220.635587288445, 18515.444536663923, 50087.49912500828, 51035.0, 51400.48599513957, 52108.0, 53093.469065308855, 71033.28966710267, 71673.92489112563, 71838.64080679564, 73059.63470182614, 75379.62310188414, 7557.886631700419, 7791.220877912164, 7898.368130549427, 7942.761717148494, 8212.425130240827, 8503.0, 11766.470508826953, 12105.576304829288, 12157.75684486323, 12577.182483138567, 10287.119606510189, 10725.30285531438, 10844.511996960313, 11075.280106793032, 11146.944265278946, 10396.272260941661, 10458.790824183627, 10670.89329106699, 10850.511726972147, 10850.945745271223, 10884.945575272073, 10947.671569852917, 11140.832887506533, 11215.0, 11326.546938122383, 7542.509736867086, 7812.101608315116, 7830.373570114263, 7907.84184316299, 7940.205979402013, 10706.89293107059, 10730.570777168827, 10986.670399888017, 11040.668779936615, 11047.116230701686], "unit": "score", "name": "jquery.html", "value": 9500.950145383615}, {"lowerIsBetter": false, "replicates": [1458.314592141693, 1471.7792331150329, 1652.7438247071705, 1908.3702378215191, 2060.1141509151057, 7252.927470725291, 8209.466384684998, 9028.638854445831, 9028.90971090289, 9044.231240344563, 8664.220220180183, 8949.194572488475, 8965.551722413886, 8975.640974361035, 9009.279257659387, 2082.0422605601443, 2088.4778805298674, 2430.331658793837, 2461.298529918969, 2494.5759220932487, 2502.074232533965, 2506.1980166346775, 2506.6240063990367, 2510.134003768697, 2510.1716433576876, 2437.5124975004983, 2497.2882728422405, 2513.723490416062, 2515.949681006379, 2518.156417600106, 2429.441228517442, 2491.813114016438, 2493.8379005364773, 2497.3756560859783, 2507.5862482690336, 2457.127719659513, 2485.689288838895, 2512.271441282026, 2522.0794410040385, 2522.092046863128, 8931.866022009675, 9059.0, 9066.637334506611, 9070.047644997312, 9087.0, 5504.284443022381, 5644.181593668895, 5672.092465205547, 5674.687892165929, 5680.772769089232, 3199.520071989197, 3571.23218508022, 3576.91057723559, 3638.1268495560876, 3737.906552336186, 915.9587818548115, 1001.8547310639916, 1011.1657882247175, 1082.929609575375, 1085.1210519479248, 12454.315012674298, 12473.625791226277, 12475.875241247562, 12499.187552809039, 12515.687107822287, 4873.342098816614, 4913.877153071202, 5013.172826483662, 5021.723805190676, 5038.143515602356, 10378.06597406222, 10382.792344153075, 10386.844197337046, 10388.636397726043, 10407.959204079683, 5584.497395234448, 5606.439356064361, 5609.775608975595, 5619.943800562024, 5635.887282254332, 4481.955180448219, 4606.262997920317, 4854.150523658345, 5007.974960125176, 5035.697858128524, 3326.866925323008, 3847.076701591598, 3935.980320098381, 3972.56301806801, 4022.014606421387, 1295.1387327427155, 1309.9869001310055, 1312.5471712259255, 1321.6497628128554, 1322.9140105893086, 1372.6019454358325, 1400.1459109942928, 1424.4302279088447, 1425.059460755917, 1425.4868247430916, 8341.374396920255, 8668.653253869901, 8683.305335573139, 8686.261667758185, 8687.305015598737, 1065.3607835298915, 1154.9951542158376, 1192.4276347353318, 1193.8268951002055, 1232.9136960412864, 5261.842144735664, 6417.839554011187, 6428.8071357859335, 6449.451796597342, 6462.965925451905, 10361.015703508154, 10710.089642380484, 10819.0, 10833.187510936554, 10917.39954302521, 10261.333013354108, 10658.307210031324, 10701.892981070245, 10706.892931070746, 10707.839382409271, 6678.732850686015, 8408.41141120128, 8412.074671786098, 8471.449355791854, 8473.49159050459, 8176.059753128228, 8275.089740128702, 8329.541875196923, 8351.457155284887, 8449.155084491502, 9657.806843863224, 9942.701718948443, 9953.601855925972, 9975.401475911469, 10058.497075146068, 10049.89950100519, 10371.58513659445, 10402.583896644352, 10507.579696812347, 10539.42033188182, 6778.084958530732, 6796.402845331244, 7694.038245219348, 7709.537427754352, 7835.608219588884, 8488.872666910125, 8498.660053598034, 8552.828943421222, 8553.914460855562, 8557.57212139403, 7394.704211831467, 7469.551826890404, 7557.659905304385, 7567.8108047297055, 7585.734499292498, 7303.598302093435, 7367.8158046049275, 7389.926100738924, 7527.8118047049265, 7538.170801211972, 7931.405144614062, 7970.601469926596, 7993.800154996172, 8032.357411407191, 8038.959805201171, 7137.393321567725, 7208.315210055036, 7222.277772222736, 7227.891581626385, 7260.0, 7310.415166786538, 7330.780076597711, 7376.299251571092, 7391.704331826667, 7401.814954625962], "unit": "score", "name": "mootools.html", "value": 5039.386130511265}, {"lowerIsBetter": false, "replicates": [327.9393312237236, 329.1901921273667, 331.56564899981043, 335.68948722431753, 335.7381242630749, 5811.38980407057, 5851.912221316684, 6410.358964103587, 6447.484201263899, 6466.3533646635315, 6380.712867920943, 6404.327545607714, 6405.711742971565, 6469.223693156828, 6487.610743355402, 4563.634909207272, 4628.884277893063, 4682.6956247843955, 4758.191107511731, 4809.422869255677, 4001.8799436016966, 4264.78676066197, 4426.380306757057, 4765.0946320199055, 4828.0, 4690.57784799368, 4764.642651801111, 4768.809247630108, 4785.473597904228, 4789.976050119744, 4554.0, 4585.747783871902, 4702.3416721659, 4711.481737008926, 4740.454847692525, 4052.5542190359038, 4057.3711074783455, 4072.7352722073265, 4076.5515793262716, 4077.103037331782, 6088.9391106088815, 6156.722947467375, 6172.4136207060255, 6196.10156527301, 6202.62784232943, 5603.579731520112, 5614.29821272341, 5623.156526521014, 5635.267415235993, 5637.43625637433, 6806.319368063204, 6818.727250909958, 6828.487863410264, 6829.282925292872, 6872.725090996354, 4276.593723596285, 4426.756528390937, 4452.821887124511, 4454.2873140297725, 4465.799039043251, 7026.332498412643, 7146.2496437874315, 7166.964165179193, 7171.641417929135, 7176.425885929113, 4501.167284052461, 4503.54964503547, 4506.414166158378, 4509.346144808985, 4513.661475389359, 4562.178807814559, 4563.703359281636, 4574.74838883858, 4575.771211439482, 4579.473360563511, 5407.432219616962, 5410.864728381822, 5414.29614150158, 5419.295491586068, 5422.240886275925, 5713.428657134336, 6335.461485773761, 6789.592624442549, 6794.320567943265, 6845.486588505882, 1570.7722380255027, 1578.6053486628343, 1606.5822886049712, 1607.6302450436465, 1610.7664388663577, 962.3215632978734, 989.9059589339001, 1014.2393205096178, 1016.8373060310315, 1040.1210976724656, 6298.401651843067, 6335.239771227482, 6377.17096777416, 6585.967070164618, 6625.536212465177, 6555.475561955032, 7193.712251509881, 7200.747973820891, 7235.457340699469, 7254.238304977901, 6463.903041454382, 6523.608583485006, 6551.934480655133, 6557.868842623121, 6692.698828552727, 3257.4788033914933, 3613.8193090345376, 3765.359888818907, 3785.375413056815, 3795.2409518096492, 7151.531507218994, 7433.10802703679, 7436.73971410998, 7473.215312392121, 7476.401887848959, 6369.331220221903, 7345.632718364061, 7350.228226036189, 7376.004239427716, 7389.926100739031, 5986.61087029333, 7429.257074292527, 7431.516951398142, 7434.553926764412, 7461.0, 6882.655867206719, 7123.967024781274, 7130.2869713028285, 7130.821729456805, 7148.749793757193, 5323.6273460857365, 6911.861762764817, 6976.058232138596, 7028.789136325919, 7078.044463997295, 7370.299821516947, 7450.0687414073245, 7453.552786832807, 7468.141163766237, 7487.475876688797, 3823.063349479284, 4477.955220447754, 4551.817927283004, 4564.817407303671, 4566.771661416849, 7115.786526404217, 7126.465515086493, 7144.821379465555, 7154.67803948834, 7171.03191069199, 6555.3772391622715, 6884.65576721152, 6920.688569014305, 6951.652417379212, 6974.721011159497, 6847.965760171167, 6915.377616014583, 6933.168019837652, 6937.924621683647, 6942.0, 6761.290064543152, 6762.594244345355, 6763.415389843391, 6790.5925644461495, 6811.89782153278, 6891.3797758202, 6907.654617269016, 6912.861742765016, 6919.930800691928, 6938.202106757787, 5501.257330260523, 6567.0, 6599.142111525471, 6650.700718467778, 6740.898886516804], "unit": "score", "name": "prototype.html", "value": 4995.509517955917}, {"lowerIsBetter": false, "replicates": [591.1015256809652, 685.9657017149142, 738.8817789153735, 772.5480593852596, 797.9838331829101, 15252.0, 15537.689246215068, 15557.455489057886, 15558.611034724137, 15566.143862087582, 14141.010129290953, 14309.785353219684, 14583.979121461476, 14803.40786368544, 14888.106713597192, 750.0923882102662, 939.2439086535336, 946.9526523673788, 964.9131578157965, 965.888922773883, 716.2801384608488, 764.1288930619098, 947.9146876781089, 948.4309414351403, 952.2524818017857, 998.6804222648756, 1000.0649392817702, 1003.8945910679347, 1004.036125319694, 1007.0, 779.1001393390586, 972.5672075926216, 989.806987637411, 991.479473276532, 991.6083147156869, 733.101950111115, 735.3308489274788, 737.6791095873259, 737.977860664181, 738.0589748071199, 15092.698146037017, 15124.470643527424, 15156.393744250217, 15163.924180379137, 15167.544973650809, 12521.186122901981, 12546.498140074385, 12668.113232073758, 12781.233126012468, 13061.281629510373, 9694.660686875995, 9964.0, 10098.64654737088, 10102.9494852526, 10505.107065899409, 3499.30013997199, 3539.3098345822573, 3550.2721942001826, 3578.4632305154173, 3636.9272614547563, 75604.62197689031, 76996.0, 77002.0, 77025.0, 77890.0, 9589.712308630753, 9709.951450242845, 9724.151022569427, 9747.707568772948, 10007.549660265306, 22806.543869122524, 22836.0, 22851.542969140857, 22860.542789144456, 22875.542489150124, 7319.34125928669, 7359.521631093961, 7412.407007439392, 7444.367228785614, 7626.4661473697415, 4021.557628660845, 4088.2436749201493, 4093.4269202311702, 4094.406311084876, 4097.89755256115, 3662.761920475214, 3698.112453011258, 3699.2231631357176, 3706.0179052551093, 3713.721470889694, 654.201873714068, 685.4208194076098, 691.7198534593498, 711.7260104413043, 717.9102612173479, 476.532997662286, 493.8320970869921, 546.6911195174714, 589.6874656432097, 631.8072987738692, 7890.053193616803, 8072.717454889168, 8165.387595930329, 8187.4678145920325, 8368.539730314891, 578.8350320158735, 608.6895683201599, 612.4916319454842, 613.365167052099, 621.0932039222695, 3354.329134173175, 3559.911002224965, 3864.439656249828, 3870.574236833946, 3874.341361968472, 91759.08240917505, 92545.0, 92840.0, 94229.5288523553, 94606.52696736473, 76663.61668191735, 77762.0, 78016.60991695005, 78806.60596697095, 79041.20958790454, 65585.67207164029, 67409.3259067403, 69796.6510167446, 70316.0, 70611.2938870615, 7038.929610703827, 7149.892751608626, 7672.5012874163, 7977.282044616012, 7987.800304992422, 32550.674493254763, 45428.0, 45976.0, 46079.0, 46713.59859204229, 58197.70901145467, 66071.33928660651, 66594.33514162185, 67089.66455167693, 67429.32570674231, 10155.187584993035, 10271.794564108526, 10280.434576098387, 10312.690619281433, 10640.201984851012, 10763.461826908466, 11257.493412796608, 11395.259308144945, 12008.879911200776, 12009.759804804029, 10324.277300588887, 10414.947925260325, 10735.355878647306, 10739.409332486788, 11259.605913792979, 10661.840072398765, 10704.678859634223, 10736.0, 10778.946105269424, 10794.406307653155, 8821.647134114564, 10588.417637030037, 10610.734731631772, 10670.413127278074, 10704.357738535713, 8755.950224110611, 9017.188453039258, 9111.271098311987, 9155.13026262504, 9217.0, 8526.914730852612, 8593.785155371166, 8597.484150950962, 8758.0, 9085.409448385833], "unit": "score", "name": "yui.html", "value": 6808.435025483902}], "name": "dromaeo_css", "value": 7484.691607136214}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 108.0, 110.0, 111.0, 111.0, 117.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [162.0, 119.0, 145.0, 162.0, 119.0, 146.0, 140.0, 119.0, 162.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 139.4}, {"lowerIsBetter": true, "replicates": [187.0, 184.0, 198.0, 261.0, 184.0, 184.0, 200.0, 264.0, 186.0, 180.0], "unit": "score", "name": "audio-dft", "value": 202.8}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 97.0, 108.0, 83.0, 47.0, 52.0, 66.0, 79.0, 71.0], "unit": "score", "name": "audio-fft", "value": 75.0}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 127.0, 78.0, 77.0, 85.0, 112.0, 79.0, 79.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 94.8}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 86.0, 83.0, 87.0, 84.0, 87.0, 87.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 93.0, 93.0, 92.0, 94.0, 93.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.1}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 85.0, 85.0, 86.0, 88.0, 83.0, 85.0, 86.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 85.5}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 55.0, 55.0, 55.0, 55.0, 54.0, 64.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 69.0, 79.0, 74.0, 71.0, 67.0, 69.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 82.0, 84.0, 83.0, 83.0, 84.0, 83.0, 85.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [123.0, 126.0, 141.0, 110.0, 132.0, 135.0, 136.0, 140.0, 122.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.4}, {"lowerIsBetter": true, "replicates": [137.0, 172.0, 135.0, 141.0, 141.0, 126.0, 139.0, 138.0, 138.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.4}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 73.0, 67.0, 68.0, 68.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1432.9000000000003}]} 05:42:01 INFO - Return code: 0 05:42:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:42:01 ERROR - # TBPL SUCCESS # 05:42:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:42:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:42:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:42:01 INFO - 2016-03-30 05:42:01.540 screenresolution[1981:13727] starting screenresolution argv=screenresolution get 05:42:01 INFO - 2016-03-30 05:42:01.542 screenresolution[1981:13727] Display 0: 1600x1200x32@60 05:42:01 INFO - 2016-03-30 05:42:01.549 screenresolution[1982:13730] starting screenresolution argv=screenresolution list 05:42:01 INFO - Available Modes on Display 0 05:42:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:42:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:42:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:42:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:42:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:42:01 INFO - Intel Iris: 05:42:01 INFO - Chipset Model: Intel Iris 05:42:01 INFO - Type: GPU 05:42:01 INFO - Bus: Built-In 05:42:01 INFO - VRAM (Dynamic, Max): 1536 MB 05:42:01 INFO - Vendor: Intel (0x8086) 05:42:01 INFO - Device ID: 0x0a2e 05:42:01 INFO - Revision ID: 0x0009 05:42:01 INFO - Displays: 05:42:01 INFO - Display: 05:42:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:42:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:42:01 INFO - Display Serial Number: 1600x1200 60 05:42:01 INFO - Main Display: Yes 05:42:01 INFO - Mirror: Off 05:42:01 INFO - Online: Yes 05:42:01 INFO - Rotation: Supported 05:42:01 INFO - Return code: 0 05:42:01 INFO - Running post-action listener: _resource_record_post_action 05:42:01 INFO - Running post-run listener: _resource_record_post_run 05:42:02 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 602112; Write bytes: 704161792; Read time: 12; Write time: 1877 05:42:02 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 391918080; Write bytes: 386037248; Read time: 29589; Write time: 695 05:42:02 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 602112; Write bytes: 298693120; Read time: 12; Write time: 1138 05:42:02 INFO - Running post-run listener: _upload_blobber_files 05:42:02 INFO - Blob upload gear active. 05:42:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:42:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:42:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:42:03 INFO - (blobuploader) - INFO - Open directory for files ... 05:42:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:42:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:42:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:04 INFO - (blobuploader) - INFO - Done attempting. 05:42:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:42:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:42:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:05 INFO - (blobuploader) - INFO - Done attempting. 05:42:05 INFO - (blobuploader) - INFO - Iteration through files over. 05:42:05 INFO - Return code: 0 05:42:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:42:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:42:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa6be51bcf1a3d4be035371af264984e15a5050acb8edc5d9fbde04ba0a94461d20b52d7dd2d899fac766398868dd802bf4561415f6e019369251e755f4b63a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0fe82c8931d603e59196e330f71a7cddc6543501dd46826f6c02f94a5e81b29cccc2af267576c5d6e58ada600f4e6c2c52bbc4da4f519c5aea14cae0b7422ce"} 05:42:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:42:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:42:05 INFO - Contents: 05:42:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa6be51bcf1a3d4be035371af264984e15a5050acb8edc5d9fbde04ba0a94461d20b52d7dd2d899fac766398868dd802bf4561415f6e019369251e755f4b63a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0fe82c8931d603e59196e330f71a7cddc6543501dd46826f6c02f94a5e81b29cccc2af267576c5d6e58ada600f4e6c2c52bbc4da4f519c5aea14cae0b7422ce"} 05:42:05 INFO - Running post-run listener: copy_logs_to_upload_dir 05:42:05 INFO - Copying logs to upload dir... 05:42:05 INFO - mkdir: /builds/slave/test/build/upload/logs 05:42:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.132804 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-30 05:42:05.685689) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 05:42:05.689282) ========= 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.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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/aa6be51bcf1a3d4be035371af264984e15a5050acb8edc5d9fbde04ba0a94461d20b52d7dd2d899fac766398868dd802bf4561415f6e019369251e755f4b63a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0fe82c8931d603e59196e330f71a7cddc6543501dd46826f6c02f94a5e81b29cccc2af267576c5d6e58ada600f4e6c2c52bbc4da4f519c5aea14cae0b7422ce"} build_url:https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010898 build_url: 'https://queue.taskcluster.net/v1/task/AJ8oHYwZSeKtXDT5i54v-Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa6be51bcf1a3d4be035371af264984e15a5050acb8edc5d9fbde04ba0a94461d20b52d7dd2d899fac766398868dd802bf4561415f6e019369251e755f4b63a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0fe82c8931d603e59196e330f71a7cddc6543501dd46826f6c02f94a5e81b29cccc2af267576c5d6e58ada600f4e6c2c52bbc4da4f519c5aea14cae0b7422ce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 05:42:05.717279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 05:42:05.717623) ========= 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.VsFU8EwzbZ/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.KBqCxhKBhj/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.005215 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 05:42:05.767656) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 05:42:05.768016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 05:42:05.768592) ========= ========= Total master_lag: 0.27 =========