builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0199 starttime: 1457353790.11 results: success (0) buildid: 20160307023512 builduid: b6e89e7c228544ff8b7fd3a6b9afba37 revision: 68d3781deda0d4d58ec9877862830db89669b3a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 04:29:50.112617) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 04:29:50.113102) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 04:29:50.113387) ========= 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.4BUsqr6rCi/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.YYGZlYJrbC/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.005812 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 04:29:50.177971) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 04:29:50.178271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 04:29:50.269835) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 04:29:50.270093) ========= 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.4BUsqr6rCi/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.YYGZlYJrbC/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.005058 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 04:29:50.317262) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 04:29:50.320731) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 04:29:50.321086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-07 04:29:50.325910) ========= 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.4BUsqr6rCi/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.YYGZlYJrbC/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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-07 04:29:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 40.6M=0s 2016-03-07 04:29:50 (40.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148208 ========= master_lag: 3.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-07 04:29:53.764276) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 04:29:53.764603) ========= 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.4BUsqr6rCi/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.YYGZlYJrbC/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.027198 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 04:29:53.850546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-07 04:29:53.850886) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 68d3781deda0d4d58ec9877862830db89669b3a5 --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 68d3781deda0d4d58ec9877862830db89669b3a5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4BUsqr6rCi/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.YYGZlYJrbC/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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-07 04:29:53,929 truncating revision to first 12 chars 2016-03-07 04:29:53,929 Setting DEBUG logging. 2016-03-07 04:29:53,929 attempt 1/10 2016-03-07 04:29:53,929 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/68d3781deda0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 04:29:56,038 unpacking tar archive at: mozilla-central-68d3781deda0/testing/mozharness/ program finished with exit code 0 elapsedTime=2.359395 ========= master_lag: 0.61 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-07 04:29:56.817963) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 04:29:56.823060) ========= echo 68d3781deda0d4d58ec9877862830db89669b3a5 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'68d3781deda0d4d58ec9877862830db89669b3a5'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4BUsqr6rCi/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.YYGZlYJrbC/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 68d3781deda0d4d58ec9877862830db89669b3a5 program finished with exit code 0 elapsedTime=0.005871 script_repo_revision: '68d3781deda0d4d58ec9877862830db89669b3a5' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 04:29:56.872624) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 04:29:56.872914) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 04:29:56.890600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-07 04:29:56.890872) ========= /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.4BUsqr6rCi/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.YYGZlYJrbC/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 04:29:57 INFO - MultiFileLogger online at 20160307 04:29:57 in /builds/slave/test 04:29:57 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 04:29:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:29:57 INFO - {'append_to_log': False, 04:29:57 INFO - 'base_work_dir': '/builds/slave/test', 04:29:57 INFO - 'blob_upload_branch': 'Firefox', 04:29:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:29:57 INFO - 'branch': 'Firefox', 04:29:57 INFO - 'buildbot_json_path': 'buildprops.json', 04:29:57 INFO - 'config_files': ('talos/mac_config.py',), 04:29:57 INFO - 'default_actions': ('clobber', 04:29:57 INFO - 'read-buildbot-config', 04:29:57 INFO - 'download-and-extract', 04:29:57 INFO - 'populate-webroot', 04:29:57 INFO - 'create-virtualenv', 04:29:57 INFO - 'install', 04:29:57 INFO - 'run-tests'), 04:29:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:29:57 INFO - 'download_minidump_stackwalk': True, 04:29:57 INFO - 'download_symbols': 'ondemand', 04:29:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:29:57 INFO - 'tooltool.py': '/tools/tooltool.py', 04:29:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:29:57 INFO - '/tools/misc-python/virtualenv.py')}, 04:29:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:29:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:29:57 INFO - 'installer_path': 'installer.exe', 04:29:57 INFO - 'log_level': 'info', 04:29:57 INFO - 'log_name': 'talos', 04:29:57 INFO - 'log_to_console': True, 04:29:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:29:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:29:57 INFO - 'opt_config_files': (), 04:29:57 INFO - 'pip_index': False, 04:29:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:29:57 INFO - 'cmd': ('bash', 04:29:57 INFO - '-c', 04:29:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:29:57 INFO - 'enabled': True, 04:29:57 INFO - 'halt_on_failure': False, 04:29:57 INFO - 'name': 'check_screen_resolution'},), 04:29:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:29:57 INFO - 'cmd': ('bash', 04:29:57 INFO - '-c', 04:29:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:29:57 INFO - 'enabled': True, 04:29:57 INFO - 'halt_on_failure': False, 04:29:57 INFO - 'name': 'check_screen_resolution'},), 04:29:57 INFO - 'run_cmd_checks_enabled': True, 04:29:57 INFO - 'sps_profile': False, 04:29:57 INFO - 'sps_profile_interval': 0, 04:29:57 INFO - 'suite': 'dromaeojs', 04:29:57 INFO - 'system_bits': '32', 04:29:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:29:57 INFO - 'title': 't-yosemite-r7-0199', 04:29:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:29:57 INFO - 'use_talos_json': True, 04:29:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:29:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:29:57 INFO - 'work_dir': 'build'} 04:29:57 INFO - ##### 04:29:57 INFO - ##### Running clobber step. 04:29:57 INFO - ##### 04:29:57 INFO - Running pre-action listener: _resource_record_pre_action 04:29:57 INFO - Running main action method: clobber 04:29:57 INFO - rmtree: /builds/slave/test/build 04:29:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:29:58 INFO - Running post-action listener: _resource_record_post_action 04:29:58 INFO - ##### 04:29:58 INFO - ##### Running read-buildbot-config step. 04:29:58 INFO - ##### 04:29:58 INFO - Running pre-action listener: _resource_record_pre_action 04:29:58 INFO - Running main action method: read_buildbot_config 04:29:58 INFO - Using buildbot properties: 04:29:58 INFO - { 04:29:58 INFO - "project": "", 04:29:58 INFO - "product": "firefox", 04:29:58 INFO - "script_repo_revision": "production", 04:29:58 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:29:58 INFO - "repository": "", 04:29:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:29:58 INFO - "buildid": "20160307023512", 04:29:58 INFO - "pgo_build": "False", 04:29:58 INFO - "basedir": "/builds/slave/test", 04:29:58 INFO - "buildnumber": 169, 04:29:58 INFO - "slavename": "t-yosemite-r7-0199", 04:29:58 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:29:58 INFO - "platform": "yosemite_r7", 04:29:58 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:29:58 INFO - "branch": "mozilla-central", 04:29:58 INFO - "repo_path": "mozilla-central", 04:29:58 INFO - "revision": "68d3781deda0d4d58ec9877862830db89669b3a5", 04:29:58 INFO - "stage_platform": "macosx64", 04:29:58 INFO - "builduid": "b6e89e7c228544ff8b7fd3a6b9afba37", 04:29:58 INFO - "slavebuilddir": "test" 04:29:58 INFO - } 04:29:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 04:29:58 INFO - Running post-action listener: _resource_record_post_action 04:29:58 INFO - ##### 04:29:58 INFO - ##### Running download-and-extract step. 04:29:58 INFO - ##### 04:29:58 INFO - Running pre-action listener: _resource_record_pre_action 04:29:58 INFO - Running main action method: download_and_extract 04:29:58 INFO - mkdir: /builds/slave/test/build/tests 04:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:58 INFO - https://queue.taskcluster.net/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:29:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 04:29:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 04:29:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 04:29:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 04:30:00 INFO - Downloaded 1277 bytes. 04:30:00 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 04:30:00 INFO - Using the following test package requirements: 04:30:00 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:30:00 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:30:00 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:30:00 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:30:00 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:30:00 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:30:00 INFO - u'jsshell-mac.zip'], 04:30:00 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:30:00 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:30:00 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:30:00 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:30:00 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:30:00 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:30:00 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:30:00 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:30:00 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:30:00 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:30:00 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:30:00 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:30:00 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:00 INFO - https://queue.taskcluster.net/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:30:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:30:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:30:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:30:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:30:05 INFO - Downloaded 17866417 bytes. 04:30:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:30:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:30:08 INFO - Return code: 0 04:30:08 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:30:08 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')]} 04:30:08 INFO - https://queue.taskcluster.net/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:30:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:30:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:30:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:30:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:30:09 INFO - Downloaded 17866417 bytes. 04:30:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:30:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:30:13 INFO - Return code: 0 04:30:13 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')]} 04:30:13 INFO - https://queue.taskcluster.net/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:30:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:30:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:30:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:30:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:30:16 INFO - Downloaded 10845161 bytes. 04:30:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:30:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:30:16 INFO - Return code: 0 04:30: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')]} 04:30:16 INFO - https://queue.taskcluster.net/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:30:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:30:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:30:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:30:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 04:30:19 INFO - Downloaded 110992284 bytes. 04:30:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:30:19 INFO - mkdir: /builds/slave/test/properties 04:30:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:30:19 INFO - Writing to file /builds/slave/test/properties/build_url 04:30:19 INFO - Contents: 04:30:19 INFO - build_url:https://queue.taskcluster.net/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:30:20 INFO - Running post-action listener: _resource_record_post_action 04:30:20 INFO - Running post-action listener: set_extra_try_arguments 04:30:20 INFO - ##### 04:30:20 INFO - ##### Running populate-webroot step. 04:30:20 INFO - ##### 04:30:20 INFO - Running pre-action listener: _resource_record_pre_action 04:30:20 INFO - Running main action method: populate_webroot 04:30:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:30:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:30:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:30:20 INFO - '--tppagecycles', 04:30:20 INFO - '7'], 04:30:20 INFO - 'tests': ['tsvgm']}}, 04:30:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:30:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:30:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:30:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:30:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:30:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:30:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:20 INFO - 'talos_options': ['--e10s'], 04:30:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:20 INFO - 'tests': ['damp', 'tps']}, 04:30:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:20 INFO - 'talos_options': ['--e10s'], 04:30:20 INFO - 'tests': ['damp', 'tps']}, 04:30:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:30:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:30:20 INFO - 'other': {'tests': ['a11yr', 04:30:20 INFO - 'ts_paint', 04:30:20 INFO - 'tpaint', 04:30:20 INFO - 'sessionrestore', 04:30:20 INFO - 'sessionrestore_no_auto_restore', 04:30:20 INFO - 'tabpaint']}, 04:30:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:30:20 INFO - 'tests': ['a11yr', 04:30:20 INFO - 'ts_paint', 04:30:20 INFO - 'tpaint', 04:30:20 INFO - 'sessionrestore', 04:30:20 INFO - 'sessionrestore_no_auto_restore', 04:30:20 INFO - 'tabpaint']}, 04:30:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:30:20 INFO - 'tests': ['a11yr', 04:30:20 INFO - 'ts_paint', 04:30:20 INFO - 'tpaint', 04:30:20 INFO - 'sessionrestore', 04:30:20 INFO - 'sessionrestore_no_auto_restore', 04:30:20 INFO - 'tabpaint']}, 04:30:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:30:20 INFO - 'tests': ['a11yr', 04:30:20 INFO - 'ts_paint', 04:30:20 INFO - 'tpaint', 04:30:20 INFO - 'sessionrestore', 04:30:20 INFO - 'sessionrestore_no_auto_restore', 04:30:20 INFO - 'tabpaint']}, 04:30:20 INFO - 'other_l64': {'tests': ['a11yr', 04:30:20 INFO - 'ts_paint', 04:30:20 INFO - 'tpaint', 04:30:20 INFO - 'sessionrestore', 04:30:20 INFO - 'sessionrestore_no_auto_restore', 04:30:20 INFO - 'tabpaint']}, 04:30:20 INFO - 'other_nol64': {'tests': ['a11yr', 04:30:20 INFO - 'ts_paint', 04:30:20 INFO - 'tpaint', 04:30:20 INFO - 'sessionrestore', 04:30:20 INFO - 'sessionrestore_no_auto_restore', 04:30:20 INFO - 'tabpaint']}, 04:30:20 INFO - 'svgr': {'tests': ['tsvgx', 04:30:20 INFO - 'tsvgr_opacity', 04:30:20 INFO - 'tart', 04:30:20 INFO - 'tscrollx', 04:30:20 INFO - 'cart']}, 04:30:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:30:20 INFO - 'tests': ['tsvgx', 04:30:20 INFO - 'tsvgr_opacity', 04:30:20 INFO - 'tart', 04:30:20 INFO - 'tscrollx', 04:30:20 INFO - 'cart']}, 04:30:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:20 INFO - 'tests': ['tp5o']}, 04:30:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:20 INFO - 'talos_options': ['--e10s'], 04:30:20 INFO - 'tests': ['tp5o']}, 04:30:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:20 INFO - 'talos_options': ['--xperf_path', 04:30:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:20 INFO - 'tests': ['tp5n']}, 04:30:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:20 INFO - 'talos_options': ['--e10s', 04:30:20 INFO - '--xperf_path', 04:30:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:20 INFO - 'tests': ['tp5n']}}, 04:30:20 INFO - 'talos.zip': {'path': '', 04:30:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:30:20 INFO - Running post-action listener: _resource_record_post_action 04:30:20 INFO - ##### 04:30:20 INFO - ##### Running create-virtualenv step. 04:30:20 INFO - ##### 04:30:20 INFO - Running pre-action listener: _resource_record_pre_action 04:30:20 INFO - Running main action method: create_virtualenv 04:30:20 INFO - Creating virtualenv /builds/slave/test/build/venv 04:30: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 04:30:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:30:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:30:20 INFO - Using real prefix '/tools/python27' 04:30:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:30:21 INFO - Installing distribute.............................................................................................................................................................................................done. 04:30:24 INFO - Installing pip.................done. 04:30:24 INFO - Return code: 0 04:30:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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 0x104eb8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc614bcb30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5cd30>, '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 0x104b80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d53b20>, '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.4BUsqr6rCi/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.YYGZlYJrbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 04:30: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 04:30: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 04:30:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4BUsqr6rCi/Render', 04:30:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:24 INFO - 'HOME': '/Users/cltbld', 04:30:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:24 INFO - 'LOGNAME': 'cltbld', 04:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:24 INFO - 'MOZ_NO_REMOTE': '1', 04:30:24 INFO - 'NO_EM_RESTART': '1', 04:30:24 INFO - 'PAGER': '/bin/cat', 04:30:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:24 INFO - 'PWD': '/builds/slave/test', 04:30:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:24 INFO - 'SHELL': '/bin/bash', 04:30:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYGZlYJrbC/Listeners', 04:30:24 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:30:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:24 INFO - 'USER': 'cltbld', 04:30:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:24 INFO - 'XPC_FLAGS': '0x0', 04:30:24 INFO - 'XPC_SERVICE_NAME': '0', 04:30:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30: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 04:30:24 INFO - Cleaning up... 04:30:24 INFO - Return code: 0 04:30:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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 0x104eb8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc614bcb30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5cd30>, '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 0x104b80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d53b20>, '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.4BUsqr6rCi/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.YYGZlYJrbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 04:30: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 04:30: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 04:30:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4BUsqr6rCi/Render', 04:30:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:24 INFO - 'HOME': '/Users/cltbld', 04:30:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:24 INFO - 'LOGNAME': 'cltbld', 04:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:24 INFO - 'MOZ_NO_REMOTE': '1', 04:30:24 INFO - 'NO_EM_RESTART': '1', 04:30:24 INFO - 'PAGER': '/bin/cat', 04:30:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:24 INFO - 'PWD': '/builds/slave/test', 04:30:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:24 INFO - 'SHELL': '/bin/bash', 04:30:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYGZlYJrbC/Listeners', 04:30:24 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:30:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:24 INFO - 'USER': 'cltbld', 04:30:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:24 INFO - 'XPC_FLAGS': '0x0', 04:30:24 INFO - 'XPC_SERVICE_NAME': '0', 04:30:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:24 INFO - Downloading/unpacking psutil>=0.7.1 04:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:30:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:27 INFO - Installing collected packages: psutil 04:30:27 INFO - Running setup.py install for psutil 04:30:27 INFO - building 'psutil._psutil_osx' extension 04:30: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 04:30: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 04:30: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:30:27 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 04:30:28 INFO - building 'psutil._psutil_posix' extension 04:30: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 04:30:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:30:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:30:28 INFO - ^ 04:30:28 INFO - 1 warning generated. 04:30: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 04:30:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:28 INFO - Successfully installed psutil 04:30:28 INFO - Cleaning up... 04:30:28 INFO - Return code: 0 04:30:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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 0x104eb8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc614bcb30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5cd30>, '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 0x104b80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d53b20>, '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.4BUsqr6rCi/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.YYGZlYJrbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 04:30: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 04:30: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 04:30:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4BUsqr6rCi/Render', 04:30:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:28 INFO - 'HOME': '/Users/cltbld', 04:30:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:28 INFO - 'LOGNAME': 'cltbld', 04:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:28 INFO - 'MOZ_NO_REMOTE': '1', 04:30:28 INFO - 'NO_EM_RESTART': '1', 04:30:28 INFO - 'PAGER': '/bin/cat', 04:30:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:28 INFO - 'PWD': '/builds/slave/test', 04:30:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:28 INFO - 'SHELL': '/bin/bash', 04:30:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYGZlYJrbC/Listeners', 04:30:28 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:30:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:28 INFO - 'USER': 'cltbld', 04:30:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:28 INFO - 'XPC_FLAGS': '0x0', 04:30:28 INFO - 'XPC_SERVICE_NAME': '0', 04:30:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:30:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:30: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) 04:30:31 INFO - Installing collected packages: mozsystemmonitor 04:30:31 INFO - Running setup.py install for mozsystemmonitor 04:30:31 INFO - Successfully installed mozsystemmonitor 04:30:31 INFO - Cleaning up... 04:30:31 INFO - Return code: 0 04:30:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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 0x104eb8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc614bcb30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5cd30>, '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 0x104b80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d53b20>, '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.4BUsqr6rCi/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.YYGZlYJrbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 04:30: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 04:30: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 04:30:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4BUsqr6rCi/Render', 04:30:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:31 INFO - 'HOME': '/Users/cltbld', 04:30:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:31 INFO - 'LOGNAME': 'cltbld', 04:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:31 INFO - 'MOZ_NO_REMOTE': '1', 04:30:31 INFO - 'NO_EM_RESTART': '1', 04:30:31 INFO - 'PAGER': '/bin/cat', 04:30:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:31 INFO - 'PWD': '/builds/slave/test', 04:30:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:31 INFO - 'SHELL': '/bin/bash', 04:30:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYGZlYJrbC/Listeners', 04:30:31 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:30:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:31 INFO - 'USER': 'cltbld', 04:30:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:31 INFO - 'XPC_FLAGS': '0x0', 04:30:31 INFO - 'XPC_SERVICE_NAME': '0', 04:30:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:31 INFO - Downloading/unpacking blobuploader==1.2.4 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:33 INFO - Downloading blobuploader-1.2.4.tar.gz 04:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:30:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:30:33 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 04:30:33 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 04:30:33 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 04:30:33 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 04:30:33 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 04:30:33 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 04:30:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:30:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:35 INFO - Downloading docopt-0.6.1.tar.gz 04:30:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:30:35 INFO - Installing collected packages: blobuploader, requests, docopt 04:30:35 INFO - Running setup.py install for blobuploader 04:30:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:30:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:30:35 INFO - Running setup.py install for requests 04:30:35 INFO - Running setup.py install for docopt 04:30:35 INFO - Successfully installed blobuploader requests docopt 04:30:35 INFO - Cleaning up... 04:30:36 INFO - Return code: 0 04:30:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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 0x104eb8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc614bcb30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5cd30>, '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 0x104b80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d53b20>, '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.4BUsqr6rCi/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.YYGZlYJrbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 04:30: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 04:30: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 04:30:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4BUsqr6rCi/Render', 04:30:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:36 INFO - 'HOME': '/Users/cltbld', 04:30:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:36 INFO - 'LOGNAME': 'cltbld', 04:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:36 INFO - 'MOZ_NO_REMOTE': '1', 04:30:36 INFO - 'NO_EM_RESTART': '1', 04:30:36 INFO - 'PAGER': '/bin/cat', 04:30:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:36 INFO - 'PWD': '/builds/slave/test', 04:30:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:36 INFO - 'SHELL': '/bin/bash', 04:30:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYGZlYJrbC/Listeners', 04:30:36 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:30:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:36 INFO - 'USER': 'cltbld', 04:30:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:36 INFO - 'XPC_FLAGS': '0x0', 04:30:36 INFO - 'XPC_SERVICE_NAME': '0', 04:30:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:36 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-c79XMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:36 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-WORm3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:36 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-fb1qeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:36 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-xZZSKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:37 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-MHSLB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:37 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-EQxSYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:37 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-P5Ub8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:37 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-8ip15p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:37 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-FXZrib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:37 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-MNgSK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:37 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-tyHihC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:37 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Y3cvvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:37 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-uot2NE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:37 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Lcj0Ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:38 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-jD0K1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:38 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-hgRx_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:38 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-arsOVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:30:38 INFO - Running setup.py install for manifestparser 04:30:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:30:38 INFO - Running setup.py install for mozcrash 04:30:38 INFO - Running setup.py install for mozdebug 04:30:38 INFO - Running setup.py install for mozdevice 04:30:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:30:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:30:39 INFO - Running setup.py install for mozfile 04:30:39 INFO - Running setup.py install for mozhttpd 04:30:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:30:39 INFO - Running setup.py install for mozinfo 04:30:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:30:39 INFO - Running setup.py install for mozInstall 04:30:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:30:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:30:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:30:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:30:39 INFO - Running setup.py install for mozleak 04:30:39 INFO - Running setup.py install for mozlog 04:30:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:30:39 INFO - Running setup.py install for moznetwork 04:30:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:30:40 INFO - Running setup.py install for mozprocess 04:30:40 INFO - Running setup.py install for mozprofile 04:30:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:30:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:30:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:30:40 INFO - Running setup.py install for mozrunner 04:30:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:30:40 INFO - Running setup.py install for mozscreenshot 04:30:40 INFO - Running setup.py install for moztest 04:30:40 INFO - Running setup.py install for mozversion 04:30:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:30:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:30:40 INFO - Cleaning up... 04:30:40 INFO - Return code: 0 04:30:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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 0x104eb8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc614bcb30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5cd30>, '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 0x104b80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d53b20>, '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.4BUsqr6rCi/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.YYGZlYJrbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 04:30: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 04:30: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 04:30:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4BUsqr6rCi/Render', 04:30:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:40 INFO - 'HOME': '/Users/cltbld', 04:30:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:40 INFO - 'LOGNAME': 'cltbld', 04:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:40 INFO - 'MOZ_NO_REMOTE': '1', 04:30:40 INFO - 'NO_EM_RESTART': '1', 04:30:40 INFO - 'PAGER': '/bin/cat', 04:30:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:40 INFO - 'PWD': '/builds/slave/test', 04:30:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:40 INFO - 'SHELL': '/bin/bash', 04:30:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYGZlYJrbC/Listeners', 04:30:40 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:30:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:40 INFO - 'USER': 'cltbld', 04:30:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:40 INFO - 'XPC_FLAGS': '0x0', 04:30:40 INFO - 'XPC_SERVICE_NAME': '0', 04:30:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:41 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-uHGenv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30: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)) 04:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:41 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-5Ynhuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30: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)) 04:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:41 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-KIUAXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30: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)) 04:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:41 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-h0s_io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30: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)) 04:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:41 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-PI8vst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30: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)) 04:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:41 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-9dOFsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30: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)) 04:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:41 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-NwhaVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30: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)) 04:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:41 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-VglyHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:42 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)) 04:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:42 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-bJKsXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:42 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)) 04:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:42 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-mf0kDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30: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)) 04:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:42 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-7sUtes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30: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)) 04:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:42 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-pOxo3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30: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)) 04:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:42 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-5lUViC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30: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)) 04:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:42 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-Ix9aXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30: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)) 04:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:42 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-6ZONNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30: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)) 04:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:42 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-ru0Rcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30: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)) 04:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:42 INFO - Running setup.py (path:/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/pip-tHKfYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:43 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)) 04:30:43 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)) 04:30:43 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)) 04:30:43 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)) 04:30:43 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)) 04:30:43 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)) 04:30:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:30:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:30:45 INFO - Downloading blessings-1.6.tar.gz 04:30:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:30:45 INFO - Installing collected packages: blessings 04:30:45 INFO - Running setup.py install for blessings 04:30:46 INFO - Successfully installed blessings 04:30:46 INFO - Cleaning up... 04:30:46 INFO - Return code: 0 04:30:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:30:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:30:46 INFO - Reading from file tmpfile_stdout 04:30:46 INFO - Current package versions: 04:30:46 INFO - blessings == 1.6 04:30:46 INFO - blobuploader == 1.2.4 04:30:46 INFO - docopt == 0.6.1 04:30:46 INFO - manifestparser == 1.1 04:30:46 INFO - mozInstall == 1.12 04:30:46 INFO - mozcrash == 0.17 04:30:46 INFO - mozdebug == 0.1 04:30:46 INFO - mozdevice == 0.48 04:30:46 INFO - mozfile == 1.2 04:30:46 INFO - mozhttpd == 0.7 04:30:46 INFO - mozinfo == 0.9 04:30:46 INFO - mozleak == 0.1 04:30:46 INFO - mozlog == 3.1 04:30:46 INFO - moznetwork == 0.27 04:30:46 INFO - mozprocess == 0.22 04:30:46 INFO - mozprofile == 0.28 04:30:46 INFO - mozrunner == 6.11 04:30:46 INFO - mozscreenshot == 0.1 04:30:46 INFO - mozsystemmonitor == 0.0 04:30:46 INFO - moztest == 0.7 04:30:46 INFO - mozversion == 1.4 04:30:46 INFO - psutil == 3.1.1 04:30:46 INFO - requests == 1.2.3 04:30:46 INFO - wsgiref == 0.1.2 04:30:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:46 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 0x104eb8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc614bcb30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5cd30>, '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 0x104b80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d53b20>, '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.4BUsqr6rCi/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.YYGZlYJrbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 04:30:46 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 04:30:46 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 04:30:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4BUsqr6rCi/Render', 04:30:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:46 INFO - 'HOME': '/Users/cltbld', 04:30:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:46 INFO - 'LOGNAME': 'cltbld', 04:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:46 INFO - 'MOZ_NO_REMOTE': '1', 04:30:46 INFO - 'NO_EM_RESTART': '1', 04:30:46 INFO - 'PAGER': '/bin/cat', 04:30:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:46 INFO - 'PWD': '/builds/slave/test', 04:30:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:46 INFO - 'SHELL': '/bin/bash', 04:30:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYGZlYJrbC/Listeners', 04:30:46 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:30:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:46 INFO - 'USER': 'cltbld', 04:30:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:46 INFO - 'XPC_FLAGS': '0x0', 04:30:46 INFO - 'XPC_SERVICE_NAME': '0', 04:30:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30: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)) 04:30: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)) 04:30: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)) 04:30: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)) 04:30: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)) 04:30: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)) 04:30: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)) 04:30: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)) 04:30: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)) 04:30: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)) 04:30: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)) 04:30:46 INFO - Cleaning up... 04:30:46 INFO - Return code: 0 04:30:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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 0x104eb8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc614bcb30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5cd30>, '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 0x104b80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d53b20>, '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.4BUsqr6rCi/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.YYGZlYJrbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 04:30: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 04:30: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 04:30:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4BUsqr6rCi/Render', 04:30:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:46 INFO - 'HOME': '/Users/cltbld', 04:30:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:46 INFO - 'LOGNAME': 'cltbld', 04:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:46 INFO - 'MOZ_NO_REMOTE': '1', 04:30:46 INFO - 'NO_EM_RESTART': '1', 04:30:46 INFO - 'PAGER': '/bin/cat', 04:30:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:46 INFO - 'PWD': '/builds/slave/test', 04:30:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:46 INFO - 'SHELL': '/bin/bash', 04:30:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYGZlYJrbC/Listeners', 04:30:46 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:30:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:46 INFO - 'USER': 'cltbld', 04:30:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:46 INFO - 'XPC_FLAGS': '0x0', 04:30:46 INFO - 'XPC_SERVICE_NAME': '0', 04:30:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:46 INFO - Downloading/unpacking jsonschema 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:30:49 INFO - Downloading/unpacking functools32 (from jsonschema) 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:49 INFO - Downloading functools32-3.2.3-2.tar.gz 04:30:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:30:49 INFO - warning: no files found matching '*.txt' 04:30:49 INFO - no previously-included directories found matching 'build' 04:30:49 INFO - no previously-included directories found matching 'dist' 04:30:49 INFO - no previously-included directories found matching '.git*' 04:30:49 INFO - Installing collected packages: jsonschema, functools32 04:30:49 INFO - Running setup.py install for functools32 04:30:49 INFO - warning: no files found matching '*.txt' 04:30:49 INFO - no previously-included directories found matching 'build' 04:30:49 INFO - no previously-included directories found matching 'dist' 04:30:49 INFO - no previously-included directories found matching '.git*' 04:30:49 INFO - Successfully installed jsonschema functools32 04:30:49 INFO - Cleaning up... 04:30:50 INFO - Return code: 0 04:30:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:30:50 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')]} 04:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:50 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')]} 04:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:50 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 0x104eb8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ec04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc614bcb30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d5cd30>, '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 0x104b80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d53b20>, '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.4BUsqr6rCi/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.YYGZlYJrbC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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 04:30:50 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 04:30:50 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 04:30:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4BUsqr6rCi/Render', 04:30:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:50 INFO - 'HOME': '/Users/cltbld', 04:30:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:50 INFO - 'LOGNAME': 'cltbld', 04:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:50 INFO - 'MOZ_NO_REMOTE': '1', 04:30:50 INFO - 'NO_EM_RESTART': '1', 04:30:50 INFO - 'PAGER': '/bin/cat', 04:30:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:50 INFO - 'PWD': '/builds/slave/test', 04:30:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:50 INFO - 'SHELL': '/bin/bash', 04:30:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYGZlYJrbC/Listeners', 04:30:50 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:30:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:50 INFO - 'USER': 'cltbld', 04:30:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:50 INFO - 'XPC_FLAGS': '0x0', 04:30:50 INFO - 'XPC_SERVICE_NAME': '0', 04:30:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:50 INFO - Downloading/unpacking flake8 04:30:50 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 04:30:50 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 04:30:50 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 04:30:50 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 04:30:50 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 04:30:50 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 04:30:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:30:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:30:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:30:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:30:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:30:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:30:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:30:53 INFO - no previously-included directories found matching 'docs/_build' 04:30:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:30:53 INFO - Running setup.py install for pep8 04:30:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:30:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:30:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:30:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:30:54 INFO - no previously-included directories found matching 'docs/_build' 04:30:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:30:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:30:54 INFO - Cleaning up... 04:30:54 INFO - Return code: 0 04:30:54 INFO - Running post-action listener: _resource_record_post_action 04:30:54 INFO - Running post-action listener: _start_resource_monitoring 04:30:54 INFO - Starting resource monitoring. 04:30:54 INFO - ##### 04:30:54 INFO - ##### Running install step. 04:30:54 INFO - ##### 04:30:54 INFO - Running pre-action listener: _resource_record_pre_action 04:30:54 INFO - Running main action method: install 04:30:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:30:54 INFO - Reading from file tmpfile_stdout 04:30:54 INFO - Detecting whether we're running mozinstall >=1.0... 04:30:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:30:54 INFO - Reading from file tmpfile_stdout 04:30:54 INFO - Output received: 04:30:54 INFO - Usage: mozinstall [options] installer 04:30:54 INFO - Options: 04:30:54 INFO - -h, --help show this help message and exit 04:30:54 INFO - -d DEST, --destination=DEST 04:30:54 INFO - Directory to install application into. [default: 04:30:54 INFO - "/builds/slave/test"] 04:30:54 INFO - --app=APP Application being installed. [default: firefox] 04:30:54 INFO - mkdir: /builds/slave/test/build/application 04:30:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:31:28 INFO - Reading from file tmpfile_stdout 04:31:28 INFO - Output received: 04:31:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:31:28 INFO - Running post-action listener: _resource_record_post_action 04:31:28 INFO - ##### 04:31:28 INFO - ##### Running run-tests step. 04:31:28 INFO - ##### 04:31:28 INFO - Running pre-action listener: _resource_record_pre_action 04:31:28 INFO - Running main action method: run_tests 04:31:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:31:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:31:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:31:28 INFO - 2016-03-07 04:31:28.432 screenresolution[1643:7681] starting screenresolution argv=screenresolution get 04:31:28 INFO - 2016-03-07 04:31:28.435 screenresolution[1643:7681] Display 0: 1600x1200x32@60 04:31:28 INFO - 2016-03-07 04:31:28.440 screenresolution[1644:7683] starting screenresolution argv=screenresolution list 04:31:28 INFO - Available Modes on Display 0 04:31:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:31:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:31:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:31:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:31:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:31:28 INFO - Intel Iris: 04:31:28 INFO - Chipset Model: Intel Iris 04:31:28 INFO - Type: GPU 04:31:28 INFO - Bus: Built-In 04:31:28 INFO - VRAM (Dynamic, Max): 1536 MB 04:31:28 INFO - Vendor: Intel (0x8086) 04:31:28 INFO - Device ID: 0x0a2e 04:31:28 INFO - Revision ID: 0x0009 04:31:28 INFO - Displays: 04:31:28 INFO - Display: 04:31:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:31:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:31:28 INFO - Display Serial Number: 1600x1200 60 04:31:28 INFO - Main Display: Yes 04:31:28 INFO - Mirror: Off 04:31:28 INFO - Online: Yes 04:31:28 INFO - Rotation: Supported 04:31:28 INFO - Return code: 0 04:31:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:31:28 INFO - Python 2.7.3 04:31:28 INFO - Return code: 0 04:31:28 INFO - grabbing minidump binary from tooltool 04:31: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')]} 04:31: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 0x104d5cd30>, '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 0x104b80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d53b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:31: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 04:31: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 04:31:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:28 INFO - Return code: 0 04:31:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:31:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:31:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:31:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:31:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:31:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:31:29 INFO - Return code: 0 04:31: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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0199', '--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 04:31: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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0199 --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 04:31:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4BUsqr6rCi/Render', 04:31:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:29 INFO - 'HOME': '/Users/cltbld', 04:31:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:29 INFO - 'LOGNAME': 'cltbld', 04:31:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:31:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:29 INFO - 'MOZ_NO_REMOTE': '1', 04:31:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:31:29 INFO - 'NO_EM_RESTART': '1', 04:31:29 INFO - 'PAGER': '/bin/cat', 04:31:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:29 INFO - 'PWD': '/builds/slave/test', 04:31:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:31:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:29 INFO - 'SHELL': '/bin/bash', 04:31:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YYGZlYJrbC/Listeners', 04:31:29 INFO - 'TMPDIR': '/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/', 04:31:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:29 INFO - 'USER': 'cltbld', 04:31:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:29 INFO - 'XPC_FLAGS': '0x0', 04:31:29 INFO - 'XPC_SERVICE_NAME': '0', 04:31:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31: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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0199', '--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 04:31:30 INFO - mozversion application_buildid: 20160307023512 04:31:30 INFO - mozversion application_changeset: 68d3781deda0d4d58ec9877862830db89669b3a5 04:31:30 INFO - mozversion application_display_name: Nightly 04:31:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:31:30 INFO - mozversion application_name: Firefox 04:31:30 INFO - mozversion application_remotingname: firefox 04:31:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:31:30 INFO - mozversion application_vendor: Mozilla 04:31:30 INFO - mozversion application_version: 47.0a1 04:31:30 INFO - mozversion platform_buildid: 20160307023512 04:31:30 INFO - mozversion platform_changeset: 68d3781deda0d4d58ec9877862830db89669b3a5 04:31:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:31:30 INFO - mozversion platform_version: 47.0a1 04:31:30 INFO - using testdate: 1457353890 04:31:30 INFO - actual date: 1457353890 04:31:30 INFO - starting webserver on 'localhost:49275' 04:31:30 INFO - SUITE-START | Running 2 tests 04:31:30 INFO - TEST-START | dromaeo_css 04:31:30 INFO - operating with platform_type : mac_ 04:31:30 INFO - Initialising browser for dromaeo_css test... 04:31:30 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpKqKI0p/profile http://localhost:49275/getInfo.html) 04:31:32 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 04:31:32 INFO - PROCESS | 1662 | colorDepth:24 04:31:32 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 04:31:32 INFO - PROCESS | 1662 | __metrics 04:31:32 INFO - PROCESS | 1662 | 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" 04:31:32 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:31:33 INFO - TEST-INFO | 1662: exit 0 04:31:33 INFO - Browser initialized. 04:31:33 INFO - Running cycle 1/1 for dromaeo_css test... 04:31:33 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpKqKI0p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:45 INFO - PROCESS | 1665 | RSS: Main: 245891072 04:31:45 INFO - PROCESS | 1665 | 04:32:37 INFO - PROCESS | 1665 | 1457353957042 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] 04:34:46 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 04:34:47 INFO - PROCESS | 1665 | RSS: Main: 360488960 04:34:47 INFO - PROCESS | 1665 | 04:37:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 04:37:50 INFO - PROCESS | 1665 | RSS: Main: 381321216 04:37:50 INFO - PROCESS | 1665 | 04:40:52 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 04:40:53 INFO - PROCESS | 1665 | RSS: Main: 381435904 04:40:53 INFO - PROCESS | 1665 | 04:43:55 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 04:43:56 INFO - PROCESS | 1665 | RSS: Main: 335122432 04:43:56 INFO - PROCESS | 1665 | 04:46:58 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 04:46:59 INFO - PROCESS | 1665 | RSS: Main: 339959808 04:46:59 INFO - PROCESS | 1665 | 04:50:02 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 04:50:02 INFO - PROCESS | 1665 | RSS: Main: 407875584 04:50:02 INFO - PROCESS | 1665 | 04:50:02 INFO - PROCESS | 1665 | __start_tp_report 04:50:02 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 04:50:02 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 04:50:02 INFO - PROCESS | 1665 | |i|pagename|runs| 04:50:02 INFO - PROCESS | 1665 | |0;dojo.html;3391.4065038618237;3404.574428196476;3435.5877294724637;3441.432163692991;3456.0495863637498;5490.945090549093;5519.9172012419795;5523.309586301717;5561.860953476165;5650.971745141269;5751.338596061454;5780.248567686195;5800.622959507639;5869.823905282838;5905.793297234598;5076.213186956028;5115.9488405116035;5121.078205922932;5158.561522270612;5225.973870130644;5276.234945932837;5284.048871203182;5313.8937221255555;5338.546223571001;5350.5452036576935;5068.1890897456415;5086.287919691246;5173.741312934357;5209.973950130225;5214.504622060898;5170.276161337416;5182.7408629568745;5183.637145399824;5183.766730497099;5206.479352064801;5109.744512774384;5127.6154288428515;5135.794568217267;5140.074786538422;5150.793968241266;5493.972530137324;5602.831915042555;5636.71816409182;5656.802011929604;5671.319441667027;6082.422169893853;6085.452309292141;6091.725872335711;6102.054181601814;6107.4503294703245;6069.180660610849;6139.1712118863825;6140.140380346755;6141.078838174265;6141.692915354214;5660.716964151776;5770.567207459458;5778.59549831512;5863.970680146572;5872.295324560994;6253;6261.812145635638;6272.278687950853;6284.057391391328;6285.874282514415;5996.820095397145;6006.2191915051635;6041.969790151109;6083.209182806207;6087.056506241451;4606.262997920317;6109.495762817132;6156.846078848064;6163.414475624809;6164.229471316085;6138.386161383915;6141.539384546088;6143.907841382383;6144.201253836973;6153.938460615426;6098.311206366174;6105.677094999929;6111.680786882627;6130.080487926757;6153.261608606996;4810.278458231293;4823.2282834746975;4853.854384368475;4856.053069651384;4871.5128487151715;4378.036831896978;4405.823767049346;4418.381426600278;4425.845095421645;4433.645308375322;5633.042382794934;5695.117256825199;5722.227499287626;5724.227229323988;5742.712864356766;6076.574639775174;6137.5703700741415;6142.416470435302;6145.955187618116;6152.138700581922;5748.827535173951;5782.10377391505;5792.94207057924;5828.766849326064;5831.679257640785;5341.946580534222;5353.9196912046355;5364.678119312854;5365.490278423544;5379.246905433242;6343.460805831463;6344.714487848058;6347.39699728525;6362.236531616236;6368.172137622079;6096.116063170904;6098.855844323317;6141.84645383869;6145.432914606747;6155.507559395327;6306.4639505642535;6330.9050364245495;6340.7463701451425;6355.269144048493;6421.261554921244;6062.333143354315;6062.696865156813;6068.848278792889;6075.7569697213385;6085.208922840003;6088.756449741961;6100.278413292402;6101.633901965896;6106.847328816815;6138.07928810682;5020.322256495472;6041.607295525777;6059.515238780975;6062.696865156637;6091.177691011834;6041.456268935817;6056.57603967718;6064.48451881595;6072.969635151796;6079.118527813531;5872.148538461985;5874.353821079592;5978.491828194652;5978.641281523122;6010.942563985173;5102.413222479462;6026.945284575269;6031.175835493617;6040.486558642565;6049.879002420015;5972.671503067199;5976.312724036791;5984.341722410444;5989;5998.430149135826 04:50:02 INFO - PROCESS | 1665 | |1;ext.html;459.5496413514753;461.4808340616806;536.7611412921246;613.8373331067268;641.3874749614117;36907;37792.24415511688;37814.62185378146;37857.86426407205;38085.428718569245;42939.14121717564;43636.909077273085;43729.78135109328;43749.34375984363;43750.343744843856;9601.711948641552;9845.753856153618;9846.458444785534;9855;9861.013898610117;9552.426854388725;9696.127348538665;9700.951495242514;9708.708738737814;9723.367981081206;9654.469004204766;9720.659776907809;9723;9735;9735.318527703064;9647.228221742243;9701.029897010243;9705.854412183822;9709.029097090304;9712.125908668184;9534.761630959212;9565.330426870121;9687.17658998986;9688.031196880325;9694.36986595869;40401.787946361655;40703.38944915828;40769.79615101935;40818.77543673695;40821.38767918484;3184.2357834119875;3324.4680851063954;3401.761876668634;3628.256207477461;3798.0125167456385;28040.719592804016;29282.560761588593;29728;29857.85071074631;29951.700482995326;2355.747578677519;2765.5851622256623;2779.9305017374527;2834.829910205374;2858.2282783648507;464929;495229;497103;497224.5138774319;497463;44625.88435289079;45072.3239151413;45106.77446612812;62599;62774.0583891242;43778.12443751171;43974.560254397686;43991.56008439875;44077.67766966996;44080.559194407644;15628.984116032421;15778.526644200692;15796.289166987513;15802.446914357943;15816.68366632661;12727.618171454871;12800.679983000313;12802.359882006049;12803.871961280454;12842.357882105858;14554;14594.978351515505;14617.049891757002;14642.558998635312;14785.334659940328;6211.943969525191;6359.17330747;6378.521610879203;6384.138141350858;6406.935930640727;961.7684579811827;969.970900872975;973.4208146153028;981.4405788700373;1012.1902478017556;23441.882790585936;28291.858540707166;28715.856420717762;29009.839606415506;29635.96274130438;948.7296120605595;1079.282277285612;1106.435717783936;1151.2746969409386;1162.2271189658952;14656.487022954145;14778.556643300719;15072.472463463726;15118.924405377902;15122.924385378003;529021;530170.9354704816;533326;533883;534088;57696.13455798166;58174.4182558169;58201.417985820444;58246.12630810541;58284.4171558279;1337.6856438736888;1457.4753088887992;1470.1399681186413;1493.8506149384975;1502.8647421732096;25398.619020715072;26586.670666466987;27859.442811143257;28400.147995560168;29190.708092918798;45637.543624564656;46881.765591171825;46980.83210846873;47098.293525596455;47119;369533;371469;372707;373485;375225;32320.030399088064;33035.669643303256;33615.495767563996;33617.66382336145;33661.15847103842;44532.88667783331;44574.3313850299;44689.32966005448;44953.77523112363;45958.080838383714;29823;34617;36992.44511332386;37825.81087094547;37905.81047094747;35994.28011439704;36431.817840910626;36643.45034824533;37000.81499592485;37007.6299237015;35609.93170204898;35850.10374740652;36163.63836361708;36903.708370206914;36973.89078327655;31312.373752525276;31908.840455797574;32083.358332832744;32092;32240.35519289648;23466;24128.672922989404;24440.14459493909;24467.265982020566;24475.66666831986 04:50:02 INFO - PROCESS | 1665 | |2;jquery.html;360.4377171612285;362.84760400631734;364.855881926639;373.9607341229171;374.85755412943075;19845;20332.390028299156;20840.47898802531;21027.264045758402;21232.893835530802;20341.084651190697;20382.388528344138;21158.047887845045;21182.046807893643;21424.571508569818;5869.295684517864;6020.759169633231;6074.787382441616;6084.878302433949;6114.602550834204;5820.272465941757;5854.268216472941;5949.3158286796925;5999.1301261317085;6009.1286763419275;5914.319853216892;5943.524518038546;5946.881062378771;5959.642421454727;5967.8209653710455;5644.548436125121;5923.05231163014;5948.970255148696;5964.075568286922;5967.701614919237;5111.4121875984365;5150.768215430315;5154.5103215194495;5157.097507936096;5158.896822063538;25344.619830702555;25795.484090318278;26081.826317815743;26185.214443566725;26204.475910481684;2175.5540114276537;2184.748753893291;2197.7142971413614;2218.9556208875892;2831.3204830840655;14596.34316455762;14792.260386980608;14961.551153465414;15353.15557644329;15386.384544618202;1712.2722842791889;1726.0334212840723;1734.9566260843453;1747.9825201747947;1770.8655679447306;64036.359636403504;76343.85484217742;83635.5818220911;85595.57202213949;104975;10773.62292319765;10824.07995320391;10900.672979810619;10948.890511094947;10971.39657318839;11893.643190704293;12150.878491215151;12185.45165467556;12202.206856554296;12203.145779795506;7802.453828232083;7853.8821917671285;8514.403991720521;8649.524276164871;8875.822483550293;8709.475841727799;9078.04680508537;9121.726348209564;9142.725718228463;9161.358704890727;5568.858384031264;6297.086922396227;6297.149884765589;6299.811005669837;6310.274318453345;1780.2078075256645;1842.2907180735244;1846.270723064409;1856.378113332022;1876.249500199931;861.7888617288679;881.6120906800987;970.8592254123254;982.5332966840837;1040.942748148859;20315.39053828358;20917;21048.579028419346;21229.256976005767;21483.78516214849;814.3729328417086;958.3291695812959;975.4586204656483;977.8386566216636;1022.2997246885907;10239.48802559869;10462.738431539272;10575.788484230427;10747.83878241827;10758.354498730101;465966;471191;504803;637569;637575;115881.42059289818;116031;117315.41342293404;124250.13624795635;128630.35684821704;1014.2899970021015;1068.4764465411893;1101.6970333158285;1116.625930313338;1122.3097794856105;15813.604659883595;17833.554161146076;17980.730289045412;18181.272749090418;18405.81594184041;50180.247296289854;51617;52020.73989630028;52383.73808130935;53721;51005;68216.31783682099;74326.62836685783;74585.25414745783;77611.22388776265;7766.611669416619;7957;8123.147069557847;8133.430659853753;8277.089520152658;12484.56304029391;13133.540326088923;13201.801972970605;13483;13554.254516001714;11264.15518836107;11546.59586914454;11567.479463423997;11837.526498939946;11855.881441185478;11290.830637540279;11429.59996400122;11532.308061516336;11688.240264382788;11769.588064417705;11612.825807612724;11737.589184378507;11791.587294444653;11923.046156307648;11949.342786146846;7850.882236766567;7965.880511792444;8018.3184429324165;8235.423520353757;8380.12008739098;11030.558777648805;11584.304941703525;11598.88401115978;11739.765204696028;11868.93179613839 04:50:02 INFO - PROCESS | 1665 | |3;mootools.html;1434.4118911246378;1560.1419219429313;1585.2866210205411;1868.280711925908;2018.2431588154452;7976.441649084566;8487.533185674785;8640.74077777666;8644.827103457927;8705.042445331017;7247.27527247275;8354.707585234519;8632.17994290543;8645.69740059098;8651.87022194666;2163.707899433572;2420.322309753272;2448.718397384297;2453.276283496364;2460.2127319257843;2399.448126930807;2474.6906636670415;2483.1184929350093;2483.192962287255;2488.30327508298;2123.235635171337;2471.6786817713673;2474.2206205045354;2478.603423452248;2486.0552989863827;2402.4594466245044;2435.2329016359877;2450.338408629678;2453.4970331082086;2458.1519375815315;2414.6619473273754;2429.757024297574;2442.8762769126224;2457.741937096597;2468.8024958003316;8738.344624153215;8790.560471976376;8812.69155579558;8816.074312197192;8826.86759698605;5398.757055932492;5535.806246781343;5558.944410555923;5578.386377498472;5580.804671836466;3597.2985267872778;3693.409054551259;3754.2491501699496;3754.9249015019545;3764.830582623761;935.1256575102301;1028.444639894456;1046.3774054437597;1056.984145237822;1067.199600299775;11870.643880683594;11878.643640690792;11905.702357441047;11905.880941190564;11910.940445297805;4780.426348838162;4863.416390033219;4960.950390496048;4981.950180498221;4984.3021976923255;9840.852387214198;9857.852132218022;10138;10145.847812282822;10153;5010.398752149693;5528.944710552923;5530.972345138249;5532.834014979557;5554.611177217556;4596.954030459719;4824.975875120602;4962.379702537183;4966.081274964144;4975.90048199034;3844.8462061517225;3939.1136994176654;3952.762834229898;3987.80060996949;4013.1973605278476;1305.8759417855288;1316.5260506217753;1318.8483324417623;1328.9401976911063;1331.6803967047838;1367.0430698511082;1368.8494265630773;1393.7212557488542;1409.8167238259166;1420.3537390487304;8184.2224988625985;8211.8357632847;8230.8353832923;8248.968878890139;8269.379796515286;507.7359772918062;508.6693649128096;511.0877084404395;513.876669599301;515.3300709078184;6111.35830737775;6181.134641150243;6226.59527130735;6249.687515624291;6269.65516896566;10240.334378265388;10512.737181570523;10591.099756520782;10615.256932014685;10658.467076646137;10056.949715251378;10325.74185645365;10451.581936722598;10495.265331426726;10495.580176792842;8210.425270231026;8228.753137405887;8236.629351679068;8279.130691277449;8329.416940814206;7729.149793522595;7765.650545725343;7769.339606133542;7979.241972012649;7993.400494962785;7783.53298802051;9112.908870911206;9311.76720581991;9373;9506.144446999802;9525.761855953657;9568.942677324409;9682.273829462678;9793.85309220348;9847.901520984698;6773.187217533928;6798.76204332846;7366.77899663011;7394.852102958018;7505.662245199088;8151.103378628465;8157.021157461143;8202.58987050657;8205.753827385188;8226.177382261725;7164.713411463483;7255.165655949633;7287.526310789994;7387;7479.663415146223;6794.3545363190415;7199.604021778852;7230.674619642234;7258.673359698721;7267.30960558746;7617.314441700052;7659.502132361378;7711.305982461606;7803.180666030212;7812.3359514439635;6944;7027.22700502934;7027.508074434741;7029;7031.1211098612675;6911.5853048817235;7076.929230707833;7079.008938748682;7093.184283807222;7098.219195888345 04:50:02 INFO - PROCESS | 1665 | |4;prototype.html;321.1441508380167;327.4400774675305;331.7644472424578;332.1844870842083;335.97816141950784;6480.675966201695;6485.805425837227;6539.378759017892;6559.704813283402;6590.901136482945;5163.32876726026;6525.510586705992;6527.314631963647;6532.738690452376;6532.967335163317;4565.223911934979;4664.906701865961;4689.249720044793;4779.0441911617645;4795.729131780081;4761.285807128924;4773.6897101688455;4787;4796.83211087612;4801.975990120044;4684.789184486689;4732.911430370999;4757.643176761757;4786.664933454659;4795.448523419799;4526.388937493446;4598.172328980782;4724.645651576146;4752.809887604491;4776.593989510896;3331.9666803331897;3348.2131699050706;4087.52848974369;4117.773522456264;4117.97941010296;6211.596246244025;6230.781922632731;6248.656323902183;6256.936320825471;6268.435840774307;5659.547236221092;5674.744636491368;5684.175794509814;5707.857303567403;5738.942610573882;5523.861903452405;6884.65576721167;6886.51794374394;6891.27641597635;6893.689783959734;4281.657467402601;4464.843730469418;4483.753393563353;4489.057297967431;4492.775361231926;7163.964180179118;7272.127344718668;7277.3814225790875;7279.235680253603;7327.780166595011;4531.501534831166;4531.660125490602;4532.841350552781;4545.477270113913;4547.977260113678;3724.7951362675312;4560.475545312332;4564.155631208171;4567.314902764546;4568.954310456853;5429.592780541475;5442.863928401822;5451.318585176853;5460;5462.481064298885;5351;6890.276520965327;6910;6917.308269173042;6977.686004129826;1578.8342224066307;1582.485692150056;1598.20888660114;1602.6954878573267;1603.4307820723475;960.6973803251954;1010.9696709098739;1018.674024312213;1034.8602938603342;1042.1142029275056;6258.061290806416;6346.2067241594805;6506.186726659168;6506.60960342381;6584.189347929358;7169;7179.605121718251;7285.854282914312;7295.963520182365;7308.269173082649;6571.31001244872;6574.145361103026;6577.638229897401;6584.30864759203;6596.439302659328;3764.849406023783;3821.102041020358;3830.693544516432;3833.769973801581;3845.8653947111716;7226.494145409771;7594.8101297468;7604.353629941406;7607.049118860143;7616.04799400075;5855.887381397521;7038.979347994512;7426.108866936002;7486.663100160506;7494.213107623621;6024.277086749618;7526.736564220226;7535.284148005821;7578.355839753683;7606.619669016527;7184.1019872515935;7218.097737782778;7222.458315626244;7231.819204519929;7257.637118143966;6724.798256052326;7006.929930700831;7023.403010744144;7025.297470252934;7063.328983746535;7523.623818808928;7576.924230757621;7597.050368703912;7601.581912994839;7610.162882083077;4692.906141877075;4765.404324459442;4774.4509381421585;4775.71345719258;4782.402199725035;5514.558835293247;6660.533762636569;7064.116985376828;7093.574385536885;7118.394936430462;6630.187048098189;6795.830104247433;6840.760573379908;6858.4856135791015;6865.759698410531;6770.96614516944;6807.625580593115;6810.965945170243;6810.965945170243;6829.453643708392;6682;6692.899606506004;6699.5310328276555;6707.5975441473665;6713.56361836479;5593.965116453469;6554.246261679968;6849.691763870538;6867.725290988305;6888.070110535214;6439.549231553746;6675.566088204251;6723.226828914738;6724.630145342053;6747.6626168692355 04:50:02 INFO - PROCESS | 1665 | |5;yui.html;748.6107224243397;754.2231501553398;759.9278068583486;768.139683554419;771.8109063279497;14871.405143794249;15128.697426051473;15151.469698560553;15155.166465844373;15186.696266074685;13883.167009979408;13915.721685566308;13975;13984.930075349608;13985.300734963263;739.9825240294595;749.0412272291449;913.8720579118946;926.7080869526078;946.0586716217373;926.1988380051274;928.2805825485235;936.8173206224789;936.976575585609;941.2799208605422;981.7790997025647;993.170702463444;993.9850902236473;994.527599390291;994.8358520844088;772.2123434097217;779.3687113438104;781.2656103262972;960.8894977077656;982.6953644370196;737.0565675934812;739.4380270994029;739.5156172706886;739.8446326271489;741.4957828676498;14872.256387180705;14963.177025263607;14981;14997.400103995828;15033.624159395993;12371.195872268274;12407.193532420364;12472.251664900135;12583.874161258453;12761.55334563295;10032.347897386646;10169.9491502542;10245.64140255095;10403.791924161475;10849.037770502235;3458.757886947915;3514;3532.8056956867363;3584.9283014339826;3785;64820.67589662068;79827;81312.59343703302;82067;83010.58494707548;9438.24494040489;9448;9627.56675949584;9666.613335466644;9803.803923921625;21823.236186733706;21937;22087.33737987863;22210.777892221195;22355.66466503004;7544.962275188699;7578.280063393969;7618.085829700472;7640.69437222516;7751.573663448452;3852.5954774748807;4140.171965606891;4140.254754144223;4209.473815773028;4429.889252768642;3566.661167189113;3576.195356044921;3576.8748093816594;3623.0398944279787;3628.564572251294;651.680676468527;658.2726087673148;660.6168422315046;671.8488340123433;675.7567275780715;581.4563383236688;588.3821986913723;592.3158751641861;595.8152972578514;608.9117078023662;6642.900356494656;8202.425830191829;8234.505929644241;8395;8447.704330348408;520.3339725151736;557.5985290590768;564.1525587287814;582.1782178217821;620.4230066038627;3785.7539259948016;3796.8101594920145;3812.14226798968;3837.750546214543;3910.8240129194255;88373;94361;94533.5273323629;95768;95921.0407895926;78698;81550.77673834897;81790;81949.59025204837;82975;62689;67536.6623166881;70882.22794430077;70946.64526677334;71313.64343178355;7680.462367634212;7703;7942.007249093864;7966.522008679498;8017;48446.788830279525;49081.50918490769;49946.50053499564;50129.74935125447;51260.46218613448;52150.47849521608;59449.51376215629;64669.67665161644;65281.69436611336;69989.30010699827;10782.946085269523;11134.053605443629;11209.71975700614;11449.484773185393;11920.701982450508;12024.098192635762;12078.39608019578;12146.331951742739;12331.568395106127;12333.260004399765;11594.304341739522;11641;11672.182947193614;11941;12003.75992480163;11686.532538698357;11690.357030363411;11874.990625796558;11877.287362758263;12037.699057523281;9386.812263754824;10955.671329860117;11075.05862001739;11127.666170014912;12194.57318993831;9509.334346595948;9546.379485333431;9957.551910164206;10002.048371544784;10118.949405252926;8867.911320886966;9624.711258662252;9705.708828735149;9764.170045545923;9769.364991275545 04:50:02 INFO - PROCESS | 1665 | __end_tp_report 04:50:02 INFO - PROCESS | 1665 | __start_cc_report 04:50:02 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1035 04:50:02 INFO - PROCESS | 1665 | __end_cc_report 04:50:02 INFO - PROCESS | 1665 | __startTimestamp1457355002670__endTimestamp 04:50:02 INFO - PROCESS | 1665 | 04:50:02 INFO - PROCESS | 1665 | ------- Summary: start ------- 04:50:02 INFO - PROCESS | 1665 | Number of tests: 6 04:50:02 INFO - PROCESS | 1665 | 04:50:02 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5688.20 Median:5978.49 stddev:625.61 (10.5%) stddev-sans-first:601.02 04:50:02 INFO - PROCESS | 1665 | Values: 3391.4 3404.6 3435.6 3441.4 3456.0 5490.9 5519.9 5523.3 5561.9 5651.0 5751.3 5780.2 5800.6 5869.8 5905.8 5076.2 5115.9 5121.1 5158.6 5226.0 5276.2 5284.0 5313.9 5338.5 5350.5 5068.2 5086.3 5173.7 5210.0 5214.5 5170.3 5182.7 5183.6 5183.8 5206.5 5109.7 5127.6 5135.8 5140.1 5150.8 5494.0 5602.8 5636.7 5656.8 5671.3 6082.4 6085.5 6091.7 6102.1 6107.5 6069.2 6139.2 6140.1 6141.1 6141.7 5660.7 5770.6 5778.6 5864.0 5872.3 6253.0 6261.8 6272.3 6284.1 6285.9 5996.8 6006.2 6042.0 6083.2 6087.1 4606.3 6109.5 6156.8 6163.4 6164.2 6138.4 6141.5 6143.9 6144.2 6153.9 6098.3 6105.7 6111.7 6130.1 6153.3 4810.3 4823.2 4853.9 4856.1 4871.5 4378.0 4405.8 4418.4 4425.8 4433.6 5633.0 5695.1 5722.2 5724.2 5742.7 6076.6 6137.6 6142.4 6146.0 6152.1 5748.8 5782.1 5792.9 5828.8 5831.7 5341.9 5353.9 5364.7 5365.5 5379.2 6343.5 6344.7 6347.4 6362.2 6368.2 6096.1 6098.9 6141.8 6145.4 6155.5 6306.5 6330.9 6340.7 6355.3 6421.3 6062.3 6062.7 6068.8 6075.8 6085.2 6088.8 6100.3 6101.6 6106.8 6138.1 5020.3 6041.6 6059.5 6062.7 6091.2 6041.5 6056.6 6064.5 6073.0 6079.1 5872.1 5874.4 5978.5 5978.6 6010.9 5102.4 6026.9 6031.2 6040.5 6049.9 5972.7 5976.3 5984.3 5989.0 5998.4 04:50:02 INFO - PROCESS | 1665 | 04:50:02 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:60233.80 Median:37841.84 stddev:125026.09 (330.4%) stddev-sans-first:125296.28 04:50:02 INFO - PROCESS | 1665 | Values: 459.5 461.5 536.8 613.8 641.4 36907.0 37792.2 37814.6 37857.9 38085.4 42939.1 43636.9 43729.8 43749.3 43750.3 9601.7 9845.8 9846.5 9855.0 9861.0 9552.4 9696.1 9701.0 9708.7 9723.4 9654.5 9720.7 9723.0 9735.0 9735.3 9647.2 9701.0 9705.9 9709.0 9712.1 9534.8 9565.3 9687.2 9688.0 9694.4 40401.8 40703.4 40769.8 40818.8 40821.4 3184.2 3324.5 3401.8 3628.3 3798.0 28040.7 29282.6 29728.0 29857.9 29951.7 2355.7 2765.6 2779.9 2834.8 2858.2 464929.0 495229.0 497103.0 497224.5 497463.0 44625.9 45072.3 45106.8 62599.0 62774.1 43778.1 43974.6 43991.6 44077.7 44080.6 15629.0 15778.5 15796.3 15802.4 15816.7 12727.6 12800.7 12802.4 12803.9 12842.4 14554.0 14595.0 14617.0 14642.6 14785.3 6211.9 6359.2 6378.5 6384.1 6406.9 961.8 970.0 973.4 981.4 1012.2 23441.9 28291.9 28715.9 29009.8 29636.0 948.7 1079.3 1106.4 1151.3 1162.2 14656.5 14778.6 15072.5 15118.9 15122.9 529021.0 530170.9 533326.0 533883.0 534088.0 57696.1 58174.4 58201.4 58246.1 58284.4 1337.7 1457.5 1470.1 1493.9 1502.9 25398.6 26586.7 27859.4 28400.1 29190.7 45637.5 46881.8 46980.8 47098.3 47119.0 369533.0 371469.0 372707.0 373485.0 375225.0 32320.0 33035.7 33615.5 33617.7 33661.2 44532.9 44574.3 44689.3 44953.8 45958.1 29823.0 34617.0 36992.4 37825.8 37905.8 35994.3 36431.8 36643.5 37000.8 37007.6 35609.9 35850.1 36163.6 36903.7 36973.9 31312.4 31908.8 32083.4 32092.0 32240.4 23466.0 24128.7 24440.1 24467.3 24475.7 04:50:02 INFO - PROCESS | 1665 | 04:50:02 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:32226.69 Median:2208.33 stddev:91124.82 (4126.4%) stddev-sans-first:91349.04 04:50:02 INFO - PROCESS | 1665 | Values: 360.4 362.8 364.9 374.0 374.9 19845.0 20332.4 20840.5 21027.3 21232.9 20341.1 20382.4 21158.0 21182.0 21424.6 5869.3 6020.8 6074.8 6084.9 6114.6 5820.3 5854.3 5949.3 5999.1 6009.1 5914.3 5943.5 5946.9 5959.6 5967.8 5644.5 5923.1 5949.0 5964.1 5967.7 5111.4 5150.8 5154.5 5157.1 5158.9 25344.6 25795.5 26081.8 26185.2 26204.5 2175.6 2184.7 2197.7 2219.0 2831.3 14596.3 14792.3 14961.6 15353.2 15386.4 1712.3 1726.0 1735.0 1748.0 1770.9 64036.4 76343.9 83635.6 85595.6 104975.0 10773.6 10824.1 10900.7 10948.9 10971.4 11893.6 12150.9 12185.5 12202.2 12203.1 7802.5 7853.9 8514.4 8649.5 8875.8 8709.5 9078.0 9121.7 9142.7 9161.4 5568.9 6297.1 6297.1 6299.8 6310.3 1780.2 1842.3 1846.3 1856.4 1876.2 861.8 881.6 970.9 982.5 1040.9 20315.4 20917.0 21048.6 21229.3 21483.8 814.4 958.3 975.5 977.8 1022.3 10239.5 10462.7 10575.8 10747.8 10758.4 465966.0 471191.0 504803.0 637569.0 637575.0 115881.4 116031.0 117315.4 124250.1 128630.4 1014.3 1068.5 1101.7 1116.6 1122.3 15813.6 17833.6 17980.7 18181.3 18405.8 50180.2 51617.0 52020.7 52383.7 53721.0 51005.0 68216.3 74326.6 74585.3 77611.2 7766.6 7957.0 8123.1 8133.4 8277.1 12484.6 13133.5 13201.8 13483.0 13554.3 11264.2 11546.6 11567.5 11837.5 11855.9 11290.8 11429.6 11532.3 11688.2 11769.6 11612.8 11737.6 11791.6 11923.0 11949.3 7850.9 7965.9 8018.3 8235.4 8380.1 11030.6 11584.3 11598.9 11739.8 11868.9 04:50:02 INFO - PROCESS | 1665 | 04:50:02 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5992.84 Median:5531.90 stddev:3145.73 (56.9%) stddev-sans-first:3135.89 04:50:02 INFO - PROCESS | 1665 | Values: 1434.4 1560.1 1585.3 1868.3 2018.2 7976.4 8487.5 8640.7 8644.8 8705.0 7247.3 8354.7 8632.2 8645.7 8651.9 2163.7 2420.3 2448.7 2453.3 2460.2 2399.4 2474.7 2483.1 2483.2 2488.3 2123.2 2471.7 2474.2 2478.6 2486.1 2402.5 2435.2 2450.3 2453.5 2458.2 2414.7 2429.8 2442.9 2457.7 2468.8 8738.3 8790.6 8812.7 8816.1 8826.9 5398.8 5535.8 5558.9 5578.4 5580.8 3597.3 3693.4 3754.2 3754.9 3764.8 935.1 1028.4 1046.4 1057.0 1067.2 11870.6 11878.6 11905.7 11905.9 11910.9 4780.4 4863.4 4961.0 4982.0 4984.3 9840.9 9857.9 10138.0 10145.8 10153.0 5010.4 5528.9 5531.0 5532.8 5554.6 4597.0 4825.0 4962.4 4966.1 4975.9 3844.8 3939.1 3952.8 3987.8 4013.2 1305.9 1316.5 1318.8 1328.9 1331.7 1367.0 1368.8 1393.7 1409.8 1420.4 8184.2 8211.8 8230.8 8249.0 8269.4 507.7 508.7 511.1 513.9 515.3 6111.4 6181.1 6226.6 6249.7 6269.7 10240.3 10512.7 10591.1 10615.3 10658.5 10056.9 10325.7 10451.6 10495.3 10495.6 8210.4 8228.8 8236.6 8279.1 8329.4 7729.1 7765.7 7769.3 7979.2 7993.4 7783.5 9112.9 9311.8 9373.0 9506.1 9525.8 9568.9 9682.3 9793.9 9847.9 6773.2 6798.8 7366.8 7394.9 7505.7 8151.1 8157.0 8202.6 8205.8 8226.2 7164.7 7255.2 7287.5 7387.0 7479.7 6794.4 7199.6 7230.7 7258.7 7267.3 7617.3 7659.5 7711.3 7803.2 7812.3 6944.0 7027.2 7027.5 7029.0 7031.1 6911.6 7076.9 7079.0 7093.2 7098.2 04:50:02 INFO - PROCESS | 1665 | 04:50:02 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:5621.05 Median:6496.00 stddev:1807.63 (27.8%) stddev-sans-first:1768.39 04:50:02 INFO - PROCESS | 1665 | Values: 321.1 327.4 331.8 332.2 336.0 6480.7 6485.8 6539.4 6559.7 6590.9 5163.3 6525.5 6527.3 6532.7 6533.0 4565.2 4664.9 4689.2 4779.0 4795.7 4761.3 4773.7 4787.0 4796.8 4802.0 4684.8 4732.9 4757.6 4786.7 4795.4 4526.4 4598.2 4724.6 4752.8 4776.6 3332.0 3348.2 4087.5 4117.8 4118.0 6211.6 6230.8 6248.7 6256.9 6268.4 5659.5 5674.7 5684.2 5707.9 5738.9 5523.9 6884.7 6886.5 6891.3 6893.7 4281.7 4464.8 4483.8 4489.1 4492.8 7164.0 7272.1 7277.4 7279.2 7327.8 4531.5 4531.7 4532.8 4545.5 4548.0 3724.8 4560.5 4564.2 4567.3 4569.0 5429.6 5442.9 5451.3 5460.0 5462.5 5351.0 6890.3 6910.0 6917.3 6977.7 1578.8 1582.5 1598.2 1602.7 1603.4 960.7 1011.0 1018.7 1034.9 1042.1 6258.1 6346.2 6506.2 6506.6 6584.2 7169.0 7179.6 7285.9 7296.0 7308.3 6571.3 6574.1 6577.6 6584.3 6596.4 3764.8 3821.1 3830.7 3833.8 3845.9 7226.5 7594.8 7604.4 7607.0 7616.0 5855.9 7039.0 7426.1 7486.7 7494.2 6024.3 7526.7 7535.3 7578.4 7606.6 7184.1 7218.1 7222.5 7231.8 7257.6 6724.8 7006.9 7023.4 7025.3 7063.3 7523.6 7576.9 7597.1 7601.6 7610.2 4692.9 4765.4 4774.5 4775.7 4782.4 5514.6 6660.5 7064.1 7093.6 7118.4 6630.2 6795.8 6840.8 6858.5 6865.8 6771.0 6807.6 6811.0 6811.0 6829.5 6682.0 6692.9 6699.5 6707.6 6713.6 5594.0 6554.2 6849.7 6867.7 6888.1 6439.5 6675.6 6723.2 6724.6 6747.7 04:50:02 INFO - PROCESS | 1665 | 04:50:02 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:18213.80 Median:602.36 stddev:25553.34 (4242.2%) stddev-sans-first:25591.37 04:50:02 INFO - PROCESS | 1665 | Values: 748.6 754.2 759.9 768.1 771.8 14871.4 15128.7 15151.5 15155.2 15186.7 13883.2 13915.7 13975.0 13984.9 13985.3 740.0 749.0 913.9 926.7 946.1 926.2 928.3 936.8 937.0 941.3 981.8 993.2 994.0 994.5 994.8 772.2 779.4 781.3 960.9 982.7 737.1 739.4 739.5 739.8 741.5 14872.3 14963.2 14981.0 14997.4 15033.6 12371.2 12407.2 12472.3 12583.9 12761.6 10032.3 10169.9 10245.6 10403.8 10849.0 3458.8 3514.0 3532.8 3584.9 3785.0 64820.7 79827.0 81312.6 82067.0 83010.6 9438.2 9448.0 9627.6 9666.6 9803.8 21823.2 21937.0 22087.3 22210.8 22355.7 7545.0 7578.3 7618.1 7640.7 7751.6 3852.6 4140.2 4140.3 4209.5 4429.9 3566.7 3576.2 3576.9 3623.0 3628.6 651.7 658.3 660.6 671.8 675.8 581.5 588.4 592.3 595.8 608.9 6642.9 8202.4 8234.5 8395.0 8447.7 520.3 557.6 564.2 582.2 620.4 3785.8 3796.8 3812.1 3837.8 3910.8 88373.0 94361.0 94533.5 95768.0 95921.0 78698.0 81550.8 81790.0 81949.6 82975.0 62689.0 67536.7 70882.2 70946.6 71313.6 7680.5 7703.0 7942.0 7966.5 8017.0 48446.8 49081.5 49946.5 50129.7 51260.5 52150.5 59449.5 64669.7 65281.7 69989.3 10782.9 11134.1 11209.7 11449.5 11920.7 12024.1 12078.4 12146.3 12331.6 12333.3 11594.3 11641.0 11672.2 11941.0 12003.8 11686.5 11690.4 11875.0 11877.3 12037.7 9386.8 10955.7 11075.1 11127.7 12194.6 9509.3 9546.4 9957.6 10002.0 10118.9 8867.9 9624.7 9705.7 9764.2 9769.4 04:50:02 INFO - PROCESS | 1665 | -------- Summary: end -------- 04:50:02 INFO - PROCESS | 1665 | 04:50:03 INFO - TEST-INFO | 1665: exit 0 04:50:03 INFO - TEST-OK | dromaeo_css | took 1113081ms 04:50:03 INFO - TEST-START | kraken 04:50:03 INFO - operating with platform_type : mac_ 04:50:03 INFO - Initialising browser for kraken test... 04:50:03 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpjM742q/profile http://localhost:49275/getInfo.html) 04:50:05 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 04:50:05 INFO - PROCESS | 1672 | colorDepth:24 04:50:05 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 04:50:05 INFO - PROCESS | 1672 | __metrics 04:50:05 INFO - PROCESS | 1672 | 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" 04:50:05 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:06 INFO - TEST-INFO | 1672: exit 0 04:50:06 INFO - Browser initialized. 04:50:06 INFO - Running cycle 1/1 for kraken test... 04:50:06 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/T/tmpjM742q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:17 INFO - PROCESS | 1674 | RSS: Main: 245792768 04:50:17 INFO - PROCESS | 1674 | 04:50:20 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:21 INFO - PROCESS | 1674 | RSS: Main: 290316288 04:50:21 INFO - PROCESS | 1674 | 04:50:23 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 04:50:24 INFO - PROCESS | 1674 | RSS: Main: 301244416 04:50:24 INFO - PROCESS | 1674 | 04:50:27 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 04:50:28 INFO - PROCESS | 1674 | RSS: Main: 285208576 04:50:28 INFO - PROCESS | 1674 | 04:50:30 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 04:50:30 INFO - PROCESS | 1674 | RSS: Main: 288636928 04:50:30 INFO - PROCESS | 1674 | 04:50:32 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:33 INFO - PROCESS | 1674 | RSS: Main: 290267136 04:50:33 INFO - PROCESS | 1674 | 04:50:36 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 04:50:36 INFO - PROCESS | 1674 | RSS: Main: 290521088 04:50:36 INFO - PROCESS | 1674 | 04:50:39 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 04:50:40 INFO - PROCESS | 1674 | RSS: Main: 289820672 04:50:40 INFO - PROCESS | 1674 | 04:50:42 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 04:50:43 INFO - PROCESS | 1674 | RSS: Main: 289353728 04:50:43 INFO - PROCESS | 1674 | 04:50:45 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:50:45 INFO - PROCESS | 1674 | RSS: Main: 325083136 04:50:45 INFO - PROCESS | 1674 | 04:50:47 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:50:48 INFO - PROCESS | 1674 | RSS: Main: 323674112 04:50:48 INFO - PROCESS | 1674 | 04:50:50 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:50:50 INFO - PROCESS | 1674 | RSS: Main: 331345920 04:50:50 INFO - PROCESS | 1674 | 04:50:53 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:50:53 INFO - PROCESS | 1674 | RSS: Main: 334700544 04:50:53 INFO - PROCESS | 1674 | 04:50:56 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:50:57 INFO - PROCESS | 1674 | RSS: Main: 334057472 04:50:57 INFO - PROCESS | 1674 | 04:50:58 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 04:50:59 INFO - PROCESS | 1674 | RSS: Main: 393973760 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - PROCESS | 1674 | __start_tp_report 04:50:59 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 04:50:59 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 04:50:59 INFO - PROCESS | 1674 | |i|pagename|runs| 04:50:59 INFO - PROCESS | 1674 | |0;ai-astar;111;112;111;111;111;111;113;111;109;110 04:50:59 INFO - PROCESS | 1674 | |1;audio-beat-detection;155;118;142;155;117;152;167;145;184;117 04:50:59 INFO - PROCESS | 1674 | |2;audio-dft;183;185;185;184;185;185;184;186;180;182 04:50:59 INFO - PROCESS | 1674 | |3;audio-fft;85;106;115;105;57;57;58;79;91;81 04:50:59 INFO - PROCESS | 1674 | |4;audio-oscillator;96;97;129;79;77;80;117;77;78;112 04:50:59 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;87;85;87;84;86;83;87;84;87;84 04:50:59 INFO - PROCESS | 1674 | |6;imaging-darkroom;93;92;93;93;92;92;106;148;93;93 04:50:59 INFO - PROCESS | 1674 | |7;imaging-desaturate;85;86;86;85;85;86;85;84;86;84 04:50:59 INFO - PROCESS | 1674 | |8;json-parse-financial;56;56;55;54;55;54;53;63;70;72 04:50:59 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;64;66;72;74;70;68;67;68;69;68 04:50:59 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;84;80;83;80;83;82;82;82;83;80 04:50:59 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;122;127;125;121;132;127;128;107;129;121 04:50:59 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;139;164;124;164;171;136;139;139;138;136 04:50:59 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;67;68;65;66;69;67;68;67;66;67 04:50:59 INFO - PROCESS | 1674 | __end_tp_report 04:50:59 INFO - PROCESS | 1674 | __start_cc_report 04:50:59 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1205 04:50:59 INFO - PROCESS | 1674 | __end_cc_report 04:50:59 INFO - PROCESS | 1674 | __startTimestamp1457355059018__endTimestamp 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - PROCESS | 1674 | ------- Summary: start ------- 04:50:59 INFO - PROCESS | 1674 | Number of tests: 14 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:1.05 (0.9%) stddev-sans-first:1.12 04:50:59 INFO - PROCESS | 1674 | Values: 111.0 112.0 111.0 111.0 111.0 111.0 113.0 111.0 109.0 110.0 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:153.50 stddev:22.51 (14.7%) stddev-sans-first:23.59 04:50:59 INFO - PROCESS | 1674 | Values: 155.0 118.0 142.0 155.0 117.0 152.0 167.0 145.0 184.0 117.0 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:183.90 Median:185.00 stddev:1.79 (1.0%) stddev-sans-first:1.87 04:50:59 INFO - PROCESS | 1674 | Values: 183.0 185.0 185.0 184.0 185.0 185.0 184.0 186.0 180.0 182.0 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:83.40 Median:68.50 stddev:21.34 (31.2%) stddev-sans-first:22.63 04:50:59 INFO - PROCESS | 1674 | Values: 85.0 106.0 115.0 105.0 57.0 57.0 58.0 79.0 91.0 81.0 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:78.50 stddev:19.28 (24.6%) stddev-sans-first:20.44 04:50:59 INFO - PROCESS | 1674 | Values: 96.0 97.0 129.0 79.0 77.0 80.0 117.0 77.0 78.0 112.0 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.50 stddev:1.58 (1.8%) stddev-sans-first:1.56 04:50:59 INFO - PROCESS | 1674 | Values: 87.0 85.0 87.0 84.0 86.0 83.0 87.0 84.0 87.0 84.0 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:93.00 stddev:17.56 (18.9%) stddev-sans-first:18.46 04:50:59 INFO - PROCESS | 1674 | Values: 93.0 92.0 93.0 93.0 92.0 92.0 106.0 148.0 93.0 93.0 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.50 stddev:0.79 (0.9%) stddev-sans-first:0.83 04:50:59 INFO - PROCESS | 1674 | Values: 85.0 86.0 86.0 85.0 85.0 86.0 85.0 84.0 86.0 84.0 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:56.00 stddev:7.00 (12.5%) stddev-sans-first:7.36 04:50:59 INFO - PROCESS | 1674 | Values: 56.0 56.0 55.0 54.0 55.0 54.0 53.0 63.0 70.0 72.0 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.50 stddev:2.88 (4.2%) stddev-sans-first:2.52 04:50:59 INFO - PROCESS | 1674 | Values: 64.0 66.0 72.0 74.0 70.0 68.0 67.0 68.0 69.0 68.0 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.50 stddev:1.45 (1.8%) stddev-sans-first:1.32 04:50:59 INFO - PROCESS | 1674 | Values: 84.0 80.0 83.0 80.0 83.0 82.0 82.0 82.0 83.0 80.0 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:127.00 stddev:6.95 (5.5%) stddev-sans-first:7.34 04:50:59 INFO - PROCESS | 1674 | Values: 122.0 127.0 125.0 121.0 132.0 127.0 128.0 107.0 129.0 121.0 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:139.00 stddev:15.48 (11.1%) stddev-sans-first:16.27 04:50:59 INFO - PROCESS | 1674 | Values: 139.0 164.0 124.0 164.0 171.0 136.0 139.0 139.0 138.0 136.0 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.15 (1.7%) stddev-sans-first:1.22 04:50:59 INFO - PROCESS | 1674 | Values: 67.0 68.0 65.0 66.0 69.0 67.0 68.0 67.0 66.0 67.0 04:50:59 INFO - PROCESS | 1674 | -------- Summary: end -------- 04:50:59 INFO - PROCESS | 1674 | 04:50:59 INFO - TEST-INFO | 1674: exit 0 04:50:59 INFO - TEST-OK | kraken | took 56524ms 04:50:59 INFO - SUITE-END | took 1169s 04:51:00 INFO - Completed test suite (00:19:30) 04:51:00 INFO - javascript benchmark 04:51:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3391.4065038618237, 3404.574428196476, 3435.5877294724637, 3441.432163692991, 3456.0495863637498, 5490.945090549093, 5519.9172012419795, 5523.309586301717, 5561.860953476165, 5650.971745141269, 5751.338596061454, 5780.248567686195, 5800.622959507639, 5869.823905282838, 5905.793297234598, 5076.213186956028, 5115.9488405116035, 5121.078205922932, 5158.561522270612, 5225.973870130644, 5276.234945932837, 5284.048871203182, 5313.8937221255555, 5338.546223571001, 5350.5452036576935, 5068.1890897456415, 5086.287919691246, 5173.741312934357, 5209.973950130225, 5214.504622060898, 5170.276161337416, 5182.7408629568745, 5183.637145399824, 5183.766730497099, 5206.479352064801, 5109.744512774384, 5127.6154288428515, 5135.794568217267, 5140.074786538422, 5150.793968241266, 5493.972530137324, 5602.831915042555, 5636.71816409182, 5656.802011929604, 5671.319441667027, 6082.422169893853, 6085.452309292141, 6091.725872335711, 6102.054181601814, 6107.4503294703245, 6069.180660610849, 6139.1712118863825, 6140.140380346755, 6141.078838174265, 6141.692915354214, 5660.716964151776, 5770.567207459458, 5778.59549831512, 5863.970680146572, 5872.295324560994, 6253.0, 6261.812145635638, 6272.278687950853, 6284.057391391328, 6285.874282514415, 5996.820095397145, 6006.2191915051635, 6041.969790151109, 6083.209182806207, 6087.056506241451, 4606.262997920317, 6109.495762817132, 6156.846078848064, 6163.414475624809, 6164.229471316085, 6138.386161383915, 6141.539384546088, 6143.907841382383, 6144.201253836973, 6153.938460615426, 6098.311206366174, 6105.677094999929, 6111.680786882627, 6130.080487926757, 6153.261608606996, 4810.278458231293, 4823.2282834746975, 4853.854384368475, 4856.053069651384, 4871.5128487151715, 4378.036831896978, 4405.823767049346, 4418.381426600278, 4425.845095421645, 4433.645308375322, 5633.042382794934, 5695.117256825199, 5722.227499287626, 5724.227229323988, 5742.712864356766, 6076.574639775174, 6137.5703700741415, 6142.416470435302, 6145.955187618116, 6152.138700581922, 5748.827535173951, 5782.10377391505, 5792.94207057924, 5828.766849326064, 5831.679257640785, 5341.946580534222, 5353.9196912046355, 5364.678119312854, 5365.490278423544, 5379.246905433242, 6343.460805831463, 6344.714487848058, 6347.39699728525, 6362.236531616236, 6368.172137622079, 6096.116063170904, 6098.855844323317, 6141.84645383869, 6145.432914606747, 6155.507559395327, 6306.4639505642535, 6330.9050364245495, 6340.7463701451425, 6355.269144048493, 6421.261554921244, 6062.333143354315, 6062.696865156813, 6068.848278792889, 6075.7569697213385, 6085.208922840003, 6088.756449741961, 6100.278413292402, 6101.633901965896, 6106.847328816815, 6138.07928810682, 5020.322256495472, 6041.607295525777, 6059.515238780975, 6062.696865156637, 6091.177691011834, 6041.456268935817, 6056.57603967718, 6064.48451881595, 6072.969635151796, 6079.118527813531, 5872.148538461985, 5874.353821079592, 5978.491828194652, 5978.641281523122, 6010.942563985173, 5102.413222479462, 6026.945284575269, 6031.175835493617, 6040.486558642565, 6049.879002420015, 5972.671503067199, 5976.312724036791, 5984.341722410444, 5989.0, 5998.430149135826], "unit": "score", "name": "dojo.html", "value": 5650.112871698766}, {"lowerIsBetter": false, "replicates": [459.5496413514753, 461.4808340616806, 536.7611412921246, 613.8373331067268, 641.3874749614117, 36907.0, 37792.24415511688, 37814.62185378146, 37857.86426407205, 38085.428718569245, 42939.14121717564, 43636.909077273085, 43729.78135109328, 43749.34375984363, 43750.343744843856, 9601.711948641552, 9845.753856153618, 9846.458444785534, 9855.0, 9861.013898610117, 9552.426854388725, 9696.127348538665, 9700.951495242514, 9708.708738737814, 9723.367981081206, 9654.469004204766, 9720.659776907809, 9723.0, 9735.0, 9735.318527703064, 9647.228221742243, 9701.029897010243, 9705.854412183822, 9709.029097090304, 9712.125908668184, 9534.761630959212, 9565.330426870121, 9687.17658998986, 9688.031196880325, 9694.36986595869, 40401.787946361655, 40703.38944915828, 40769.79615101935, 40818.77543673695, 40821.38767918484, 3184.2357834119875, 3324.4680851063954, 3401.761876668634, 3628.256207477461, 3798.0125167456385, 28040.719592804016, 29282.560761588593, 29728.0, 29857.85071074631, 29951.700482995326, 2355.747578677519, 2765.5851622256623, 2779.9305017374527, 2834.829910205374, 2858.2282783648507, 464929.0, 495229.0, 497103.0, 497224.5138774319, 497463.0, 44625.88435289079, 45072.3239151413, 45106.77446612812, 62599.0, 62774.0583891242, 43778.12443751171, 43974.560254397686, 43991.56008439875, 44077.67766966996, 44080.559194407644, 15628.984116032421, 15778.526644200692, 15796.289166987513, 15802.446914357943, 15816.68366632661, 12727.618171454871, 12800.679983000313, 12802.359882006049, 12803.871961280454, 12842.357882105858, 14554.0, 14594.978351515505, 14617.049891757002, 14642.558998635312, 14785.334659940328, 6211.943969525191, 6359.17330747, 6378.521610879203, 6384.138141350858, 6406.935930640727, 961.7684579811827, 969.970900872975, 973.4208146153028, 981.4405788700373, 1012.1902478017556, 23441.882790585936, 28291.858540707166, 28715.856420717762, 29009.839606415506, 29635.96274130438, 948.7296120605595, 1079.282277285612, 1106.435717783936, 1151.2746969409386, 1162.2271189658952, 14656.487022954145, 14778.556643300719, 15072.472463463726, 15118.924405377902, 15122.924385378003, 529021.0, 530170.9354704816, 533326.0, 533883.0, 534088.0, 57696.13455798166, 58174.4182558169, 58201.417985820444, 58246.12630810541, 58284.4171558279, 1337.6856438736888, 1457.4753088887992, 1470.1399681186413, 1493.8506149384975, 1502.8647421732096, 25398.619020715072, 26586.670666466987, 27859.442811143257, 28400.147995560168, 29190.708092918798, 45637.543624564656, 46881.765591171825, 46980.83210846873, 47098.293525596455, 47119.0, 369533.0, 371469.0, 372707.0, 373485.0, 375225.0, 32320.030399088064, 33035.669643303256, 33615.495767563996, 33617.66382336145, 33661.15847103842, 44532.88667783331, 44574.3313850299, 44689.32966005448, 44953.77523112363, 45958.080838383714, 29823.0, 34617.0, 36992.44511332386, 37825.81087094547, 37905.81047094747, 35994.28011439704, 36431.817840910626, 36643.45034824533, 37000.81499592485, 37007.6299237015, 35609.93170204898, 35850.10374740652, 36163.63836361708, 36903.708370206914, 36973.89078327655, 31312.373752525276, 31908.840455797574, 32083.358332832744, 32092.0, 32240.35519289648, 23466.0, 24128.672922989404, 24440.14459493909, 24467.265982020566, 24475.66666831986], "unit": "score", "name": "ext.html", "value": 18928.99307366809}, {"lowerIsBetter": false, "replicates": [360.4377171612285, 362.84760400631734, 364.855881926639, 373.9607341229171, 374.85755412943075, 19845.0, 20332.390028299156, 20840.47898802531, 21027.264045758402, 21232.893835530802, 20341.084651190697, 20382.388528344138, 21158.047887845045, 21182.046807893643, 21424.571508569818, 5869.295684517864, 6020.759169633231, 6074.787382441616, 6084.878302433949, 6114.602550834204, 5820.272465941757, 5854.268216472941, 5949.3158286796925, 5999.1301261317085, 6009.1286763419275, 5914.319853216892, 5943.524518038546, 5946.881062378771, 5959.642421454727, 5967.8209653710455, 5644.548436125121, 5923.05231163014, 5948.970255148696, 5964.075568286922, 5967.701614919237, 5111.4121875984365, 5150.768215430315, 5154.5103215194495, 5157.097507936096, 5158.896822063538, 25344.619830702555, 25795.484090318278, 26081.826317815743, 26185.214443566725, 26204.475910481684, 2175.5540114276537, 2184.748753893291, 2197.7142971413614, 2218.9556208875892, 2831.3204830840655, 14596.34316455762, 14792.260386980608, 14961.551153465414, 15353.15557644329, 15386.384544618202, 1712.2722842791889, 1726.0334212840723, 1734.9566260843453, 1747.9825201747947, 1770.8655679447306, 64036.359636403504, 76343.85484217742, 83635.5818220911, 85595.57202213949, 104975.0, 10773.62292319765, 10824.07995320391, 10900.672979810619, 10948.890511094947, 10971.39657318839, 11893.643190704293, 12150.878491215151, 12185.45165467556, 12202.206856554296, 12203.145779795506, 7802.453828232083, 7853.8821917671285, 8514.403991720521, 8649.524276164871, 8875.822483550293, 8709.475841727799, 9078.04680508537, 9121.726348209564, 9142.725718228463, 9161.358704890727, 5568.858384031264, 6297.086922396227, 6297.149884765589, 6299.811005669837, 6310.274318453345, 1780.2078075256645, 1842.2907180735244, 1846.270723064409, 1856.378113332022, 1876.249500199931, 861.7888617288679, 881.6120906800987, 970.8592254123254, 982.5332966840837, 1040.942748148859, 20315.39053828358, 20917.0, 21048.579028419346, 21229.256976005767, 21483.78516214849, 814.3729328417086, 958.3291695812959, 975.4586204656483, 977.8386566216636, 1022.2997246885907, 10239.48802559869, 10462.738431539272, 10575.788484230427, 10747.83878241827, 10758.354498730101, 465966.0, 471191.0, 504803.0, 637569.0, 637575.0, 115881.42059289818, 116031.0, 117315.41342293404, 124250.13624795635, 128630.35684821704, 1014.2899970021015, 1068.4764465411893, 1101.6970333158285, 1116.625930313338, 1122.3097794856105, 15813.604659883595, 17833.554161146076, 17980.730289045412, 18181.272749090418, 18405.81594184041, 50180.247296289854, 51617.0, 52020.73989630028, 52383.73808130935, 53721.0, 51005.0, 68216.31783682099, 74326.62836685783, 74585.25414745783, 77611.22388776265, 7766.611669416619, 7957.0, 8123.147069557847, 8133.430659853753, 8277.089520152658, 12484.56304029391, 13133.540326088923, 13201.801972970605, 13483.0, 13554.254516001714, 11264.15518836107, 11546.59586914454, 11567.479463423997, 11837.526498939946, 11855.881441185478, 11290.830637540279, 11429.59996400122, 11532.308061516336, 11688.240264382788, 11769.588064417705, 11612.825807612724, 11737.589184378507, 11791.587294444653, 11923.046156307648, 11949.342786146846, 7850.882236766567, 7965.880511792444, 8018.3184429324165, 8235.423520353757, 8380.12008739098, 11030.558777648805, 11584.304941703525, 11598.88401115978, 11739.765204696028, 11868.93179613839], "unit": "score", "name": "jquery.html", "value": 9579.3782475956}, {"lowerIsBetter": false, "replicates": [1434.4118911246378, 1560.1419219429313, 1585.2866210205411, 1868.280711925908, 2018.2431588154452, 7976.441649084566, 8487.533185674785, 8640.74077777666, 8644.827103457927, 8705.042445331017, 7247.27527247275, 8354.707585234519, 8632.17994290543, 8645.69740059098, 8651.87022194666, 2163.707899433572, 2420.322309753272, 2448.718397384297, 2453.276283496364, 2460.2127319257843, 2399.448126930807, 2474.6906636670415, 2483.1184929350093, 2483.192962287255, 2488.30327508298, 2123.235635171337, 2471.6786817713673, 2474.2206205045354, 2478.603423452248, 2486.0552989863827, 2402.4594466245044, 2435.2329016359877, 2450.338408629678, 2453.4970331082086, 2458.1519375815315, 2414.6619473273754, 2429.757024297574, 2442.8762769126224, 2457.741937096597, 2468.8024958003316, 8738.344624153215, 8790.560471976376, 8812.69155579558, 8816.074312197192, 8826.86759698605, 5398.757055932492, 5535.806246781343, 5558.944410555923, 5578.386377498472, 5580.804671836466, 3597.2985267872778, 3693.409054551259, 3754.2491501699496, 3754.9249015019545, 3764.830582623761, 935.1256575102301, 1028.444639894456, 1046.3774054437597, 1056.984145237822, 1067.199600299775, 11870.643880683594, 11878.643640690792, 11905.702357441047, 11905.880941190564, 11910.940445297805, 4780.426348838162, 4863.416390033219, 4960.950390496048, 4981.950180498221, 4984.3021976923255, 9840.852387214198, 9857.852132218022, 10138.0, 10145.847812282822, 10153.0, 5010.398752149693, 5528.944710552923, 5530.972345138249, 5532.834014979557, 5554.611177217556, 4596.954030459719, 4824.975875120602, 4962.379702537183, 4966.081274964144, 4975.90048199034, 3844.8462061517225, 3939.1136994176654, 3952.762834229898, 3987.80060996949, 4013.1973605278476, 1305.8759417855288, 1316.5260506217753, 1318.8483324417623, 1328.9401976911063, 1331.6803967047838, 1367.0430698511082, 1368.8494265630773, 1393.7212557488542, 1409.8167238259166, 1420.3537390487304, 8184.2224988625985, 8211.8357632847, 8230.8353832923, 8248.968878890139, 8269.379796515286, 507.7359772918062, 508.6693649128096, 511.0877084404395, 513.876669599301, 515.3300709078184, 6111.35830737775, 6181.134641150243, 6226.59527130735, 6249.687515624291, 6269.65516896566, 10240.334378265388, 10512.737181570523, 10591.099756520782, 10615.256932014685, 10658.467076646137, 10056.949715251378, 10325.74185645365, 10451.581936722598, 10495.265331426726, 10495.580176792842, 8210.425270231026, 8228.753137405887, 8236.629351679068, 8279.130691277449, 8329.416940814206, 7729.149793522595, 7765.650545725343, 7769.339606133542, 7979.241972012649, 7993.400494962785, 7783.53298802051, 9112.908870911206, 9311.76720581991, 9373.0, 9506.144446999802, 9525.761855953657, 9568.942677324409, 9682.273829462678, 9793.85309220348, 9847.901520984698, 6773.187217533928, 6798.76204332846, 7366.77899663011, 7394.852102958018, 7505.662245199088, 8151.103378628465, 8157.021157461143, 8202.58987050657, 8205.753827385188, 8226.177382261725, 7164.713411463483, 7255.165655949633, 7287.526310789994, 7387.0, 7479.663415146223, 6794.3545363190415, 7199.604021778852, 7230.674619642234, 7258.673359698721, 7267.30960558746, 7617.314441700052, 7659.502132361378, 7711.305982461606, 7803.180666030212, 7812.3359514439635, 6944.0, 7027.22700502934, 7027.508074434741, 7029.0, 7031.1211098612675, 6911.5853048817235, 7076.929230707833, 7079.008938748682, 7093.184283807222, 7098.219195888345], "unit": "score", "name": "mootools.html", "value": 4823.388798732896}, {"lowerIsBetter": false, "replicates": [321.1441508380167, 327.4400774675305, 331.7644472424578, 332.1844870842083, 335.97816141950784, 6480.675966201695, 6485.805425837227, 6539.378759017892, 6559.704813283402, 6590.901136482945, 5163.32876726026, 6525.510586705992, 6527.314631963647, 6532.738690452376, 6532.967335163317, 4565.223911934979, 4664.906701865961, 4689.249720044793, 4779.0441911617645, 4795.729131780081, 4761.285807128924, 4773.6897101688455, 4787.0, 4796.83211087612, 4801.975990120044, 4684.789184486689, 4732.911430370999, 4757.643176761757, 4786.664933454659, 4795.448523419799, 4526.388937493446, 4598.172328980782, 4724.645651576146, 4752.809887604491, 4776.593989510896, 3331.9666803331897, 3348.2131699050706, 4087.52848974369, 4117.773522456264, 4117.97941010296, 6211.596246244025, 6230.781922632731, 6248.656323902183, 6256.936320825471, 6268.435840774307, 5659.547236221092, 5674.744636491368, 5684.175794509814, 5707.857303567403, 5738.942610573882, 5523.861903452405, 6884.65576721167, 6886.51794374394, 6891.27641597635, 6893.689783959734, 4281.657467402601, 4464.843730469418, 4483.753393563353, 4489.057297967431, 4492.775361231926, 7163.964180179118, 7272.127344718668, 7277.3814225790875, 7279.235680253603, 7327.780166595011, 4531.501534831166, 4531.660125490602, 4532.841350552781, 4545.477270113913, 4547.977260113678, 3724.7951362675312, 4560.475545312332, 4564.155631208171, 4567.314902764546, 4568.954310456853, 5429.592780541475, 5442.863928401822, 5451.318585176853, 5460.0, 5462.481064298885, 5351.0, 6890.276520965327, 6910.0, 6917.308269173042, 6977.686004129826, 1578.8342224066307, 1582.485692150056, 1598.20888660114, 1602.6954878573267, 1603.4307820723475, 960.6973803251954, 1010.9696709098739, 1018.674024312213, 1034.8602938603342, 1042.1142029275056, 6258.061290806416, 6346.2067241594805, 6506.186726659168, 6506.60960342381, 6584.189347929358, 7169.0, 7179.605121718251, 7285.854282914312, 7295.963520182365, 7308.269173082649, 6571.31001244872, 6574.145361103026, 6577.638229897401, 6584.30864759203, 6596.439302659328, 3764.849406023783, 3821.102041020358, 3830.693544516432, 3833.769973801581, 3845.8653947111716, 7226.494145409771, 7594.8101297468, 7604.353629941406, 7607.049118860143, 7616.04799400075, 5855.887381397521, 7038.979347994512, 7426.108866936002, 7486.663100160506, 7494.213107623621, 6024.277086749618, 7526.736564220226, 7535.284148005821, 7578.355839753683, 7606.619669016527, 7184.1019872515935, 7218.097737782778, 7222.458315626244, 7231.819204519929, 7257.637118143966, 6724.798256052326, 7006.929930700831, 7023.403010744144, 7025.297470252934, 7063.328983746535, 7523.623818808928, 7576.924230757621, 7597.050368703912, 7601.581912994839, 7610.162882083077, 4692.906141877075, 4765.404324459442, 4774.4509381421585, 4775.71345719258, 4782.402199725035, 5514.558835293247, 6660.533762636569, 7064.116985376828, 7093.574385536885, 7118.394936430462, 6630.187048098189, 6795.830104247433, 6840.760573379908, 6858.4856135791015, 6865.759698410531, 6770.96614516944, 6807.625580593115, 6810.965945170243, 6810.965945170243, 6829.453643708392, 6682.0, 6692.899606506004, 6699.5310328276555, 6707.5975441473665, 6713.56361836479, 5593.965116453469, 6554.246261679968, 6849.691763870538, 6867.725290988305, 6888.070110535214, 6439.549231553746, 6675.566088204251, 6723.226828914738, 6724.630145342053, 6747.6626168692355], "unit": "score", "name": "prototype.html", "value": 5019.947632010064}, {"lowerIsBetter": false, "replicates": [748.6107224243397, 754.2231501553398, 759.9278068583486, 768.139683554419, 771.8109063279497, 14871.405143794249, 15128.697426051473, 15151.469698560553, 15155.166465844373, 15186.696266074685, 13883.167009979408, 13915.721685566308, 13975.0, 13984.930075349608, 13985.300734963263, 739.9825240294595, 749.0412272291449, 913.8720579118946, 926.7080869526078, 946.0586716217373, 926.1988380051274, 928.2805825485235, 936.8173206224789, 936.976575585609, 941.2799208605422, 981.7790997025647, 993.170702463444, 993.9850902236473, 994.527599390291, 994.8358520844088, 772.2123434097217, 779.3687113438104, 781.2656103262972, 960.8894977077656, 982.6953644370196, 737.0565675934812, 739.4380270994029, 739.5156172706886, 739.8446326271489, 741.4957828676498, 14872.256387180705, 14963.177025263607, 14981.0, 14997.400103995828, 15033.624159395993, 12371.195872268274, 12407.193532420364, 12472.251664900135, 12583.874161258453, 12761.55334563295, 10032.347897386646, 10169.9491502542, 10245.64140255095, 10403.791924161475, 10849.037770502235, 3458.757886947915, 3514.0, 3532.8056956867363, 3584.9283014339826, 3785.0, 64820.67589662068, 79827.0, 81312.59343703302, 82067.0, 83010.58494707548, 9438.24494040489, 9448.0, 9627.56675949584, 9666.613335466644, 9803.803923921625, 21823.236186733706, 21937.0, 22087.33737987863, 22210.777892221195, 22355.66466503004, 7544.962275188699, 7578.280063393969, 7618.085829700472, 7640.69437222516, 7751.573663448452, 3852.5954774748807, 4140.171965606891, 4140.254754144223, 4209.473815773028, 4429.889252768642, 3566.661167189113, 3576.195356044921, 3576.8748093816594, 3623.0398944279787, 3628.564572251294, 651.680676468527, 658.2726087673148, 660.6168422315046, 671.8488340123433, 675.7567275780715, 581.4563383236688, 588.3821986913723, 592.3158751641861, 595.8152972578514, 608.9117078023662, 6642.900356494656, 8202.425830191829, 8234.505929644241, 8395.0, 8447.704330348408, 520.3339725151736, 557.5985290590768, 564.1525587287814, 582.1782178217821, 620.4230066038627, 3785.7539259948016, 3796.8101594920145, 3812.14226798968, 3837.750546214543, 3910.8240129194255, 88373.0, 94361.0, 94533.5273323629, 95768.0, 95921.0407895926, 78698.0, 81550.77673834897, 81790.0, 81949.59025204837, 82975.0, 62689.0, 67536.6623166881, 70882.22794430077, 70946.64526677334, 71313.64343178355, 7680.462367634212, 7703.0, 7942.007249093864, 7966.522008679498, 8017.0, 48446.788830279525, 49081.50918490769, 49946.50053499564, 50129.74935125447, 51260.46218613448, 52150.47849521608, 59449.51376215629, 64669.67665161644, 65281.69436611336, 69989.30010699827, 10782.946085269523, 11134.053605443629, 11209.71975700614, 11449.484773185393, 11920.701982450508, 12024.098192635762, 12078.39608019578, 12146.331951742739, 12331.568395106127, 12333.260004399765, 11594.304341739522, 11641.0, 11672.182947193614, 11941.0, 12003.75992480163, 11686.532538698357, 11690.357030363411, 11874.990625796558, 11877.287362758263, 12037.699057523281, 9386.812263754824, 10955.671329860117, 11075.05862001739, 11127.666170014912, 12194.57318993831, 9509.334346595948, 9546.379485333431, 9957.551910164206, 10002.048371544784, 10118.949405252926, 8867.911320886966, 9624.711258662252, 9705.708828735149, 9764.170045545923, 9769.364991275545], "unit": "score", "name": "yui.html", "value": 6927.817071133648}], "name": "dromaeo_css", "value": 7456.484569584122}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 111.0, 111.0, 111.0, 111.0, 113.0, 111.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [155.0, 118.0, 142.0, 155.0, 117.0, 152.0, 167.0, 145.0, 184.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [183.0, 185.0, 185.0, 184.0, 185.0, 185.0, 184.0, 186.0, 180.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.9}, {"lowerIsBetter": true, "replicates": [85.0, 106.0, 115.0, 105.0, 57.0, 57.0, 58.0, 79.0, 91.0, 81.0], "unit": "score", "name": "audio-fft", "value": 83.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 129.0, 79.0, 77.0, 80.0, 117.0, 77.0, 78.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 94.2}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 87.0, 84.0, 86.0, 83.0, 87.0, 84.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.4}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 93.0, 93.0, 92.0, 92.0, 106.0, 148.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 99.5}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 85.0, 85.0, 86.0, 85.0, 84.0, 86.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.2}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 55.0, 54.0, 55.0, 54.0, 53.0, 63.0, 70.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 58.8}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 72.0, 74.0, 70.0, 68.0, 67.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [84.0, 80.0, 83.0, 80.0, 83.0, 82.0, 82.0, 82.0, 83.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [122.0, 127.0, 125.0, 121.0, 132.0, 127.0, 128.0, 107.0, 129.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.9}, {"lowerIsBetter": true, "replicates": [139.0, 164.0, 124.0, 164.0, 171.0, 136.0, 139.0, 139.0, 138.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 65.0, 66.0, 69.0, 67.0, 68.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1433.0000000000002}]} 04:51:00 INFO - Return code: 0 04:51:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:51:00 INFO - # TBPL SUCCESS # 04:51:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:51:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:51:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:51:00 INFO - 2016-03-07 04:51:00.348 screenresolution[1678:9786] starting screenresolution argv=screenresolution get 04:51:00 INFO - 2016-03-07 04:51:00.350 screenresolution[1678:9786] Display 0: 1600x1200x32@60 04:51:00 INFO - 2016-03-07 04:51:00.356 screenresolution[1679:9789] starting screenresolution argv=screenresolution list 04:51:00 INFO - Available Modes on Display 0 04:51:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:51:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:51:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:51:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:51:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:51:00 INFO - Intel Iris: 04:51:00 INFO - Chipset Model: Intel Iris 04:51:00 INFO - Type: GPU 04:51:00 INFO - Bus: Built-In 04:51:00 INFO - VRAM (Dynamic, Max): 1536 MB 04:51:00 INFO - Vendor: Intel (0x8086) 04:51:00 INFO - Device ID: 0x0a2e 04:51:00 INFO - Revision ID: 0x0009 04:51:00 INFO - Displays: 04:51:00 INFO - Display: 04:51:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:51:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:51:00 INFO - Display Serial Number: 1600x1200 60 04:51:00 INFO - Main Display: Yes 04:51:00 INFO - Mirror: Off 04:51:00 INFO - Online: Yes 04:51:00 INFO - Rotation: Supported 04:51:00 INFO - Return code: 0 04:51:00 INFO - Running post-action listener: _resource_record_post_action 04:51:00 INFO - Running post-run listener: _resource_record_post_run 04:51:01 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 38737408; Write bytes: 703587840; Read time: 420; Write time: 1976 04:51:01 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 404587008; Write bytes: 392783360; Read time: 30208; Write time: 710 04:51:01 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 31702528; Write bytes: 299110400; Read time: 331; Write time: 1231 04:51:01 INFO - Running post-run listener: _upload_blobber_files 04:51:01 INFO - Blob upload gear active. 04:51:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:01 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 04:51:01 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'] 04:51:01 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 04:51:02 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:51:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:51:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:03 INFO - (blobuploader) - INFO - Done attempting. 04:51:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:51:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:51:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:04 INFO - (blobuploader) - INFO - Done attempting. 04:51:04 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:04 INFO - Return code: 0 04:51:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/292b4807041435a9ec2f6c374debcd5e362156bd9c805ef88b52c41de6a9b485e9c2bbcffc0cf9124bc9549de3b72e6aa01b6e1361ab81b9ff22f5bd5d90fe28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8326372be83d0e6daa85f5d1b51c5d99344573564e3a014a091cd30aef95cc8758a35c94bf76855364d01d4b694de2897fff2db82fd28e59de1bbcbdccc7a875"} 04:51:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:04 INFO - Contents: 04:51:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/292b4807041435a9ec2f6c374debcd5e362156bd9c805ef88b52c41de6a9b485e9c2bbcffc0cf9124bc9549de3b72e6aa01b6e1361ab81b9ff22f5bd5d90fe28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8326372be83d0e6daa85f5d1b51c5d99344573564e3a014a091cd30aef95cc8758a35c94bf76855364d01d4b694de2897fff2db82fd28e59de1bbcbdccc7a875"} 04:51:04 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:04 INFO - Copying logs to upload dir... 04:51:04 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.945547 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-07 04:51:04.886274) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 04:51:04.893988) ========= 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.4BUsqr6rCi/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.YYGZlYJrbC/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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/292b4807041435a9ec2f6c374debcd5e362156bd9c805ef88b52c41de6a9b485e9c2bbcffc0cf9124bc9549de3b72e6aa01b6e1361ab81b9ff22f5bd5d90fe28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8326372be83d0e6daa85f5d1b51c5d99344573564e3a014a091cd30aef95cc8758a35c94bf76855364d01d4b694de2897fff2db82fd28e59de1bbcbdccc7a875"} build_url:https://queue.taskcluster.net/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010925 build_url: 'https://queue.taskcluster.net/v1/task/ePIljHO3Rjqyadzoer4mOw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/292b4807041435a9ec2f6c374debcd5e362156bd9c805ef88b52c41de6a9b485e9c2bbcffc0cf9124bc9549de3b72e6aa01b6e1361ab81b9ff22f5bd5d90fe28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8326372be83d0e6daa85f5d1b51c5d99344573564e3a014a091cd30aef95cc8758a35c94bf76855364d01d4b694de2897fff2db82fd28e59de1bbcbdccc7a875"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 04:51:04.920765) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 04:51:04.921046) ========= 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.4BUsqr6rCi/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.YYGZlYJrbC/Listeners TMPDIR=/var/folders/ll/nfr6cy655632107dm4rhqyxr00000w/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.005058 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 04:51:04.971132) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 04:51:04.971401) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 04:51:04.973743) ========= ========= Total master_lag: 4.21 =========