builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0264 starttime: 1486350121.51 results: success (0) buildid: 20170205181908 builduid: ee3d9e8cc9d74abebe76246128f8f45a revision: 20a8536b0bfac74389d3a57bd8dd957d98779ce1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-05 19:02:01.513500) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-05 19:02:01.513954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-05 19:02:01.514241) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-05 19:02:01.538812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:02:01.539094) ========= 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.8ixrJK0iyO/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.WwkuqfxomI/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 --2017-02-05 19:02:01-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 70.4M=0s 2017-02-05 19:02:02 (70.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.474045 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:02:02.061078) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:02:02.061367) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8ixrJK0iyO/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.WwkuqfxomI/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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.019807 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:02:02.114148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:02:02.114512) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 20a8536b0bfac74389d3a57bd8dd957d98779ce1 --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 20a8536b0bfac74389d3a57bd8dd957d98779ce1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8ixrJK0iyO/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.WwkuqfxomI/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 2017-02-05 19:02:02,205 truncating revision to first 12 chars 2017-02-05 19:02:02,205 Setting DEBUG logging. 2017-02-05 19:02:02,205 attempt 1/10 2017-02-05 19:02:02,205 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/20a8536b0bfa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-05 19:02:02,839 unpacking tar archive at: mozilla-central-20a8536b0bfa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.905298 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:02:03.043852) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-05 19:02:03.044162) ========= script_repo_revision: 20a8536b0bfac74389d3a57bd8dd957d98779ce1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-05 19:02:03.047591) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-05 19:02:03.047854) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-05 19:02:03.067518) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-05 19:02:03.067784) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8ixrJK0iyO/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.WwkuqfxomI/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 19:02:03 INFO - MultiFileLogger online at 20170205 19:02:03 in /builds/slave/test 19:02:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:02:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:02:03 INFO - {'append_to_log': False, 19:02:03 INFO - 'base_work_dir': '/builds/slave/test', 19:02:03 INFO - 'blob_upload_branch': 'Firefox', 19:02:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:02:03 INFO - 'branch': 'Firefox', 19:02:03 INFO - 'buildbot_json_path': 'buildprops.json', 19:02:03 INFO - 'config_files': ('talos/mac_config.py',), 19:02:03 INFO - 'default_actions': ('clobber', 19:02:03 INFO - 'read-buildbot-config', 19:02:03 INFO - 'download-and-extract', 19:02:03 INFO - 'populate-webroot', 19:02:03 INFO - 'create-virtualenv', 19:02:03 INFO - 'install', 19:02:03 INFO - 'run-tests'), 19:02:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:02:03 INFO - 'download_minidump_stackwalk': True, 19:02:03 INFO - 'download_symbols': 'ondemand', 19:02:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:02:03 INFO - 'tooltool.py': '/tools/tooltool.py', 19:02:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:02:03 INFO - '/tools/misc-python/virtualenv.py')}, 19:02:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:02:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:02:03 INFO - 'installer_path': 'installer.exe', 19:02:03 INFO - 'log_level': 'info', 19:02:03 INFO - 'log_name': 'talos', 19:02:03 INFO - 'log_to_console': True, 19:02:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:02:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:02:03 INFO - 'opt_config_files': (), 19:02:03 INFO - 'pip_index': False, 19:02:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:02:03 INFO - 'cmd': ('bash', 19:02:03 INFO - '-c', 19:02:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:02:03 INFO - 'enabled': True, 19:02:03 INFO - 'halt_on_failure': False, 19:02:03 INFO - 'name': 'check_screen_resolution'},), 19:02:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:02:03 INFO - 'cmd': ('bash', 19:02:03 INFO - '-c', 19:02:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:02:03 INFO - 'enabled': True, 19:02:03 INFO - 'halt_on_failure': False, 19:02:03 INFO - 'name': 'check_screen_resolution'},), 19:02:03 INFO - 'run_cmd_checks_enabled': True, 19:02:03 INFO - 'sps_profile': False, 19:02:03 INFO - 'sps_profile_interval': 0, 19:02:03 INFO - 'suite': 'dromaeojs-e10s', 19:02:03 INFO - 'system_bits': '32', 19:02:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:02:03 INFO - 'title': 't-yosemite-r7-0264', 19:02:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:02:03 INFO - 'use_talos_json': True, 19:02:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:02:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:02:03 INFO - 'work_dir': 'build'} 19:02:03 INFO - [mozharness: 2017-02-06 03:02:03.279266Z] Running clobber step. 19:02:03 INFO - Running pre-action listener: _resource_record_pre_action 19:02:03 INFO - Running main action method: clobber 19:02:03 INFO - rmtree: /builds/slave/test/build 19:02:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:02:04 INFO - Running post-action listener: _resource_record_post_action 19:02:04 INFO - [mozharness: 2017-02-06 03:02:04.950628Z] Finished clobber step (success) 19:02:04 INFO - [mozharness: 2017-02-06 03:02:04.950799Z] Running read-buildbot-config step. 19:02:04 INFO - Running pre-action listener: _resource_record_pre_action 19:02:04 INFO - Running main action method: read_buildbot_config 19:02:04 INFO - Using buildbot properties: 19:02:04 INFO - { 19:02:04 INFO - "project": "", 19:02:04 INFO - "product": "firefox", 19:02:04 INFO - "script_repo_revision": "production", 19:02:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 19:02:04 INFO - "repository": "", 19:02:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 19:02:04 INFO - "buildid": "20170205181908", 19:02:04 INFO - "pgo_build": "False", 19:02:04 INFO - "basedir": "/builds/slave/test", 19:02:04 INFO - "buildnumber": 50, 19:02:04 INFO - "slavename": "t-yosemite-r7-0264", 19:02:04 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 19:02:04 INFO - "platform": "yosemite_r7", 19:02:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:02:04 INFO - "branch": "mozilla-central", 19:02:04 INFO - "repo_path": "mozilla-central", 19:02:04 INFO - "revision": "20a8536b0bfac74389d3a57bd8dd957d98779ce1", 19:02:04 INFO - "stage_platform": "macosx64", 19:02:04 INFO - "builduid": "ee3d9e8cc9d74abebe76246128f8f45a", 19:02:04 INFO - "slavebuilddir": "test" 19:02:04 INFO - } 19:02:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 19:02:04 INFO - Running post-action listener: _resource_record_post_action 19:02:04 INFO - [mozharness: 2017-02-06 03:02:04.954763Z] Finished read-buildbot-config step (success) 19:02:04 INFO - [mozharness: 2017-02-06 03:02:04.954898Z] Running download-and-extract step. 19:02:04 INFO - Running pre-action listener: _resource_record_pre_action 19:02:04 INFO - Running main action method: download_and_extract 19:02:04 INFO - mkdir: /builds/slave/test/build/tests 19:02:04 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:04 INFO - trying https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 19:02:04 INFO - Downloading https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 19:02:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 19:02:06 INFO - Downloaded 1199 bytes. 19:02:06 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 19:02:06 INFO - Using the following test package requirements: 19:02:06 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 19:02:06 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:02:06 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 19:02:06 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:02:06 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 19:02:06 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:02:06 INFO - u'jsshell-mac.zip'], 19:02:06 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:02:06 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 19:02:06 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 19:02:06 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:02:06 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 19:02:06 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:02:06 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 19:02:06 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:02:06 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 19:02:06 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:02:06 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 19:02:06 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:02:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 19:02:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:02:06 INFO - Fetch https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 19:02:07 INFO - Expected file size: 34850933 19:02:07 INFO - Obtained file size: 34850933 19:02:14 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:02:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 19:02:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:02:14 INFO - Fetch https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 19:02:15 INFO - Expected file size: 34850933 19:02:15 INFO - Obtained file size: 34850933 19:02:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 19:02:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:02:22 INFO - Fetch https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 19:02:23 INFO - Expected file size: 14403454 19:02:23 INFO - Obtained file size: 14403454 19:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:23 INFO - trying https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 19:02:23 INFO - Downloading https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 19:02:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 19:02:26 INFO - Downloaded 70288827 bytes. 19:02:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 19:02:26 INFO - mkdir: /builds/slave/test/properties 19:02:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:02:26 INFO - Writing to file /builds/slave/test/properties/build_url 19:02:26 INFO - Contents: 19:02:26 INFO - build_url:https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 19:02:26 INFO - Running post-action listener: _resource_record_post_action 19:02:26 INFO - Running post-action listener: set_extra_try_arguments 19:02:26 INFO - [mozharness: 2017-02-06 03:02:26.836779Z] Finished download-and-extract step (success) 19:02:26 INFO - [mozharness: 2017-02-06 03:02:26.836884Z] Running populate-webroot step. 19:02:26 INFO - Running pre-action listener: _resource_record_pre_action 19:02:26 INFO - Running main action method: populate_webroot 19:02:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:02:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:02:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:02:26 INFO - '--tppagecycles', 19:02:26 INFO - '7'], 19:02:26 INFO - 'tests': ['tsvgm']}}, 19:02:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:02:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:02:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:02:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:02:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:02:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:02:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:02:26 INFO - 'talos_options': ['--disable-e10s'], 19:02:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:02:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:02:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:02:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:02:26 INFO - 'talos_options': ['--disable-e10s'], 19:02:26 INFO - 'tests': ['damp', 'tps']}, 19:02:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:02:26 INFO - 'tests': ['damp', 'tps']}, 19:02:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:02:26 INFO - 'tests': ['dromaeo_dom']}, 19:02:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:02:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:02:26 INFO - 'tests': ['basic_compositor_video']}, 19:02:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:02:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:02:26 INFO - 'tests': ['a11yr', 19:02:26 INFO - 'ts_paint', 19:02:26 INFO - 'tpaint', 19:02:26 INFO - 'sessionrestore', 19:02:26 INFO - 'sessionrestore_no_auto_restore', 19:02:26 INFO - 'tabpaint']}, 19:02:26 INFO - 'other-e10s': {'tests': ['a11yr', 19:02:26 INFO - 'ts_paint', 19:02:26 INFO - 'tpaint', 19:02:26 INFO - 'sessionrestore', 19:02:26 INFO - 'sessionrestore_no_auto_restore', 19:02:26 INFO - 'tabpaint']}, 19:02:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:02:26 INFO - 'ts_paint', 19:02:26 INFO - 'tpaint', 19:02:26 INFO - 'sessionrestore', 19:02:26 INFO - 'sessionrestore_no_auto_restore', 19:02:26 INFO - 'tabpaint']}, 19:02:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:02:26 INFO - 'ts_paint', 19:02:26 INFO - 'tpaint', 19:02:26 INFO - 'sessionrestore', 19:02:26 INFO - 'sessionrestore_no_auto_restore', 19:02:26 INFO - 'tabpaint']}, 19:02:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:02:26 INFO - 'tests': ['a11yr', 19:02:26 INFO - 'ts_paint', 19:02:26 INFO - 'tpaint', 19:02:26 INFO - 'sessionrestore', 19:02:26 INFO - 'sessionrestore_no_auto_restore', 19:02:26 INFO - 'tabpaint']}, 19:02:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:02:26 INFO - 'tests': ['a11yr', 19:02:26 INFO - 'ts_paint', 19:02:26 INFO - 'tpaint', 19:02:26 INFO - 'sessionrestore', 19:02:26 INFO - 'sessionrestore_no_auto_restore', 19:02:26 INFO - 'tabpaint']}, 19:02:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:02:26 INFO - 'tests': ['tsvgx', 19:02:26 INFO - 'tsvgr_opacity', 19:02:26 INFO - 'tart', 19:02:26 INFO - 'tscrollx', 19:02:26 INFO - 'cart', 19:02:26 INFO - 'tsvg_static']}, 19:02:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:02:26 INFO - 'tsvgr_opacity', 19:02:26 INFO - 'tart', 19:02:26 INFO - 'tscrollx', 19:02:26 INFO - 'cart', 19:02:26 INFO - 'tsvg_static']}, 19:02:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:02:26 INFO - 'talos_options': ['--disable-e10s'], 19:02:26 INFO - 'tests': ['tp5o']}, 19:02:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:02:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:02:26 INFO - 'talos_options': ['--disable-e10s', 19:02:26 INFO - '--xperf_path', 19:02:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:02:26 INFO - 'tests': ['tp5n']}, 19:02:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:02:26 INFO - 'talos_options': ['--xperf_path', 19:02:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:02:26 INFO - 'tests': ['tp5n']}}, 19:02:26 INFO - 'talos.zip': {'path': '', 19:02:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:02:26 INFO - Running post-action listener: _resource_record_post_action 19:02:26 INFO - [mozharness: 2017-02-06 03:02:26.851321Z] Finished populate-webroot step (success) 19:02:26 INFO - [mozharness: 2017-02-06 03:02:26.851409Z] Running create-virtualenv step. 19:02:26 INFO - Running pre-action listener: _resource_record_pre_action 19:02:26 INFO - Running main action method: create_virtualenv 19:02:26 INFO - Creating virtualenv /builds/slave/test/build/venv 19:02:26 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 19:02:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:02:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:02:26 INFO - Using real prefix '/tools/python27' 19:02:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:02:27 INFO - Installing distribute.............................................................................................................................................................................................done. 19:02:30 INFO - Installing pip.................done. 19:02:30 INFO - Return code: 0 19:02:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:02:30 INFO - Reading from file tmpfile_stdout 19:02:30 INFO - Output received: 19:02:30 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:02:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:02:30 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:30 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:30 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 0x1100eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f977a48ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feccd30>, '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 0x10fdf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fec1be8>, '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.8ixrJK0iyO/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.WwkuqfxomI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 19:02:30 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 19:02:30 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 19:02:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ixrJK0iyO/Render', 19:02:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:30 INFO - 'HOME': '/Users/cltbld', 19:02:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:30 INFO - 'LOGNAME': 'cltbld', 19:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:30 INFO - 'MOZ_NO_REMOTE': '1', 19:02:30 INFO - 'NO_EM_RESTART': '1', 19:02:30 INFO - 'PAGER': '/bin/cat', 19:02:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:30 INFO - 'PWD': '/builds/slave/test', 19:02:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:30 INFO - 'SHELL': '/bin/bash', 19:02:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwkuqfxomI/Listeners', 19:02:30 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 19:02:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:30 INFO - 'USER': 'cltbld', 19:02:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:30 INFO - 'XPC_FLAGS': '0x0', 19:02:30 INFO - 'XPC_SERVICE_NAME': '0', 19:02:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:31 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 19:02:31 INFO - Cleaning up... 19:02:31 INFO - Return code: 0 19:02:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:02: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f977a48ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feccd30>, '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 0x10fdf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fec1be8>, '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.8ixrJK0iyO/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.WwkuqfxomI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 19:02: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:02: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 psutil>=3.1.1 19:02:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ixrJK0iyO/Render', 19:02:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:31 INFO - 'HOME': '/Users/cltbld', 19:02:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:31 INFO - 'LOGNAME': 'cltbld', 19:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:31 INFO - 'MOZ_NO_REMOTE': '1', 19:02:31 INFO - 'NO_EM_RESTART': '1', 19:02:31 INFO - 'PAGER': '/bin/cat', 19:02:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:31 INFO - 'PWD': '/builds/slave/test', 19:02:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:31 INFO - 'SHELL': '/bin/bash', 19:02:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwkuqfxomI/Listeners', 19:02:31 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 19:02:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:31 INFO - 'USER': 'cltbld', 19:02:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:31 INFO - 'XPC_FLAGS': '0x0', 19:02:31 INFO - 'XPC_SERVICE_NAME': '0', 19:02:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:31 INFO - Downloading/unpacking psutil>=3.1.1 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:02:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:35 INFO - Installing collected packages: psutil 19:02:35 INFO - Running setup.py install for psutil 19:02:35 INFO - building 'psutil._psutil_osx' extension 19:02:35 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 19:02:35 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 19:02:35 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 19:02:35 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 19:02:35 INFO - building 'psutil._psutil_posix' extension 19:02:35 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 19:02:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:02:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:02:36 INFO - ^ 19:02:36 INFO - 1 warning generated. 19:02:36 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 19:02:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:02:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:02:36 INFO - Successfully installed psutil 19:02:36 INFO - Cleaning up... 19:02:36 INFO - Return code: 0 19:02:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:02: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:36 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f977a48ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feccd30>, '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 0x10fdf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fec1be8>, '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.8ixrJK0iyO/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.WwkuqfxomI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 19:02:36 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.3'] in /builds/slave/test/build 19:02:36 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.3 19:02:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ixrJK0iyO/Render', 19:02:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:36 INFO - 'HOME': '/Users/cltbld', 19:02:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:36 INFO - 'LOGNAME': 'cltbld', 19:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:36 INFO - 'MOZ_NO_REMOTE': '1', 19:02:36 INFO - 'NO_EM_RESTART': '1', 19:02:36 INFO - 'PAGER': '/bin/cat', 19:02:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:36 INFO - 'PWD': '/builds/slave/test', 19:02:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:36 INFO - 'SHELL': '/bin/bash', 19:02:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwkuqfxomI/Listeners', 19:02:36 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 19:02:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:36 INFO - 'USER': 'cltbld', 19:02:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:36 INFO - 'XPC_FLAGS': '0x0', 19:02:36 INFO - 'XPC_SERVICE_NAME': '0', 19:02:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:02:39 INFO - Installing collected packages: mozsystemmonitor 19:02:39 INFO - Running setup.py install for mozsystemmonitor 19:02:39 INFO - Successfully installed mozsystemmonitor 19:02:39 INFO - Cleaning up... 19:02:39 INFO - Return code: 0 19:02:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f977a48ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feccd30>, '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 0x10fdf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fec1be8>, '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.8ixrJK0iyO/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.WwkuqfxomI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 19:02:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:02:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ixrJK0iyO/Render', 19:02:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:39 INFO - 'HOME': '/Users/cltbld', 19:02:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:39 INFO - 'LOGNAME': 'cltbld', 19:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:39 INFO - 'MOZ_NO_REMOTE': '1', 19:02:39 INFO - 'NO_EM_RESTART': '1', 19:02:39 INFO - 'PAGER': '/bin/cat', 19:02:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:39 INFO - 'PWD': '/builds/slave/test', 19:02:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:39 INFO - 'SHELL': '/bin/bash', 19:02:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwkuqfxomI/Listeners', 19:02:39 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 19:02:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:39 INFO - 'USER': 'cltbld', 19:02:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:39 INFO - 'XPC_FLAGS': '0x0', 19:02:39 INFO - 'XPC_SERVICE_NAME': '0', 19:02:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:39 INFO - Downloading/unpacking jsonschema==2.5.1 19:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:02:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:42 INFO - Downloading functools32-3.2.3-2.tar.gz 19:02:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:02:42 INFO - warning: no files found matching '*.txt' 19:02:42 INFO - no previously-included directories found matching 'build' 19:02:42 INFO - no previously-included directories found matching 'dist' 19:02:42 INFO - no previously-included directories found matching '.git*' 19:02:42 INFO - Installing collected packages: jsonschema, functools32 19:02:42 INFO - Running setup.py install for functools32 19:02:43 INFO - warning: no files found matching '*.txt' 19:02:43 INFO - no previously-included directories found matching 'build' 19:02:43 INFO - no previously-included directories found matching 'dist' 19:02:43 INFO - no previously-included directories found matching '.git*' 19:02:43 INFO - Successfully installed jsonschema functools32 19:02:43 INFO - Cleaning up... 19:02:43 INFO - Return code: 0 19:02:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:02:43 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:43 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:43 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f977a48ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feccd30>, '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 0x10fdf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fec1be8>, '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.8ixrJK0iyO/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.WwkuqfxomI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 19:02:43 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:02:43 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 functools32==3.2.3-2 19:02:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ixrJK0iyO/Render', 19:02:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:43 INFO - 'HOME': '/Users/cltbld', 19:02:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:43 INFO - 'LOGNAME': 'cltbld', 19:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:43 INFO - 'MOZ_NO_REMOTE': '1', 19:02:43 INFO - 'NO_EM_RESTART': '1', 19:02:43 INFO - 'PAGER': '/bin/cat', 19:02:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:43 INFO - 'PWD': '/builds/slave/test', 19:02:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:43 INFO - 'SHELL': '/bin/bash', 19:02:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwkuqfxomI/Listeners', 19:02:43 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 19:02:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:43 INFO - 'USER': 'cltbld', 19:02:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:43 INFO - 'XPC_FLAGS': '0x0', 19:02:43 INFO - 'XPC_SERVICE_NAME': '0', 19:02:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:02:43 INFO - Cleaning up... 19:02:43 INFO - Return code: 0 19:02:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:02:43 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:43 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:43 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 0x1100eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f977a48ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feccd30>, '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 0x10fdf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fec1be8>, '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.8ixrJK0iyO/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.WwkuqfxomI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 19:02:43 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 19:02:43 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 19:02:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ixrJK0iyO/Render', 19:02:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:43 INFO - 'HOME': '/Users/cltbld', 19:02:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:43 INFO - 'LOGNAME': 'cltbld', 19:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:43 INFO - 'MOZ_NO_REMOTE': '1', 19:02:43 INFO - 'NO_EM_RESTART': '1', 19:02:43 INFO - 'PAGER': '/bin/cat', 19:02:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:43 INFO - 'PWD': '/builds/slave/test', 19:02:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:43 INFO - 'SHELL': '/bin/bash', 19:02:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwkuqfxomI/Listeners', 19:02:43 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 19:02:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:43 INFO - 'USER': 'cltbld', 19:02:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:43 INFO - 'XPC_FLAGS': '0x0', 19:02:43 INFO - 'XPC_SERVICE_NAME': '0', 19:02:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:43 INFO - Downloading/unpacking blobuploader==1.2.4 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02:46 INFO - Downloading blobuploader-1.2.4.tar.gz 19:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:02:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02: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 19:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:02:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:02:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:02:47 INFO - Downloading docopt-0.6.1.tar.gz 19:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:02:47 INFO - Installing collected packages: blobuploader, requests, docopt 19:02:47 INFO - Running setup.py install for blobuploader 19:02:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:02:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:02:47 INFO - Running setup.py install for requests 19:02:48 INFO - Running setup.py install for docopt 19:02:48 INFO - Successfully installed blobuploader requests docopt 19:02:48 INFO - Cleaning up... 19:02:48 INFO - Return code: 0 19:02:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02:48 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:48 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:48 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 0x1100eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f977a48ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feccd30>, '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 0x10fdf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fec1be8>, '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.8ixrJK0iyO/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.WwkuqfxomI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 19:02:48 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 19:02:48 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 19:02:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ixrJK0iyO/Render', 19:02:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:48 INFO - 'HOME': '/Users/cltbld', 19:02:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:48 INFO - 'LOGNAME': 'cltbld', 19:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:48 INFO - 'MOZ_NO_REMOTE': '1', 19:02:48 INFO - 'NO_EM_RESTART': '1', 19:02:48 INFO - 'PAGER': '/bin/cat', 19:02:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:48 INFO - 'PWD': '/builds/slave/test', 19:02:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:48 INFO - 'SHELL': '/bin/bash', 19:02:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwkuqfxomI/Listeners', 19:02:48 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 19:02:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:48 INFO - 'USER': 'cltbld', 19:02:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:48 INFO - 'XPC_FLAGS': '0x0', 19:02:48 INFO - 'XPC_SERVICE_NAME': '0', 19:02:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:02:48 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Qxhy9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:02:48 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-BOf0m7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:02:48 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-RxOqy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:02:49 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-pJzApA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:02:49 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-cThjQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:02:49 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-ErUYRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:02:49 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-cu4GMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:02:49 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-mj0EJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:02:49 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-GRnPza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:02:49 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-OLDohn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:02:49 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-35Gmkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:02:49 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-o6TEY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:02:50 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-kyBtrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:02:50 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-wtx7Ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:50 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-5X8aU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:02:50 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-1fYUZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:02:50 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-T2MjNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:02:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:02:50 INFO - Running setup.py install for manifestparser 19:02:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:02:50 INFO - Running setup.py install for mozcrash 19:02:50 INFO - Running setup.py install for mozdebug 19:02:50 INFO - Running setup.py install for mozdevice 19:02:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Running setup.py install for mozfile 19:02:51 INFO - Running setup.py install for mozhttpd 19:02:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Running setup.py install for mozinfo 19:02:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Running setup.py install for mozInstall 19:02:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:02:51 INFO - Running setup.py install for mozleak 19:02:51 INFO - Running setup.py install for mozlog 19:02:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:02:52 INFO - Running setup.py install for moznetwork 19:02:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:02:52 INFO - Running setup.py install for mozprocess 19:02:52 INFO - Running setup.py install for mozprofile 19:02:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:02:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:02:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:02:52 INFO - Running setup.py install for mozrunner 19:02:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:02:52 INFO - Running setup.py install for mozscreenshot 19:02:52 INFO - Running setup.py install for moztest 19:02:53 INFO - Running setup.py install for mozversion 19:02:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:02:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:02:53 INFO - Cleaning up... 19:02:53 INFO - Return code: 0 19:02:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:53 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 0x1100eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f977a48ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feccd30>, '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 0x10fdf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fec1be8>, '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.8ixrJK0iyO/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.WwkuqfxomI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 19:02:53 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 19:02:53 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 19:02:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ixrJK0iyO/Render', 19:02:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:53 INFO - 'HOME': '/Users/cltbld', 19:02:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:53 INFO - 'LOGNAME': 'cltbld', 19:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:53 INFO - 'MOZ_NO_REMOTE': '1', 19:02:53 INFO - 'NO_EM_RESTART': '1', 19:02:53 INFO - 'PAGER': '/bin/cat', 19:02:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:53 INFO - 'PWD': '/builds/slave/test', 19:02:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:53 INFO - 'SHELL': '/bin/bash', 19:02:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwkuqfxomI/Listeners', 19:02:53 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 19:02:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:53 INFO - 'USER': 'cltbld', 19:02:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:53 INFO - 'XPC_FLAGS': '0x0', 19:02:53 INFO - 'XPC_SERVICE_NAME': '0', 19:02:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:02:53 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-hBwbiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:02:53 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)) 19:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:02:53 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-MzlmLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 19:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:02:53 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-BV72Ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:02:53 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)) 19:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:02:53 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-MDFMP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 19:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:02:53 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-2AMjph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:02:54 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)) 19:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:02:54 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Q5yjPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:02:54 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)) 19:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:02:54 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Why590-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:02:54 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)) 19:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:02:54 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-EN9PkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:02:54 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)) 19:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:02:54 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-FXMfp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:02:54 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)) 19:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:02:54 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-xWNF_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 19:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:02:54 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-562Pas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:02:54 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)) 19:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:02:54 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-YquUm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 19:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:02:54 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-TF3ThV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:02:54 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)) 19:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:02:54 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-iOogUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 19:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:54 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-vMXegT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:02:55 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)) 19:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:02:55 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-PZm2yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 19:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:02:55 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Q43lPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:02:55 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)) 19:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:02:55 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)) 19:02:55 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:02:55 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:02:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:02:55 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 19:02:55 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 19:02:55 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 19:02:55 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 19:02:55 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 19:02:55 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 19:02:57 INFO - Downloading blessings-1.6.tar.gz 19:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:02:58 INFO - Installing collected packages: blessings 19:02:58 INFO - Running setup.py install for blessings 19:02:58 INFO - Successfully installed blessings 19:02:58 INFO - Cleaning up... 19:02:58 INFO - Return code: 0 19:02:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:02:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:02:58 INFO - Reading from file tmpfile_stdout 19:02:58 INFO - Current package versions: 19:02:58 INFO - blessings == 1.6 19:02:58 INFO - blobuploader == 1.2.4 19:02:58 INFO - docopt == 0.6.1 19:02:58 INFO - functools32 == 3.2.3-2 19:02:58 INFO - jsonschema == 2.5.1 19:02:58 INFO - manifestparser == 1.1 19:02:58 INFO - mozInstall == 1.12 19:02:58 INFO - mozcrash == 1.0 19:02:58 INFO - mozdebug == 0.1 19:02:58 INFO - mozdevice == 0.49 19:02:58 INFO - mozfile == 1.2 19:02:58 INFO - mozhttpd == 0.7 19:02:58 INFO - mozinfo == 0.9 19:02:58 INFO - mozleak == 0.1 19:02:58 INFO - mozlog == 3.4 19:02:58 INFO - moznetwork == 0.27 19:02:58 INFO - mozprocess == 0.24 19:02:58 INFO - mozprofile == 0.28 19:02:58 INFO - mozrunner == 6.13 19:02:58 INFO - mozscreenshot == 0.1 19:02:58 INFO - mozsystemmonitor == 0.3 19:02:58 INFO - moztest == 0.8 19:02:58 INFO - mozversion == 1.4 19:02:58 INFO - psutil == 3.1.1 19:02:58 INFO - requests == 1.2.3 19:02:58 INFO - wsgiref == 0.1.2 19:02:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:02: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:58 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 0x1100eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f977a48ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feccd30>, '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 0x10fdf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fec1be8>, '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.8ixrJK0iyO/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.WwkuqfxomI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 19:02:58 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 19:02:58 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 19:02:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ixrJK0iyO/Render', 19:02:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:58 INFO - 'HOME': '/Users/cltbld', 19:02:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:58 INFO - 'LOGNAME': 'cltbld', 19:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:58 INFO - 'MOZ_NO_REMOTE': '1', 19:02:58 INFO - 'NO_EM_RESTART': '1', 19:02:58 INFO - 'PAGER': '/bin/cat', 19:02:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:58 INFO - 'PWD': '/builds/slave/test', 19:02:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:58 INFO - 'SHELL': '/bin/bash', 19:02:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwkuqfxomI/Listeners', 19:02:58 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 19:02:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:58 INFO - 'USER': 'cltbld', 19:02:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:58 INFO - 'XPC_FLAGS': '0x0', 19:02:58 INFO - 'XPC_SERVICE_NAME': '0', 19:02:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:58 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)) 19:02:58 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)) 19:02:58 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)) 19:02:58 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)) 19:02:58 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)) 19:02:58 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)) 19:02:58 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)) 19:02:58 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)) 19:02:58 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)) 19:02:58 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)) 19:02:58 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)) 19:02:58 INFO - Cleaning up... 19:02:58 INFO - Return code: 0 19:02:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:02: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:02:58 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 0x1100eeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100f1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f977a48ac10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feccd30>, '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 0x10fdf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fec1be8>, '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.8ixrJK0iyO/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.WwkuqfxomI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 19:02:58 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 19:02:58 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 19:02:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ixrJK0iyO/Render', 19:02:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:02:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:02:58 INFO - 'HOME': '/Users/cltbld', 19:02:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:02:58 INFO - 'LOGNAME': 'cltbld', 19:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:02:58 INFO - 'MOZ_NO_REMOTE': '1', 19:02:58 INFO - 'NO_EM_RESTART': '1', 19:02:58 INFO - 'PAGER': '/bin/cat', 19:02:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:02:58 INFO - 'PWD': '/builds/slave/test', 19:02:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:02:58 INFO - 'SHELL': '/bin/bash', 19:02:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwkuqfxomI/Listeners', 19:02:58 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 19:02:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:02:58 INFO - 'USER': 'cltbld', 19:02:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:02:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:02:58 INFO - 'XPC_FLAGS': '0x0', 19:02:58 INFO - 'XPC_SERVICE_NAME': '0', 19:02:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:02:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:02:59 INFO - Cleaning up... 19:02:59 INFO - Return code: 0 19:02:59 INFO - Running post-action listener: _resource_record_post_action 19:02:59 INFO - Running post-action listener: _start_resource_monitoring 19:02:59 INFO - Starting resource monitoring. 19:02:59 INFO - [mozharness: 2017-02-06 03:02:59.106078Z] Finished create-virtualenv step (success) 19:02:59 INFO - [mozharness: 2017-02-06 03:02:59.107103Z] Running install step. 19:02:59 INFO - Running pre-action listener: _resource_record_pre_action 19:02:59 INFO - Running main action method: install 19:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:02:59 INFO - Reading from file tmpfile_stdout 19:02:59 INFO - Detecting whether we're running mozinstall >=1.0... 19:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:02:59 INFO - Reading from file tmpfile_stdout 19:02:59 INFO - Output received: 19:02:59 INFO - Usage: mozinstall [options] installer 19:02:59 INFO - Options: 19:02:59 INFO - -h, --help show this help message and exit 19:02:59 INFO - -d DEST, --destination=DEST 19:02:59 INFO - Directory to install application into. [default: 19:02:59 INFO - "/builds/slave/test"] 19:02:59 INFO - --app=APP Application being installed. [default: firefox] 19:02:59 INFO - mkdir: /builds/slave/test/build/application 19:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:03:21 INFO - Reading from file tmpfile_stdout 19:03:21 INFO - Output received: 19:03:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:03:21 INFO - Running post-action listener: _resource_record_post_action 19:03:21 INFO - [mozharness: 2017-02-06 03:03:21.534367Z] Finished install step (success) 19:03:21 INFO - [mozharness: 2017-02-06 03:03:21.534539Z] Running run-tests step. 19:03:21 INFO - Running pre-action listener: _resource_record_pre_action 19:03:21 INFO - Running main action method: run_tests 19:03:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:03:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:03:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:03:21 INFO - 2017-02-05 19:03:21.549 screenresolution[1903:16469] starting screenresolution argv=screenresolution get 19:03:21 INFO - 2017-02-05 19:03:21.551 screenresolution[1903:16469] Display 0: 1600x1200x32@60 19:03:21 INFO - 2017-02-05 19:03:21.557 screenresolution[1904:16471] starting screenresolution argv=screenresolution list 19:03:21 INFO - Available Modes on Display 0 19:03:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:03:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:03:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:03:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:03:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:03:21 INFO - Intel Iris: 19:03:21 INFO - Chipset Model: Intel Iris 19:03:21 INFO - Type: GPU 19:03:21 INFO - Bus: Built-In 19:03:21 INFO - VRAM (Dynamic, Max): 1536 MB 19:03:21 INFO - Vendor: Intel (0x8086) 19:03:21 INFO - Device ID: 0x0a2e 19:03:21 INFO - Revision ID: 0x0009 19:03:21 INFO - Displays: 19:03:21 INFO - Display: 19:03:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:03:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:03:21 INFO - Display Serial Number: 1600x1200 60 19:03:21 INFO - Main Display: Yes 19:03:21 INFO - Mirror: Off 19:03:21 INFO - Online: Yes 19:03:21 INFO - Rotation: Supported 19:03:21 INFO - Return code: 0 19:03:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:03:21 INFO - Python 2.7.3 19:03:21 INFO - Return code: 0 19:03:21 INFO - grabbing minidump binary from tooltool 19:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:03:21 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10feccd30>, '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 0x10fdf3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fec1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:03:21 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 19:03:21 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 19:03:21 INFO - Calling ['/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'] with output_timeout 600 19:03:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:03:21 INFO - Return code: 0 19:03:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:03:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:03:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:03:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:03:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:03:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0264', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0264 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:03:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8ixrJK0iyO/Render', 19:03:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:03:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:03:21 INFO - 'HOME': '/Users/cltbld', 19:03:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:03:21 INFO - 'LOGNAME': 'cltbld', 19:03:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:03:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:21 INFO - 'MOZ_NO_REMOTE': '1', 19:03:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:03:21 INFO - 'NO_EM_RESTART': '1', 19:03:21 INFO - 'PAGER': '/bin/cat', 19:03:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:21 INFO - 'PWD': '/builds/slave/test', 19:03:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:03:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:03:21 INFO - 'SHELL': '/bin/bash', 19:03:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WwkuqfxomI/Listeners', 19:03:21 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 19:03:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:03:21 INFO - 'USER': 'cltbld', 19:03:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:03:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:21 INFO - 'XPC_FLAGS': '0x0', 19:03:21 INFO - 'XPC_SERVICE_NAME': '0', 19:03:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:03:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0264', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:03:22 INFO - mozversion application_buildid: 20170205181908 19:03:22 INFO - mozversion application_changeset: 20a8536b0bfac74389d3a57bd8dd957d98779ce1 19:03:22 INFO - mozversion application_display_name: Nightly 19:03:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:03:22 INFO - mozversion application_name: Firefox 19:03:22 INFO - mozversion application_remotingname: firefox 19:03:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:03:22 INFO - mozversion application_vendor: Mozilla 19:03:22 INFO - mozversion application_version: 54.0a1 19:03:22 INFO - mozversion platform_buildid: 20170205181908 19:03:22 INFO - mozversion platform_changeset: 20a8536b0bfac74389d3a57bd8dd957d98779ce1 19:03:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:03:22 INFO - mozversion platform_version: 54.0a1 19:03:22 INFO - using testdate: 1486350202 19:03:22 INFO - actual date: 1486350202 19:03:22 INFO - starting webserver on 'localhost:52592' 19:03:22 INFO - SUITE-START | Running 2 tests 19:03:22 INFO - TEST-START | dromaeo_css 19:03:22 INFO - operating with platform_type : mac_ 19:03:22 INFO - Initialising browser for dromaeo_css test... 19:03:22 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmp5uHEba/profile http://localhost:52592/getInfo.html) 19:03:25 INFO - PROCESS | 1914 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 19:03:25 INFO - PROCESS | 1914 | 2017-02-05 19:03:25.073 plugin-container[1916:16638] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9143, name = 'com.apple.tsm.portname' 19:03:25 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:03:25 INFO - PROCESS | 1914 | 2017-02-05 19:03:25.075 plugin-container[1916:16638] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9147, name = 'com.apple.CFPasteboardClient' 19:03:25 INFO - PROCESS | 1914 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:03:25 INFO - PROCESS | 1914 | 2017-02-05 19:03:25.075 plugin-container[1916:16638] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:03:25 INFO - PROCESS | 1914 | __metrics Screen width/height:1600/1200 19:03:25 INFO - PROCESS | 1914 | colorDepth:24 19:03:25 INFO - PROCESS | 1914 | Browser inner width/height: 1024/689 19:03:25 INFO - PROCESS | 1914 | __metrics 19:03:25 ERROR - PROCESS | 1914 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 19:03:25 INFO - PROCESS | 1914 | 1486350205225 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmp5uHEba/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmp5uHEba/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmp5uHEba/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmp5uHEba/profile/extensions/talos-powers@TalosPowersService.js:55:9 19:03:25 INFO - TEST-INFO | 1914: exit 0 19:03:25 INFO - Browser initialized. 19:03:25 INFO - Running cycle 1/1 for dromaeo_css test... 19:03:25 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmp5uHEba/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:03:28 INFO - PROCESS | 1917 | 2017-02-05 19:03:28.593 plugin-container[1918:16751] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 19:03:28 INFO - PROCESS | 1917 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:03:28 INFO - PROCESS | 1917 | 2017-02-05 19:03:28.593 plugin-container[1918:16751] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 19:03:28 INFO - PROCESS | 1917 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:03:28 INFO - PROCESS | 1917 | 2017-02-05 19:03:28.593 plugin-container[1918:16751] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:03:38 INFO - PROCESS | 1917 | RSS: Main: 234065920 19:03:38 INFO - PROCESS | 1917 | 19:06:40 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52592/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52592/tests/dromaeo/cssquery-ext.html) 19:06:42 INFO - PROCESS | 1917 | RSS: Main: 257761280 19:06:42 INFO - PROCESS | 1917 | 19:08:26 INFO - PROCESS | 1917 | ************************* 19:08:26 INFO - PROCESS | 1917 | A coding exception was thrown and uncaught in a Task. 19:08:26 INFO - PROCESS | 1917 | 19:08:26 ERROR - PROCESS | 1917 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:08:26 INFO - PROCESS | 1917 | Full stack: 19:08:26 INFO - PROCESS | 1917 | ************************* 19:09:45 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52592/tests/dromaeo/cssquery-ext.html (next: http://localhost:52592/tests/dromaeo/cssquery-jquery.html) 19:09:45 INFO - PROCESS | 1917 | RSS: Main: 263483392 19:09:45 INFO - PROCESS | 1917 | 19:12:47 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52592/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52592/tests/dromaeo/cssquery-mootools.html) 19:12:48 INFO - PROCESS | 1917 | RSS: Main: 275513344 19:12:48 INFO - PROCESS | 1917 | 19:15:50 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52592/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52592/tests/dromaeo/cssquery-prototype.html) 19:15:51 INFO - PROCESS | 1917 | RSS: Main: 268046336 19:15:51 INFO - PROCESS | 1917 | 19:18:53 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52592/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52592/tests/dromaeo/cssquery-yui.html) 19:18:54 INFO - PROCESS | 1917 | RSS: Main: 273428480 19:18:54 INFO - PROCESS | 1917 | 19:21:57 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52592/tests/dromaeo/cssquery-yui.html (next: http://localhost:52592/tests/dromaeo/cssquery-dojo.html) 19:21:57 INFO - PROCESS | 1917 | RSS: Main: 275259392 19:21:57 INFO - PROCESS | 1917 | 19:21:57 INFO - PROCESS | 1917 | __start_tp_report 19:21:57 INFO - PROCESS | 1917 | _x_x_mozilla_page_load 19:21:57 INFO - PROCESS | 1917 | _x_x_mozilla_page_load_details 19:21:57 INFO - PROCESS | 1917 | |i|pagename|runs| 19:21:57 INFO - PROCESS | 1917 | |0;dojo.html;3303.7522185836056;3322.634510203877;3360.411927912616;3372.7301815854735;3375.8818441354556;5429.294191755076;5571.1086226203815;5594.964931487672;5600.963821692984;5651.886962260763;4440.844570440036;5445;5561.694106824123;5586.86032849179;5632.5212356949705;4060.817263223147;4988.226824842155;5145.74271286436;5185.274061631375;5205.984832957575;5002.7248501332415;5050.191969284915;5213.322268105141;5239.79040838366;5266.8419947401635;5025.522575355372;5039.143345631252;5164.483551644843;5188.299579556749;5213.165893457048;5115.897682046339;5124.76938537763;5139.717315547643;5143.5113664201845;5176;5034.270030845543;5054.494550544953;5059.519345662156;5103.693778373309;5108;5377.623566350357;5409.107497262947;5413.2692086568595;5587.9941610510095;5672.177534257509;6152.815415537541;6167.599106058092;6175.351588083232;6176.69116544171;6179.258488981306;6160.476359509402;6162.22972128484;6168.1056246843955;6173.506119510428;6177.567570270083;5555.2778138842505;5591.832245032656;5849.444302791228;5868.178455016301;5891.145783861316;6083.513318934474;6146.4775494082605;6195.938040619626;6243.968780156161;6265.154204182377;5844.298684157843;5879.147523609053;6086.513078953673;6101.298350689639;6105.45050945417;5937.732802023919;6125.662799505688;6134.099846298167;6176.69116544171;6186.938130618636;5906.822795316148;5962;6160.784372547029;6166.105914642351;6178.165947597017;6103.671041328314;6107.572469927062;6133.754649814046;6171.506279497719;6202.162708034448;4906.754662266872;4911.901761964812;4914.90170196594;4923.950760492349;4955.90088198234;4269.61573458384;4396.120775844844;4403.361512580658;4433.490148632884;4439.067795762861;4628.95371046292;5537.861553461115;5614.466625670555;5703;5784.421557844266;6208.142447924442;6213.285472170758;6235.064740288993;6239.313675495692;6248.937510624926;5736.311642602915;5740.971295143498;5744.425557444306;5757.193992841006;5757.539396848242;5209.244659524424;5211.140161873324;5316.441773613792;5319.441458646864;5359.892802143935;6214.9067763984485;6254.906176407449;6255.218097737783;6276.497880169484;6289.339619340087;6248.781292654735;6256.562040657111;6266.498680105672;6270.874582508415;6298.905516417166;6101.005087479836;6117.401149625572;6177.722002509808;6214.098955651496;6268.686565671607;6158.414950579688;6167.1366008759705;6169.321374648695;6170;6183.907241391473;4679.9064018718755;5894.616849904743;5993.790217342372;6236.438720514994;6255.280642725963;5800.651960882361;5988.490978266722;5997.5501837363245;6006.969965150146;6143.385661433821;6040.637561746309;6065.332813390612;6065.54508411862;6076.513878889767;6077.270727512727;4805.975970120127;5756.712164391847;5814.592978491465;5855.443732845373;5908.852278693067;5696.344920334049;5777.74000169985;5978.953683105352;6017.518598512021;6027.30685971119;5797.275340582427;5847;5850.5027072699295;5856.472917437451;5875.911861322169 19:21:57 INFO - PROCESS | 1917 | |1;ext.html;436.7204988807164;478.15366800762627;482.74655805702014;530.5357811914573;531.5986430245164;37300.44049339258;39724.60275397245;39966.800165999164;42382.36426453606;42406.36390454145;41230.58769412305;41704.374434383506;41745.58254417455;41823;41828.37257441133;9127.497987610695;9317.208037316836;9350.812983740321;9386.765330866749;10581.470926453647;10617.78764424711;10863.728406789814;10890.237683362167;10897.400642964634;10914.563417463292;9312.208462280714;10911;10920.017198452138;10947.959943805365;10985.835212471819;10825.83761243578;10881.292715973437;10884.727881802979;10917.508712107894;10928.453577321103;10831.187660925461;10855.620053298175;10901.454927253606;10926.726831829188;10931.890681093246;36523.63476365229;36562;36692.44961325582;36776;36783.4482482763;3841.8079096045085;3919.490466239399;3927.2341893330813;3927.273454410943;3932.213557288525;27562.96647612387;27930;28248.435031299257;28265.57601635977;28843.85578072096;3133;3138.2311333723383;3145.5910731604745;3152.322250716107;3206.3106432117206;444247;445489.7725511384;447808;449102.5089749093;449838;43998.560014400085;45013;54030.729846350514;54303.45696543063;54417.63955901055;49135.75432122817;57209.71395142998;58108.41891581115;60894.39105608976;62083.68958155271;13844.584662459942;14021.738043576128;14060.648483787987;14068.648283792987;14162.787558186636;10691.572337106429;10790.784184316426;10791.946040269748;10795.784084318428;10819.783604328028;17641.823581764274;17662.470125896245;17695.55761105957;17704.203310851044;17739.822601774074;7709.922900770921;7809.3752499799875;7851;7932.286094251545;7987.600619968978;773.8684423647993;775.25962705616;859.9312055035582;860.5009094725044;867.7353407210861;29743.25641858971;29920;30050.84974575157;30466.695333046828;30584;856.6444925355908;861.4357595774777;991.9900800991898;1011.0950699124243;1023.1252279301091;13377.53178638743;14179.007469477245;14185.961043733863;14282.35729392159;14387.064840785315;622958.8852055711;627406;630437;631022;633659;50717.74641126845;50962.49037509652;51034.21380251674;51071.74464127656;51183.23225151626;1346.4681450826868;1391.08883681189;1413.724323756878;1416.4759039155579;1416.6316757643087;25899;26595.202143935712;27068;27191;27525.862370688017;44838;45340.54659453363;45489.54510454853;45596.54403455923;45811.62565123052;490639;552271;558534;562481;562955;21138.682919756524;21623.026963786353;23199.420014499774;23583.29250122499;23685.64471532894;39776.2044759109;39966.600333996284;40873.182536349705;41247.793761031004;42139.578604213566;34542.65457345495;34911;35165.82417087898;35768.82115589405;35976.82011589925;31291.061268161993;32478;34629.82685086558;35176;35669.46495802617;34345;34741;35074.82462587671;35116.64883351236;35266.82366588253;26139.954401823714;28173.154805355873;31280.21799455032;31375.744970200936;31480.37039259248;23116.884415577813;23485.295441136794;23494.412639684146;23725.881370593037;23859.761402386448 19:21:57 INFO - PROCESS | 1917 | |2;jquery.html;382.7263506592786;385.8148088917318;394.4418647613627;405.21995159318305;422.91522245440444;14622.561323160297;19369.612607747837;19987.400377988648;20851.791482085195;20894.582108357823;20833.895830520825;20976.685349719766;21348.35954921355;21353.57292854142;21508.924553772325;5406.324209473806;5727.284089488814;5798.855028624276;5857.857717745042;5873.941260587403;5540.972295138518;5796.855078623047;5904.232449781543;5915.467607915287;5921.733521991499;5791.971040144794;5890.970545147268;5955.166276721263;5963.045912653976;5986.281646202462;5725.942740572604;5954.851128721773;5972.25346831646;6399.968000159969;6481.189851268591;5041.747912604392;5696.658200507983;5801.941980580183;5813.302403711539;5815.912761308584;10205.285630005903;13165.275909824955;13232.801507977389;13497.055206135574;13709.794353084711;2492.800575953919;2814.6059551662784;2961.8074825136514;2963.3332500187503;2973.1229287360065;9912.08472653305;9960.203183745283;10191.388516689023;10429.843552346721;10583.312084714546;1742.947711568655;1782.7949785774542;1796.6676164909534;1807.475832008716;1810.5564136786572;100108.49945750297;125063.12405313927;125572.0706532878;126822;129299;11516.596919107791;11869.050475961902;11924.1653084285;11951.940240298916;11969.581064662869;13578;14196.657551503886;15673.764893526606;15822.208889555477;15856;7709.653065612061;7978;8054.8791768122355;8082.757517274491;8194.344452443791;7597;7601.809954751176;7634.8091297718;7752.5348479091435;7769.689212431553;4818;4848.296996935495;4848.927266091011;4865.416150062015;4948.713334533048;1747.4146161036194;1995.5210749420326;2051.415346626234;2060.3406909788723;2064.8038436348525;983.1446641421866;1001.7395477175841;1022.9386236825815;1031.2832581356035;1071.3946620159586;17432.65134697324;20255.29106481266;20460.795392046188;20499.8975005124;20624.27815026497;1016.6086056868011;1031.3554028732042;1048.4600430778155;1053.262716098734;1070.619929924881;9198.377168438714;10491.68524944253;10779.943043731046;10796.136309095253;10796.838047429295;450878.4912150902;581415.1858481446;586261;599781;613198;105240;105527;130487;132049;133882;998.272987731229;1015.6496008876926;1033.4625994482826;1035.1098055672267;1037.4086770540719;13643.97670174721;14167.008309418654;17488.912555437142;17895.642087158445;18298.26806927708;54774.72612636911;55445.16832247439;55734.72132639311;55974.44025559692;56405.43594564002;52759.41721748354;70969;73099;73513.91346951724;74061;8202.794930126794;8307;8308.210719981593;8427.494350338999;8543.231109200202;10972.451377430936;11043.791241751522;12380.380980950737;12510.374481275718;13011.804822927854;9188.540572971191;10713.250072494851;11086.778264434828;11194.104471642086;11233.719157020812;10103.949480252551;10792.730181745519;11127.443627818415;11178.938000889902;11220.214584978972;10013.499325033865;11199.272047316897;11373.14701397415;11426.94286528562;11490.425478725863;7114.430845532448;7604.42966777505;7624.27569380908;7917.643706033127;8471.95764021176;9394.530273486162;9763.414195148314;9788.85316720264;11449.713757156138;11699.415029248674 19:21:57 INFO - PROCESS | 1917 | |3;mootools.html;1406.6694326833199;1443.0475885915291;1445.6530432696156;1450.2603672127216;1452.012631410641;7750.8449831003345;8091.029076510819;8132.634031468583;8216;8523.488590684563;8446.788830279245;8580.656773729042;8590;8606.95696521518;8612.56937153143;2040.6122836661061;2195.3194509702043;2259.265738634946;2273.943151421211;2288.54229154169;2239.9440013999697;2300.0224904415554;2303.55080759252;2314.7569505201964;2316.108298305156;2206.0844749428966;2211.8672879627193;2223.5108276179294;2232.8325375596814;2244.5959727249087;2162.135145941636;2223.1774243529917;2245.7529671736097;2252.245497758253;2253.188852013274;1693.2972816281228;1779.670760909236;2032.7052577376346;2249;2255.796978271947;8259.008918929707;8442.324614030862;8453.70412035582;8591.613377398033;8615.741527754177;5048.949510504922;5202.635815492917;5211.270422140903;5219.243209734605;5233.058049551079;3431.588209414861;3445.500402441632;3448.499967504698;3509.5963964144194;3510.947335789965;1187.139323990109;1195.4680167325544;1212.5392350906686;1253.7931241345168;1263.2925561685395;10943.398113103776;10955.561777528968;10957.17821163416;11066.889331106666;11107.666769996913;4212.91574168521;4478.619317358061;4539.024109816405;4549.522300158435;4561.68068235227;7468.5145465544565;8794.956025219833;8827.117288271122;8836.160564746468;8847.11528847123;5111.488851114933;5112.36095488064;5112.6421150519855;5117.667351622133;5121.641485096082;4081.6530594899173;4368.279233926367;4598.172328980816;4649.86050418488;4793.257045157937;3280.16355829262;3547.9001509532127;3661.23114146027;3723.9813800930824;3737.4020156774786;1160.6169963911889;1169.2750494693344;1169.473736818435;1172.7803084791892;1180.0618508285934;715.6493318274113;729.2306616519622;755.1542272654661;781.5467029123095;781.9100803407567;4561.2473941799235;5602.523785478198;5673.149027645886;5769.134629805562;5770.172126152533;492.83982705620815;558.8351436326293;564.8249042796664;592.9673867937219;594.7531774313611;3662.8168591570316;3770.830312635938;3832.3293423651307;3885.922281554353;3900.570937196906;9923.55344009507;10258.640947566799;10280.383177009404;10287.485625718833;10313.381197128196;10170.542325595366;10197.439140847177;10242.53908574116;10264.43545604984;10304.896951030543;7850.097238817495;7883.2905038546805;7941.047074351115;8015;8038.839223215503;4353.695241333076;5612.887742245214;5664.348599910898;5671.383655658283;5701.629394089371;9198.770030749285;9232.353735238468;9272.814543709223;9335.57989890443;9337.253019758538;9282;9355.345125841126;9618;9652;9667.70996870095;6659.766908158192;6794.626295553792;6831.863362732618;6853.897191542231;6873.621950792754;7600.695972161052;7779.416543759354;7853.37173026168;7874.488158269694;7976.880346794686;7101.11236095488;7243.855122897618;7243.963780181065;7247.710091596277;7302;6177.722002509808;6447.677616119269;7010.929890701028;7031.296870312928;7049.330313620198;6335.746570137143;6429.7749578764515;6524.478041756743;6531.640759758069;6540;4081.6530594898577;4932.7286999215385;4974.477679843709;5067.5185857343495;5100.107481190703;5001;5029.315179414791;5166.328377310925;5166.535011848951;5241.266222728745 19:21:57 INFO - PROCESS | 1917 | |4;prototype.html;292.9428761391528;296.67365897512724;298.54919072200977;357.7960562479386;379.1393536671755;5011.949880501194;5115.514026167518;5283.63014588979;5408.729563521828;5425.891482170359;5157.974210128944;5221.321228240324;5230.581553475722;5233.8953220935555;5242.947570524294;3503.316853213624;3986.8604598839047;3996.5803590623073;4004.9599504004877;4051.7366371185926;3686.2811751708427;4004.7396919200305;4007.018280521276;4008.7394319369146;4023.5171779386515;3918.8628398006076;3925.41118832176;3934.783586902719;3966.583508731585;3980.761154330735;3494.5457090578316;3967.0082479380153;3969.0474286171398;3974.9602503975025;3975.264576053439;2783.8608069596644;3067.84660766963;3149;3285.6385797562248;3520.964790352115;3998.7800670963084;4403.8238470461465;4702.941838086437;4943.332650092228;5104.69371837691;3570.7143428525656;4558.974230798077;4574.9542504574865;4593.816247350102;4616.630669546428;4633.061897387228;4890.510948905081;5140.794368225266;5318.962802253562;5382.712347252441;3412.4710669846213;3422.9486557701653;3803.9619603804163;3841.8079096045085;3860.498135242429;5518.530924871391;5698.971505142489;5757.309122905236;5804.477597016246;5810.1865738796605;3735.7758534488016;3811.7522361046445;3840.8847734568008;3842.2315536892734;3847.2882516734494;3292.901212963615;3928.4303775952326;3932.528096628423;3943.92112157761;3945.0137465633593;4350.978245108754;4457.153140903218;4552.226121559343;4614.97692511542;4619.538046195354;5362.758675859595;5559.054330984204;5609.719514024364;5620.87582483505;5637.68992705397;1145.7078444996473;1265.5950095969386;1280.4558062823448;1281.4681907008487;1285.2288626823831;772.5360441962449;807.4751411582519;865.3077537969599;883.6156272021691;883.9779005524913;4118.855840045584;4510.368548403226;4652.581267685924;4796.616270698336;5020.59835213182;4701.576858082789;4950.257461380822;5458.863528411822;5494.36814766299;5571.66570005801;3747.6439738224826;4408.559144085566;4472;4811.992504684572;4907.852764417074;2577.8582177980015;2619.3105446986588;2862.770978321771;2870.8564571771326;2879.2226098953583;5617.927002922848;5768.89435356092;5769.9711501442225;5773.682447465346;5812.651240925474;4434.728600282632;5084.186530155232;5246.658967167122;5690.687012214368;5692.7722891083895;4739.980904105565;5634.014047541746;5664.433556644302;5674.858128546819;5710.885782284331;4600.953990460186;5464.781408743605;5485.50630443262;5513.195894832713;5536.200734761138;4363.105563359567;4944.604431645532;5191.273221749034;5443.755031023693;5639.802606908738;4883.949950760603;5137.8715532112;5625.971870140623;5889.911651325147;5962.493188079062;3859.3053250414073;3892.435596838386;3914.451976723204;3924.3328634132836;3926.0173612325593;5456.744948661751;5611.971940140274;5747.109198074305;5823.1847541343395;5852.268466441695;4509.9774501128595;5324.494173053554;5602.579806514609;5621.437856214346;5627.324721033502;5623.325200975909;5637.661740295595;5638.774449021993;5653;5682.516986056232;4956.7769450375545;5448.828501872116;5496.835094947158;5506.394296627448;5519.597267170064;4886.731229782396;5028.396592408788;5584.218209450762;5633.6056476047925;5659.745311460912;4478.245878784589;5209.218617207298;5506.669599824023;5510.008198524304;5555.2778138841695 19:21:57 INFO - PROCESS | 1917 | |5;yui.html;701.022074206482;701.7789396340156;711.7508871894836;766.8619648463274;814.4950130918832;14132.576022719322;14980.925095374536;15087.170205638698;15095.773563396544;15115.244237788122;13714.24571648559;13838.031337806358;13868.09857359271;13903.860961390408;13936.721265574683;868.6438560190339;871.8474267003281;884.7168905950099;891.233539156325;894.9955250223773;897.5287973813735;901.8106197698459;902.6389444222298;902.7427183252775;902.8284625921087;884.9247813935823;918.6830543462495;938.648006997376;940.8494640857464;942.9481378524179;922.5802259971697;931.7111695374422;932.8600709893536;935.8455854784021;939.3143005605878;703.0473708125519;704.6828926982878;705.1150805738765;706.2055187913597;709.3651182191909;11180.496877640444;11378.431078446045;14164.36260368286;14917.254137293092;14954.700905981928;13531.526396576073;13631.250281234528;13814.861851381458;13895.79156312656;13896.513622023282;10746.140308775279;11368.715782105432;11586.768264634744;11652.592159274385;12133.575324863676;3561.679448849616;3638.5269914911155;3654.104744337628;3670.926581468382;3769.1707824278615;98652.01347986572;98963.0103698961;99278.50360748223;100221;100228.49885750524;10619.575216991389;10641.5211315491;10873.130149588014;10907.890921090688;10920.781584368267;17619.119044047748;21192.046357913932;21928.45178870541;21929;21941.780582194293;7410.110786705522;7411.629418529052;7480.513766605262;7489.101307842985;7561.09266887977;4173.728707633994;4183.393407955829;4185.204811085884;4279.272523670983;4340.153670034376;3580.122869896892;3639.8544058237376;3659.469376940329;3680.227152297994;3684.871029513954;626.840910558439;627.3005598757353;633.7781776378323;649.1334069017914;650.612885333226;650.1450592470981;666.9966650166718;677.4174210179242;692.9986169984325;695.4471195399669;8864.06666033896;9716.869662327523;9936.850947235796;10133.543990520444;10435.895641043644;677.3937326093119;686.7115811359241;689.8482333886537;695.5687473766297;706.5548704316351;4741.66808323421;4836.540528649773;4876;4876.609871210295;4879.072976134523;96090.51954740181;96380;97260.51369743106;97441;99056;73606.63196683982;74654;74665;86148;88443.55778221197;38384.42423363652;68255.83130253106;74424;75420.86868697083;76010.85983710249;10677.359358438518;10712.89287107119;10827.566897324019;10846.783064338826;10883.292585981886;43952.78023609862;47220.52779472162;49664.75167624139;50253;51890;60415.69792151011;64213.71572568616;65059;66698.66650666716;67866.6426671454;12331.383430828244;12465.5013799447;12555.309457979898;12974.805377919527;13224.735505290033;14145.646358841112;14177.574672759834;14180.787288190892;14399.64000899944;14966.32651530662;13221.471141154247;13333.799468605603;13347.132436391992;13351.866481335452;13537.59387218385;13234.404451799499;13314.46742130304;13372.264525450804;13392.598222053353;13455.327233638474;12843.614691559269;13176.011799114913;13194.208347499181;13537.526186583422;13557;8283.58582070882;10877.67366978992;10933.398663073289;11149.442527873736;11271.718207044889;9408.871164483347;10249.180065594883;10616.203784716332;10805.729856753644;10839 19:21:57 INFO - PROCESS | 1917 | __end_tp_report 19:21:57 INFO - PROCESS | 1917 | __start_cc_report 19:21:57 INFO - PROCESS | 1917 | _x_x_mozilla_cycle_collect,411 19:21:57 INFO - PROCESS | 1917 | __end_cc_report 19:21:57 INFO - PROCESS | 1917 | __startTimestamp1486351317673__endTimestamp 19:21:57 INFO - PROCESS | 1917 | 19:21:57 INFO - PROCESS | 1917 | ------- Summary: start ------- 19:21:57 INFO - PROCESS | 1917 | Number of tests: 6 19:21:57 INFO - PROCESS | 1917 | 19:21:57 INFO - PROCESS | 1917 | [#0] dojo.html Cycles:165 Average:5633.24 Median:5849.44 stddev:659.23 (11.3%) stddev-sans-first:635.41 19:21:57 INFO - PROCESS | 1917 | Values: 3303.8 3322.6 3360.4 3372.7 3375.9 5429.3 5571.1 5595.0 5601.0 5651.9 4440.8 5445.0 5561.7 5586.9 5632.5 4060.8 4988.2 5145.7 5185.3 5206.0 5002.7 5050.2 5213.3 5239.8 5266.8 5025.5 5039.1 5164.5 5188.3 5213.2 5115.9 5124.8 5139.7 5143.5 5176.0 5034.3 5054.5 5059.5 5103.7 5108.0 5377.6 5409.1 5413.3 5588.0 5672.2 6152.8 6167.6 6175.4 6176.7 6179.3 6160.5 6162.2 6168.1 6173.5 6177.6 5555.3 5591.8 5849.4 5868.2 5891.1 6083.5 6146.5 6195.9 6244.0 6265.2 5844.3 5879.1 6086.5 6101.3 6105.5 5937.7 6125.7 6134.1 6176.7 6186.9 5906.8 5962.0 6160.8 6166.1 6178.2 6103.7 6107.6 6133.8 6171.5 6202.2 4906.8 4911.9 4914.9 4924.0 4955.9 4269.6 4396.1 4403.4 4433.5 4439.1 4629.0 5537.9 5614.5 5703.0 5784.4 6208.1 6213.3 6235.1 6239.3 6248.9 5736.3 5741.0 5744.4 5757.2 5757.5 5209.2 5211.1 5316.4 5319.4 5359.9 6214.9 6254.9 6255.2 6276.5 6289.3 6248.8 6256.6 6266.5 6270.9 6298.9 6101.0 6117.4 6177.7 6214.1 6268.7 6158.4 6167.1 6169.3 6170.0 6183.9 4679.9 5894.6 5993.8 6236.4 6255.3 5800.7 5988.5 5997.6 6007.0 6143.4 6040.6 6065.3 6065.5 6076.5 6077.3 4806.0 5756.7 5814.6 5855.4 5908.9 5696.3 5777.7 5979.0 6017.5 6027.3 5797.3 5847.0 5850.5 5856.5 5875.9 19:21:57 INFO - PROCESS | 1917 | 19:21:57 INFO - PROCESS | 1917 | [#1] ext.html Cycles:180 Average:66070.59 Median:35141.24 stddev:146017.14 (415.5%) stddev-sans-first:146343.61 19:21:57 INFO - PROCESS | 1917 | Values: 436.7 478.2 482.7 530.5 531.6 37300.4 39724.6 39966.8 42382.4 42406.4 41230.6 41704.4 41745.6 41823.0 41828.4 9127.5 9317.2 9350.8 9386.8 10581.5 10617.8 10863.7 10890.2 10897.4 10914.6 9312.2 10911.0 10920.0 10948.0 10985.8 10825.8 10881.3 10884.7 10917.5 10928.5 10831.2 10855.6 10901.5 10926.7 10931.9 36523.6 36562.0 36692.4 36776.0 36783.4 3841.8 3919.5 3927.2 3927.3 3932.2 27563.0 27930.0 28248.4 28265.6 28843.9 3133.0 3138.2 3145.6 3152.3 3206.3 444247.0 445489.8 447808.0 449102.5 449838.0 43998.6 45013.0 54030.7 54303.5 54417.6 49135.8 57209.7 58108.4 60894.4 62083.7 13844.6 14021.7 14060.6 14068.6 14162.8 10691.6 10790.8 10791.9 10795.8 10819.8 17641.8 17662.5 17695.6 17704.2 17739.8 7709.9 7809.4 7851.0 7932.3 7987.6 773.9 775.3 859.9 860.5 867.7 29743.3 29920.0 30050.8 30466.7 30584.0 856.6 861.4 992.0 1011.1 1023.1 13377.5 14179.0 14186.0 14282.4 14387.1 622958.9 627406.0 630437.0 631022.0 633659.0 50717.7 50962.5 51034.2 51071.7 51183.2 1346.5 1391.1 1413.7 1416.5 1416.6 25899.0 26595.2 27068.0 27191.0 27525.9 44838.0 45340.5 45489.5 45596.5 45811.6 490639.0 552271.0 558534.0 562481.0 562955.0 21138.7 21623.0 23199.4 23583.3 23685.6 39776.2 39966.6 40873.2 41247.8 42139.6 34542.7 34911.0 35165.8 35768.8 35976.8 31291.1 32478.0 34629.8 35176.0 35669.5 34345.0 34741.0 35074.8 35116.6 35266.8 26140.0 28173.2 31280.2 31375.7 31480.4 23116.9 23485.3 23494.4 23725.9 23859.8 19:21:57 INFO - PROCESS | 1917 | 19:21:57 INFO - PROCESS | 1917 | [#2] jquery.html Cycles:180 Average:33373.71 Median:20873.19 stddev:95286.26 (456.5%) stddev-sans-first:95521.36 19:21:57 INFO - PROCESS | 1917 | Values: 382.7 385.8 394.4 405.2 422.9 14622.6 19369.6 19987.4 20851.8 20894.6 20833.9 20976.7 21348.4 21353.6 21508.9 5406.3 5727.3 5798.9 5857.9 5873.9 5541.0 5796.9 5904.2 5915.5 5921.7 5792.0 5891.0 5955.2 5963.0 5986.3 5725.9 5954.9 5972.3 6400.0 6481.2 5041.7 5696.7 5801.9 5813.3 5815.9 10205.3 13165.3 13232.8 13497.1 13709.8 2492.8 2814.6 2961.8 2963.3 2973.1 9912.1 9960.2 10191.4 10429.8 10583.3 1742.9 1782.8 1796.7 1807.5 1810.6 100108.5 125063.1 125572.1 126822.0 129299.0 11516.6 11869.1 11924.2 11951.9 11969.6 13578.0 14196.7 15673.8 15822.2 15856.0 7709.7 7978.0 8054.9 8082.8 8194.3 7597.0 7601.8 7634.8 7752.5 7769.7 4818.0 4848.3 4848.9 4865.4 4948.7 1747.4 1995.5 2051.4 2060.3 2064.8 983.1 1001.7 1022.9 1031.3 1071.4 17432.7 20255.3 20460.8 20499.9 20624.3 1016.6 1031.4 1048.5 1053.3 1070.6 9198.4 10491.7 10779.9 10796.1 10796.8 450878.5 581415.2 586261.0 599781.0 613198.0 105240.0 105527.0 130487.0 132049.0 133882.0 998.3 1015.6 1033.5 1035.1 1037.4 13644.0 14167.0 17488.9 17895.6 18298.3 54774.7 55445.2 55734.7 55974.4 56405.4 52759.4 70969.0 73099.0 73513.9 74061.0 8202.8 8307.0 8308.2 8427.5 8543.2 10972.5 11043.8 12380.4 12510.4 13011.8 9188.5 10713.3 11086.8 11194.1 11233.7 10103.9 10792.7 11127.4 11178.9 11220.2 10013.5 11199.3 11373.1 11426.9 11490.4 7114.4 7604.4 7624.3 7917.6 8472.0 9394.5 9763.4 9788.9 11449.7 11699.4 19:21:57 INFO - PROCESS | 1917 | 19:21:57 INFO - PROCESS | 1917 | [#3] mootools.html Cycles:180 Average:5390.55 Median:5111.92 stddev:3027.74 (59.2%) stddev-sans-first:3021.44 19:21:57 INFO - PROCESS | 1917 | Values: 1406.7 1443.0 1445.7 1450.3 1452.0 7750.8 8091.0 8132.6 8216.0 8523.5 8446.8 8580.7 8590.0 8607.0 8612.6 2040.6 2195.3 2259.3 2273.9 2288.5 2239.9 2300.0 2303.6 2314.8 2316.1 2206.1 2211.9 2223.5 2232.8 2244.6 2162.1 2223.2 2245.8 2252.2 2253.2 1693.3 1779.7 2032.7 2249.0 2255.8 8259.0 8442.3 8453.7 8591.6 8615.7 5048.9 5202.6 5211.3 5219.2 5233.1 3431.6 3445.5 3448.5 3509.6 3510.9 1187.1 1195.5 1212.5 1253.8 1263.3 10943.4 10955.6 10957.2 11066.9 11107.7 4212.9 4478.6 4539.0 4549.5 4561.7 7468.5 8795.0 8827.1 8836.2 8847.1 5111.5 5112.4 5112.6 5117.7 5121.6 4081.7 4368.3 4598.2 4649.9 4793.3 3280.2 3547.9 3661.2 3724.0 3737.4 1160.6 1169.3 1169.5 1172.8 1180.1 715.6 729.2 755.2 781.5 781.9 4561.2 5602.5 5673.1 5769.1 5770.2 492.8 558.8 564.8 593.0 594.8 3662.8 3770.8 3832.3 3885.9 3900.6 9923.6 10258.6 10280.4 10287.5 10313.4 10170.5 10197.4 10242.5 10264.4 10304.9 7850.1 7883.3 7941.0 8015.0 8038.8 4353.7 5612.9 5664.3 5671.4 5701.6 9198.8 9232.4 9272.8 9335.6 9337.3 9282.0 9355.3 9618.0 9652.0 9667.7 6659.8 6794.6 6831.9 6853.9 6873.6 7600.7 7779.4 7853.4 7874.5 7976.9 7101.1 7243.9 7244.0 7247.7 7302.0 6177.7 6447.7 7010.9 7031.3 7049.3 6335.7 6429.8 6524.5 6531.6 6540.0 4081.7 4932.7 4974.5 5067.5 5100.1 5001.0 5029.3 5166.3 5166.5 5241.3 19:21:57 INFO - PROCESS | 1917 | 19:21:57 INFO - PROCESS | 1917 | [#4] prototype.html Cycles:180 Average:4415.73 Median:4888.62 stddev:1368.32 (28.0%) stddev-sans-first:1336.71 19:21:57 INFO - PROCESS | 1917 | Values: 292.9 296.7 298.5 357.8 379.1 5011.9 5115.5 5283.6 5408.7 5425.9 5158.0 5221.3 5230.6 5233.9 5242.9 3503.3 3986.9 3996.6 4005.0 4051.7 3686.3 4004.7 4007.0 4008.7 4023.5 3918.9 3925.4 3934.8 3966.6 3980.8 3494.5 3967.0 3969.0 3975.0 3975.3 2783.9 3067.8 3149.0 3285.6 3521.0 3998.8 4403.8 4702.9 4943.3 5104.7 3570.7 4559.0 4575.0 4593.8 4616.6 4633.1 4890.5 5140.8 5319.0 5382.7 3412.5 3422.9 3804.0 3841.8 3860.5 5518.5 5699.0 5757.3 5804.5 5810.2 3735.8 3811.8 3840.9 3842.2 3847.3 3292.9 3928.4 3932.5 3943.9 3945.0 4351.0 4457.2 4552.2 4615.0 4619.5 5362.8 5559.1 5609.7 5620.9 5637.7 1145.7 1265.6 1280.5 1281.5 1285.2 772.5 807.5 865.3 883.6 884.0 4118.9 4510.4 4652.6 4796.6 5020.6 4701.6 4950.3 5458.9 5494.4 5571.7 3747.6 4408.6 4472.0 4812.0 4907.9 2577.9 2619.3 2862.8 2870.9 2879.2 5617.9 5768.9 5770.0 5773.7 5812.7 4434.7 5084.2 5246.7 5690.7 5692.8 4740.0 5634.0 5664.4 5674.9 5710.9 4601.0 5464.8 5485.5 5513.2 5536.2 4363.1 4944.6 5191.3 5443.8 5639.8 4883.9 5137.9 5626.0 5889.9 5962.5 3859.3 3892.4 3914.5 3924.3 3926.0 5456.7 5612.0 5747.1 5823.2 5852.3 4510.0 5324.5 5602.6 5621.4 5627.3 5623.3 5637.7 5638.8 5653.0 5682.5 4956.8 5448.8 5496.8 5506.4 5519.6 4886.7 5028.4 5584.2 5633.6 5659.7 4478.2 5209.2 5506.7 5510.0 5555.3 19:21:57 INFO - PROCESS | 1917 | 19:21:57 INFO - PROCESS | 1917 | [#5] yui.html Cycles:180 Average:19296.67 Median:4232.24 stddev:27183.32 (642.3%) stddev-sans-first:27223.72 19:21:57 INFO - PROCESS | 1917 | Values: 701.0 701.8 711.8 766.9 814.5 14132.6 14980.9 15087.2 15095.8 15115.2 13714.2 13838.0 13868.1 13903.9 13936.7 868.6 871.8 884.7 891.2 895.0 897.5 901.8 902.6 902.7 902.8 884.9 918.7 938.6 940.8 942.9 922.6 931.7 932.9 935.8 939.3 703.0 704.7 705.1 706.2 709.4 11180.5 11378.4 14164.4 14917.3 14954.7 13531.5 13631.3 13814.9 13895.8 13896.5 10746.1 11368.7 11586.8 11652.6 12133.6 3561.7 3638.5 3654.1 3670.9 3769.2 98652.0 98963.0 99278.5 100221.0 100228.5 10619.6 10641.5 10873.1 10907.9 10920.8 17619.1 21192.0 21928.5 21929.0 21941.8 7410.1 7411.6 7480.5 7489.1 7561.1 4173.7 4183.4 4185.2 4279.3 4340.2 3580.1 3639.9 3659.5 3680.2 3684.9 626.8 627.3 633.8 649.1 650.6 650.1 667.0 677.4 693.0 695.4 8864.1 9716.9 9936.9 10133.5 10435.9 677.4 686.7 689.8 695.6 706.6 4741.7 4836.5 4876.0 4876.6 4879.1 96090.5 96380.0 97260.5 97441.0 99056.0 73606.6 74654.0 74665.0 86148.0 88443.6 38384.4 68255.8 74424.0 75420.9 76010.9 10677.4 10712.9 10827.6 10846.8 10883.3 43952.8 47220.5 49664.8 50253.0 51890.0 60415.7 64213.7 65059.0 66698.7 67866.6 12331.4 12465.5 12555.3 12974.8 13224.7 14145.6 14177.6 14180.8 14399.6 14966.3 13221.5 13333.8 13347.1 13351.9 13537.6 13234.4 13314.5 13372.3 13392.6 13455.3 12843.6 13176.0 13194.2 13537.5 13557.0 8283.6 10877.7 10933.4 11149.4 11271.7 9408.9 10249.2 10616.2 10805.7 10839.0 19:21:57 INFO - PROCESS | 1917 | -------- Summary: end -------- 19:21:57 INFO - PROCESS | 1917 | 19:21:58 INFO - TEST-INFO | 1917: exit 0 19:21:58 INFO - TEST-OK | dromaeo_css | took 1116199ms 19:21:58 INFO - TEST-START | kraken 19:21:58 INFO - operating with platform_type : mac_ 19:21:58 INFO - Initialising browser for kraken test... 19:21:58 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpbWOrA2/profile http://localhost:52592/getInfo.html) 19:22:01 INFO - PROCESS | 1922 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 19:22:01 INFO - PROCESS | 1922 | 2017-02-05 19:22:01.479 plugin-container[1923:18698] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 19:22:01 INFO - PROCESS | 1922 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:22:01 INFO - PROCESS | 1922 | 2017-02-05 19:22:01.483 plugin-container[1923:18698] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 19:22:01 INFO - PROCESS | 1922 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:22:01 INFO - PROCESS | 1922 | 2017-02-05 19:22:01.483 plugin-container[1923:18698] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:22:01 INFO - PROCESS | 1922 | __metrics Screen width/height:1600/1200 19:22:01 INFO - PROCESS | 1922 | colorDepth:24 19:22:01 INFO - PROCESS | 1922 | Browser inner width/height: 1024/689 19:22:01 INFO - PROCESS | 1922 | __metrics 19:22:01 ERROR - PROCESS | 1922 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 19:22:01 INFO - PROCESS | 1922 | 1486351321633 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpbWOrA2/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpbWOrA2/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpbWOrA2/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpbWOrA2/profile/extensions/talos-powers@TalosPowersService.js:55:9 19:22:02 INFO - TEST-INFO | 1922: exit 0 19:22:02 INFO - Browser initialized. 19:22:02 INFO - Running cycle 1/1 for kraken test... 19:22:02 INFO - TEST-INFO | started process 1924 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpbWOrA2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:22:05 INFO - PROCESS | 1924 | 2017-02-05 19:22:05.095 plugin-container[1925:18823] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 19:22:05 INFO - PROCESS | 1924 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:22:05 INFO - PROCESS | 1924 | 2017-02-05 19:22:05.095 plugin-container[1925:18823] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x481b, name = 'com.apple.CFPasteboardClient' 19:22:05 INFO - PROCESS | 1924 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:22:05 INFO - PROCESS | 1924 | 2017-02-05 19:22:05.096 plugin-container[1925:18823] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:22:14 INFO - PROCESS | 1924 | RSS: Main: 233693184 19:22:14 INFO - PROCESS | 1924 | 19:22:17 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:52592/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52592/tests/kraken/driver.html?testName=audio-beat-detection) 19:22:18 INFO - PROCESS | 1924 | RSS: Main: 247226368 19:22:18 INFO - PROCESS | 1924 | 19:22:21 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:52592/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52592/tests/kraken/driver.html?testName=audio-dft) 19:22:22 INFO - PROCESS | 1924 | RSS: Main: 255152128 19:22:22 INFO - PROCESS | 1924 | 19:22:25 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:52592/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52592/tests/kraken/driver.html?testName=audio-fft) 19:22:26 INFO - PROCESS | 1924 | RSS: Main: 257499136 19:22:26 INFO - PROCESS | 1924 | 19:22:28 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:52592/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52592/tests/kraken/driver.html?testName=audio-oscillator) 19:22:28 INFO - PROCESS | 1924 | RSS: Main: 258670592 19:22:28 INFO - PROCESS | 1924 | 19:22:31 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:52592/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52592/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:22:31 INFO - PROCESS | 1924 | RSS: Main: 259063808 19:22:31 INFO - PROCESS | 1924 | 19:22:34 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:52592/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52592/tests/kraken/driver.html?testName=imaging-darkroom) 19:22:35 INFO - PROCESS | 1924 | RSS: Main: 264437760 19:22:35 INFO - PROCESS | 1924 | 19:22:38 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:52592/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52592/tests/kraken/driver.html?testName=imaging-desaturate) 19:22:38 INFO - PROCESS | 1924 | RSS: Main: 263860224 19:22:38 INFO - PROCESS | 1924 | 19:22:42 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:52592/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52592/tests/kraken/driver.html?testName=json-parse-financial) 19:22:42 INFO - PROCESS | 1924 | RSS: Main: 263696384 19:22:42 INFO - PROCESS | 1924 | 19:22:44 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:52592/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52592/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:22:44 INFO - PROCESS | 1924 | RSS: Main: 263221248 19:22:44 INFO - PROCESS | 1924 | 19:22:46 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:52592/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52592/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:22:47 INFO - PROCESS | 1924 | RSS: Main: 264699904 19:22:47 INFO - PROCESS | 1924 | 19:22:49 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:52592/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52592/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:22:50 INFO - PROCESS | 1924 | RSS: Main: 264740864 19:22:50 INFO - PROCESS | 1924 | 19:22:53 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:52592/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52592/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:22:54 INFO - PROCESS | 1924 | RSS: Main: 265072640 19:22:54 INFO - PROCESS | 1924 | 19:22:57 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:52592/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52592/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:22:57 INFO - PROCESS | 1924 | RSS: Main: 264822784 19:22:57 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | Cycle 1(1): loaded http://localhost:52592/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52592/tests/kraken/driver.html?testName=ai-astar) 19:22:59 INFO - PROCESS | 1924 | RSS: Main: 266780672 19:22:59 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | __start_tp_report 19:22:59 INFO - PROCESS | 1924 | _x_x_mozilla_page_load 19:22:59 INFO - PROCESS | 1924 | _x_x_mozilla_page_load_details 19:22:59 INFO - PROCESS | 1924 | |i|pagename|runs| 19:22:59 INFO - PROCESS | 1924 | |0;ai-astar;105;118;119;118;128;177;119;119;119;122 19:22:59 INFO - PROCESS | 1924 | |1;audio-beat-detection;152;137;113;180;109;146;149;118;167;143 19:22:59 INFO - PROCESS | 1924 | |2;audio-dft;205;225;230;266;280;200;198;198;196;199 19:22:59 INFO - PROCESS | 1924 | |3;audio-fft;83;60;60;91;51;85;85;54;91;73 19:22:59 INFO - PROCESS | 1924 | |4;audio-oscillator;87;71;83;72;78;75;99;101;89;84 19:22:59 INFO - PROCESS | 1924 | |5;imaging-gaussian-blur;90;86;91;85;79;133;139;84;88;87 19:22:59 INFO - PROCESS | 1924 | |6;imaging-darkroom;95;95;95;98;96;96;96;100;95;98 19:22:59 INFO - PROCESS | 1924 | |7;imaging-desaturate;92;145;138;94;134;80;144;143;113;90 19:22:59 INFO - PROCESS | 1924 | |8;json-parse-financial;63;65;63;64;66;67;64;64;65;64 19:22:59 INFO - PROCESS | 1924 | |9;json-stringify-tinderbox;66;74;69;79;76;69;68;74;69;71 19:22:59 INFO - PROCESS | 1924 | |10;stanford-crypto-aes;89;87;93;88;90;90;90;93;89;93 19:22:59 INFO - PROCESS | 1924 | |11;stanford-crypto-ccm;152;136;158;137;150;156;154;142;189;179 19:22:59 INFO - PROCESS | 1924 | |12;stanford-crypto-pbkdf2;177;176;173;175;176;176;178;234;173;202 19:22:59 INFO - PROCESS | 1924 | |13;stanford-crypto-sha256-iterative;68;68;69;66;75;87;67;64;81;90 19:22:59 INFO - PROCESS | 1924 | __end_tp_report 19:22:59 INFO - PROCESS | 1924 | __start_cc_report 19:22:59 INFO - PROCESS | 1924 | _x_x_mozilla_cycle_collect,988 19:22:59 INFO - PROCESS | 1924 | __end_cc_report 19:22:59 INFO - PROCESS | 1924 | __startTimestamp1486351379894__endTimestamp 19:22:59 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | ------- Summary: start ------- 19:22:59 INFO - PROCESS | 1924 | Number of tests: 14 19:22:59 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | [#0] ai-astar Cycles:10 Average:124.40 Median:119.00 stddev:19.32 (16.2%) stddev-sans-first:19.18 19:22:59 INFO - PROCESS | 1924 | Values: 105.0 118.0 119.0 118.0 128.0 177.0 119.0 119.0 119.0 122.0 19:22:59 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:147.50 stddev:23.00 (15.6%) stddev-sans-first:24.08 19:22:59 INFO - PROCESS | 1924 | Values: 152.0 137.0 113.0 180.0 109.0 146.0 149.0 118.0 167.0 143.0 19:22:59 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | [#2] audio-dft Cycles:10 Average:219.70 Median:215.00 stddev:30.64 (14.3%) stddev-sans-first:32.04 19:22:59 INFO - PROCESS | 1924 | Values: 205.0 225.0 230.0 266.0 280.0 200.0 198.0 198.0 196.0 199.0 19:22:59 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | [#3] audio-fft Cycles:10 Average:73.30 Median:84.00 stddev:15.70 (18.7%) stddev-sans-first:16.25 19:22:59 INFO - PROCESS | 1924 | Values: 83.0 60.0 60.0 91.0 51.0 85.0 85.0 54.0 91.0 73.0 19:22:59 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | [#4] audio-oscillator Cycles:10 Average:83.90 Median:83.50 stddev:10.43 (12.5%) stddev-sans-first:11.00 19:22:59 INFO - PROCESS | 1924 | Values: 87.0 71.0 83.0 72.0 78.0 75.0 99.0 101.0 89.0 84.0 19:22:59 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | [#5] imaging-gaussian-blur Cycles:10 Average:96.20 Median:86.50 stddev:21.29 (24.6%) stddev-sans-first:22.46 19:22:59 INFO - PROCESS | 1924 | Values: 90.0 86.0 91.0 85.0 79.0 133.0 139.0 84.0 88.0 87.0 19:22:59 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:96.00 stddev:1.71 (1.8%) stddev-sans-first:1.74 19:22:59 INFO - PROCESS | 1924 | Values: 95.0 95.0 95.0 98.0 96.0 96.0 96.0 100.0 95.0 98.0 19:22:59 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | [#7] imaging-desaturate Cycles:10 Average:117.30 Median:112.50 stddev:26.22 (23.3%) stddev-sans-first:26.16 19:22:59 INFO - PROCESS | 1924 | Values: 92.0 145.0 138.0 94.0 134.0 80.0 144.0 143.0 113.0 90.0 19:22:59 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.50 stddev:1.27 (2.0%) stddev-sans-first:1.22 19:22:59 INFO - PROCESS | 1924 | Values: 63.0 65.0 63.0 64.0 66.0 67.0 64.0 64.0 65.0 64.0 19:22:59 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:72.50 stddev:4.09 (5.6%) stddev-sans-first:3.82 19:22:59 INFO - PROCESS | 1924 | Values: 66.0 74.0 69.0 79.0 76.0 69.0 68.0 74.0 69.0 71.0 19:22:59 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:90.00 stddev:2.15 (2.4%) stddev-sans-first:2.24 19:22:59 INFO - PROCESS | 1924 | Values: 89.0 87.0 93.0 88.0 90.0 90.0 90.0 93.0 89.0 93.0 19:22:59 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | [#11] stanford-crypto-ccm Cycles:10 Average:155.30 Median:155.00 stddev:17.09 (11.0%) stddev-sans-first:18.09 19:22:59 INFO - PROCESS | 1924 | Values: 152.0 136.0 158.0 137.0 150.0 156.0 154.0 142.0 189.0 179.0 19:22:59 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.00 Median:176.50 stddev:19.50 (11.1%) stddev-sans-first:20.52 19:22:59 INFO - PROCESS | 1924 | Values: 177.0 176.0 173.0 175.0 176.0 176.0 178.0 234.0 173.0 202.0 19:22:59 INFO - PROCESS | 1924 | 19:22:59 INFO - PROCESS | 1924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:72.00 stddev:9.32 (13.0%) stddev-sans-first:9.68 19:22:59 INFO - PROCESS | 1924 | Values: 68.0 68.0 69.0 66.0 75.0 87.0 67.0 64.0 81.0 90.0 19:22:59 INFO - PROCESS | 1924 | -------- Summary: end -------- 19:22:59 INFO - PROCESS | 1924 | 19:23:00 INFO - TEST-INFO | 1924: exit 0 19:23:00 INFO - TEST-OK | kraken | took 62487ms 19:23:00 INFO - SUITE-END | took 1178s 19:23:01 INFO - Completed test suite (00:19:38) 19:23:01 INFO - javascript benchmark 19:23:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7071.638724040794, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3303.7522185836056, 3322.634510203877, 3360.411927912616, 3372.7301815854735, 3375.8818441354556, 5429.294191755076, 5571.1086226203815, 5594.964931487672, 5600.963821692984, 5651.886962260763, 4440.844570440036, 5445.0, 5561.694106824123, 5586.86032849179, 5632.5212356949705, 4060.817263223147, 4988.226824842155, 5145.74271286436, 5185.274061631375, 5205.984832957575, 5002.7248501332415, 5050.191969284915, 5213.322268105141, 5239.79040838366, 5266.8419947401635, 5025.522575355372, 5039.143345631252, 5164.483551644843, 5188.299579556749, 5213.165893457048, 5115.897682046339, 5124.76938537763, 5139.717315547643, 5143.5113664201845, 5176.0, 5034.270030845543, 5054.494550544953, 5059.519345662156, 5103.693778373309, 5108.0, 5377.623566350357, 5409.107497262947, 5413.2692086568595, 5587.9941610510095, 5672.177534257509, 6152.815415537541, 6167.599106058092, 6175.351588083232, 6176.69116544171, 6179.258488981306, 6160.476359509402, 6162.22972128484, 6168.1056246843955, 6173.506119510428, 6177.567570270083, 5555.2778138842505, 5591.832245032656, 5849.444302791228, 5868.178455016301, 5891.145783861316, 6083.513318934474, 6146.4775494082605, 6195.938040619626, 6243.968780156161, 6265.154204182377, 5844.298684157843, 5879.147523609053, 6086.513078953673, 6101.298350689639, 6105.45050945417, 5937.732802023919, 6125.662799505688, 6134.099846298167, 6176.69116544171, 6186.938130618636, 5906.822795316148, 5962.0, 6160.784372547029, 6166.105914642351, 6178.165947597017, 6103.671041328314, 6107.572469927062, 6133.754649814046, 6171.506279497719, 6202.162708034448, 4906.754662266872, 4911.901761964812, 4914.90170196594, 4923.950760492349, 4955.90088198234, 4269.61573458384, 4396.120775844844, 4403.361512580658, 4433.490148632884, 4439.067795762861, 4628.95371046292, 5537.861553461115, 5614.466625670555, 5703.0, 5784.421557844266, 6208.142447924442, 6213.285472170758, 6235.064740288993, 6239.313675495692, 6248.937510624926, 5736.311642602915, 5740.971295143498, 5744.425557444306, 5757.193992841006, 5757.539396848242, 5209.244659524424, 5211.140161873324, 5316.441773613792, 5319.441458646864, 5359.892802143935, 6214.9067763984485, 6254.906176407449, 6255.218097737783, 6276.497880169484, 6289.339619340087, 6248.781292654735, 6256.562040657111, 6266.498680105672, 6270.874582508415, 6298.905516417166, 6101.005087479836, 6117.401149625572, 6177.722002509808, 6214.098955651496, 6268.686565671607, 6158.414950579688, 6167.1366008759705, 6169.321374648695, 6170.0, 6183.907241391473, 4679.9064018718755, 5894.616849904743, 5993.790217342372, 6236.438720514994, 6255.280642725963, 5800.651960882361, 5988.490978266722, 5997.5501837363245, 6006.969965150146, 6143.385661433821, 6040.637561746309, 6065.332813390612, 6065.54508411862, 6076.513878889767, 6077.270727512727, 4805.975970120127, 5756.712164391847, 5814.592978491465, 5855.443732845373, 5908.852278693067, 5696.344920334049, 5777.74000169985, 5978.953683105352, 6017.518598512021, 6027.30685971119, 5797.275340582427, 5847.0, 5850.5027072699295, 5856.472917437451, 5875.911861322169], "value": 5592.233158043274, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.7204988807164, 478.15366800762627, 482.74655805702014, 530.5357811914573, 531.5986430245164, 37300.44049339258, 39724.60275397245, 39966.800165999164, 42382.36426453606, 42406.36390454145, 41230.58769412305, 41704.374434383506, 41745.58254417455, 41823.0, 41828.37257441133, 9127.497987610695, 9317.208037316836, 9350.812983740321, 9386.765330866749, 10581.470926453647, 10617.78764424711, 10863.728406789814, 10890.237683362167, 10897.400642964634, 10914.563417463292, 9312.208462280714, 10911.0, 10920.017198452138, 10947.959943805365, 10985.835212471819, 10825.83761243578, 10881.292715973437, 10884.727881802979, 10917.508712107894, 10928.453577321103, 10831.187660925461, 10855.620053298175, 10901.454927253606, 10926.726831829188, 10931.890681093246, 36523.63476365229, 36562.0, 36692.44961325582, 36776.0, 36783.4482482763, 3841.8079096045085, 3919.490466239399, 3927.2341893330813, 3927.273454410943, 3932.213557288525, 27562.96647612387, 27930.0, 28248.435031299257, 28265.57601635977, 28843.85578072096, 3133.0, 3138.2311333723383, 3145.5910731604745, 3152.322250716107, 3206.3106432117206, 444247.0, 445489.7725511384, 447808.0, 449102.5089749093, 449838.0, 43998.560014400085, 45013.0, 54030.729846350514, 54303.45696543063, 54417.63955901055, 49135.75432122817, 57209.71395142998, 58108.41891581115, 60894.39105608976, 62083.68958155271, 13844.584662459942, 14021.738043576128, 14060.648483787987, 14068.648283792987, 14162.787558186636, 10691.572337106429, 10790.784184316426, 10791.946040269748, 10795.784084318428, 10819.783604328028, 17641.823581764274, 17662.470125896245, 17695.55761105957, 17704.203310851044, 17739.822601774074, 7709.922900770921, 7809.3752499799875, 7851.0, 7932.286094251545, 7987.600619968978, 773.8684423647993, 775.25962705616, 859.9312055035582, 860.5009094725044, 867.7353407210861, 29743.25641858971, 29920.0, 30050.84974575157, 30466.695333046828, 30584.0, 856.6444925355908, 861.4357595774777, 991.9900800991898, 1011.0950699124243, 1023.1252279301091, 13377.53178638743, 14179.007469477245, 14185.961043733863, 14282.35729392159, 14387.064840785315, 622958.8852055711, 627406.0, 630437.0, 631022.0, 633659.0, 50717.74641126845, 50962.49037509652, 51034.21380251674, 51071.74464127656, 51183.23225151626, 1346.4681450826868, 1391.08883681189, 1413.724323756878, 1416.4759039155579, 1416.6316757643087, 25899.0, 26595.202143935712, 27068.0, 27191.0, 27525.862370688017, 44838.0, 45340.54659453363, 45489.54510454853, 45596.54403455923, 45811.62565123052, 490639.0, 552271.0, 558534.0, 562481.0, 562955.0, 21138.682919756524, 21623.026963786353, 23199.420014499774, 23583.29250122499, 23685.64471532894, 39776.2044759109, 39966.600333996284, 40873.182536349705, 41247.793761031004, 42139.578604213566, 34542.65457345495, 34911.0, 35165.82417087898, 35768.82115589405, 35976.82011589925, 31291.061268161993, 32478.0, 34629.82685086558, 35176.0, 35669.46495802617, 34345.0, 34741.0, 35074.82462587671, 35116.64883351236, 35266.82366588253, 26139.954401823714, 28173.154805355873, 31280.21799455032, 31375.744970200936, 31480.37039259248, 23116.884415577813, 23485.295441136794, 23494.412639684146, 23725.881370593037, 23859.761402386448], "value": 18959.770096871005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.7263506592786, 385.8148088917318, 394.4418647613627, 405.21995159318305, 422.91522245440444, 14622.561323160297, 19369.612607747837, 19987.400377988648, 20851.791482085195, 20894.582108357823, 20833.895830520825, 20976.685349719766, 21348.35954921355, 21353.57292854142, 21508.924553772325, 5406.324209473806, 5727.284089488814, 5798.855028624276, 5857.857717745042, 5873.941260587403, 5540.972295138518, 5796.855078623047, 5904.232449781543, 5915.467607915287, 5921.733521991499, 5791.971040144794, 5890.970545147268, 5955.166276721263, 5963.045912653976, 5986.281646202462, 5725.942740572604, 5954.851128721773, 5972.25346831646, 6399.968000159969, 6481.189851268591, 5041.747912604392, 5696.658200507983, 5801.941980580183, 5813.302403711539, 5815.912761308584, 10205.285630005903, 13165.275909824955, 13232.801507977389, 13497.055206135574, 13709.794353084711, 2492.800575953919, 2814.6059551662784, 2961.8074825136514, 2963.3332500187503, 2973.1229287360065, 9912.08472653305, 9960.203183745283, 10191.388516689023, 10429.843552346721, 10583.312084714546, 1742.947711568655, 1782.7949785774542, 1796.6676164909534, 1807.475832008716, 1810.5564136786572, 100108.49945750297, 125063.12405313927, 125572.0706532878, 126822.0, 129299.0, 11516.596919107791, 11869.050475961902, 11924.1653084285, 11951.940240298916, 11969.581064662869, 13578.0, 14196.657551503886, 15673.764893526606, 15822.208889555477, 15856.0, 7709.653065612061, 7978.0, 8054.8791768122355, 8082.757517274491, 8194.344452443791, 7597.0, 7601.809954751176, 7634.8091297718, 7752.5348479091435, 7769.689212431553, 4818.0, 4848.296996935495, 4848.927266091011, 4865.416150062015, 4948.713334533048, 1747.4146161036194, 1995.5210749420326, 2051.415346626234, 2060.3406909788723, 2064.8038436348525, 983.1446641421866, 1001.7395477175841, 1022.9386236825815, 1031.2832581356035, 1071.3946620159586, 17432.65134697324, 20255.29106481266, 20460.795392046188, 20499.8975005124, 20624.27815026497, 1016.6086056868011, 1031.3554028732042, 1048.4600430778155, 1053.262716098734, 1070.619929924881, 9198.377168438714, 10491.68524944253, 10779.943043731046, 10796.136309095253, 10796.838047429295, 450878.4912150902, 581415.1858481446, 586261.0, 599781.0, 613198.0, 105240.0, 105527.0, 130487.0, 132049.0, 133882.0, 998.272987731229, 1015.6496008876926, 1033.4625994482826, 1035.1098055672267, 1037.4086770540719, 13643.97670174721, 14167.008309418654, 17488.912555437142, 17895.642087158445, 18298.26806927708, 54774.72612636911, 55445.16832247439, 55734.72132639311, 55974.44025559692, 56405.43594564002, 52759.41721748354, 70969.0, 73099.0, 73513.91346951724, 74061.0, 8202.794930126794, 8307.0, 8308.210719981593, 8427.494350338999, 8543.231109200202, 10972.451377430936, 11043.791241751522, 12380.380980950737, 12510.374481275718, 13011.804822927854, 9188.540572971191, 10713.250072494851, 11086.778264434828, 11194.104471642086, 11233.719157020812, 10103.949480252551, 10792.730181745519, 11127.443627818415, 11178.938000889902, 11220.214584978972, 10013.499325033865, 11199.272047316897, 11373.14701397415, 11426.94286528562, 11490.425478725863, 7114.430845532448, 7604.42966777505, 7624.27569380908, 7917.643706033127, 8471.95764021176, 9394.530273486162, 9763.414195148314, 9788.85316720264, 11449.713757156138, 11699.415029248674], "value": 9366.58942506331, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1406.6694326833199, 1443.0475885915291, 1445.6530432696156, 1450.2603672127216, 1452.012631410641, 7750.8449831003345, 8091.029076510819, 8132.634031468583, 8216.0, 8523.488590684563, 8446.788830279245, 8580.656773729042, 8590.0, 8606.95696521518, 8612.56937153143, 2040.6122836661061, 2195.3194509702043, 2259.265738634946, 2273.943151421211, 2288.54229154169, 2239.9440013999697, 2300.0224904415554, 2303.55080759252, 2314.7569505201964, 2316.108298305156, 2206.0844749428966, 2211.8672879627193, 2223.5108276179294, 2232.8325375596814, 2244.5959727249087, 2162.135145941636, 2223.1774243529917, 2245.7529671736097, 2252.245497758253, 2253.188852013274, 1693.2972816281228, 1779.670760909236, 2032.7052577376346, 2249.0, 2255.796978271947, 8259.008918929707, 8442.324614030862, 8453.70412035582, 8591.613377398033, 8615.741527754177, 5048.949510504922, 5202.635815492917, 5211.270422140903, 5219.243209734605, 5233.058049551079, 3431.588209414861, 3445.500402441632, 3448.499967504698, 3509.5963964144194, 3510.947335789965, 1187.139323990109, 1195.4680167325544, 1212.5392350906686, 1253.7931241345168, 1263.2925561685395, 10943.398113103776, 10955.561777528968, 10957.17821163416, 11066.889331106666, 11107.666769996913, 4212.91574168521, 4478.619317358061, 4539.024109816405, 4549.522300158435, 4561.68068235227, 7468.5145465544565, 8794.956025219833, 8827.117288271122, 8836.160564746468, 8847.11528847123, 5111.488851114933, 5112.36095488064, 5112.6421150519855, 5117.667351622133, 5121.641485096082, 4081.6530594899173, 4368.279233926367, 4598.172328980816, 4649.86050418488, 4793.257045157937, 3280.16355829262, 3547.9001509532127, 3661.23114146027, 3723.9813800930824, 3737.4020156774786, 1160.6169963911889, 1169.2750494693344, 1169.473736818435, 1172.7803084791892, 1180.0618508285934, 715.6493318274113, 729.2306616519622, 755.1542272654661, 781.5467029123095, 781.9100803407567, 4561.2473941799235, 5602.523785478198, 5673.149027645886, 5769.134629805562, 5770.172126152533, 492.83982705620815, 558.8351436326293, 564.8249042796664, 592.9673867937219, 594.7531774313611, 3662.8168591570316, 3770.830312635938, 3832.3293423651307, 3885.922281554353, 3900.570937196906, 9923.55344009507, 10258.640947566799, 10280.383177009404, 10287.485625718833, 10313.381197128196, 10170.542325595366, 10197.439140847177, 10242.53908574116, 10264.43545604984, 10304.896951030543, 7850.097238817495, 7883.2905038546805, 7941.047074351115, 8015.0, 8038.839223215503, 4353.695241333076, 5612.887742245214, 5664.348599910898, 5671.383655658283, 5701.629394089371, 9198.770030749285, 9232.353735238468, 9272.814543709223, 9335.57989890443, 9337.253019758538, 9282.0, 9355.345125841126, 9618.0, 9652.0, 9667.70996870095, 6659.766908158192, 6794.626295553792, 6831.863362732618, 6853.897191542231, 6873.621950792754, 7600.695972161052, 7779.416543759354, 7853.37173026168, 7874.488158269694, 7976.880346794686, 7101.11236095488, 7243.855122897618, 7243.963780181065, 7247.710091596277, 7302.0, 6177.722002509808, 6447.677616119269, 7010.929890701028, 7031.296870312928, 7049.330313620198, 6335.746570137143, 6429.7749578764515, 6524.478041756743, 6531.640759758069, 6540.0, 4081.6530594898577, 4932.7286999215385, 4974.477679843709, 5067.5185857343495, 5100.107481190703, 5001.0, 5029.315179414791, 5166.328377310925, 5166.535011848951, 5241.266222728745], "value": 4283.606576493858, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.9428761391528, 296.67365897512724, 298.54919072200977, 357.7960562479386, 379.1393536671755, 5011.949880501194, 5115.514026167518, 5283.63014588979, 5408.729563521828, 5425.891482170359, 5157.974210128944, 5221.321228240324, 5230.581553475722, 5233.8953220935555, 5242.947570524294, 3503.316853213624, 3986.8604598839047, 3996.5803590623073, 4004.9599504004877, 4051.7366371185926, 3686.2811751708427, 4004.7396919200305, 4007.018280521276, 4008.7394319369146, 4023.5171779386515, 3918.8628398006076, 3925.41118832176, 3934.783586902719, 3966.583508731585, 3980.761154330735, 3494.5457090578316, 3967.0082479380153, 3969.0474286171398, 3974.9602503975025, 3975.264576053439, 2783.8608069596644, 3067.84660766963, 3149.0, 3285.6385797562248, 3520.964790352115, 3998.7800670963084, 4403.8238470461465, 4702.941838086437, 4943.332650092228, 5104.69371837691, 3570.7143428525656, 4558.974230798077, 4574.9542504574865, 4593.816247350102, 4616.630669546428, 4633.061897387228, 4890.510948905081, 5140.794368225266, 5318.962802253562, 5382.712347252441, 3412.4710669846213, 3422.9486557701653, 3803.9619603804163, 3841.8079096045085, 3860.498135242429, 5518.530924871391, 5698.971505142489, 5757.309122905236, 5804.477597016246, 5810.1865738796605, 3735.7758534488016, 3811.7522361046445, 3840.8847734568008, 3842.2315536892734, 3847.2882516734494, 3292.901212963615, 3928.4303775952326, 3932.528096628423, 3943.92112157761, 3945.0137465633593, 4350.978245108754, 4457.153140903218, 4552.226121559343, 4614.97692511542, 4619.538046195354, 5362.758675859595, 5559.054330984204, 5609.719514024364, 5620.87582483505, 5637.68992705397, 1145.7078444996473, 1265.5950095969386, 1280.4558062823448, 1281.4681907008487, 1285.2288626823831, 772.5360441962449, 807.4751411582519, 865.3077537969599, 883.6156272021691, 883.9779005524913, 4118.855840045584, 4510.368548403226, 4652.581267685924, 4796.616270698336, 5020.59835213182, 4701.576858082789, 4950.257461380822, 5458.863528411822, 5494.36814766299, 5571.66570005801, 3747.6439738224826, 4408.559144085566, 4472.0, 4811.992504684572, 4907.852764417074, 2577.8582177980015, 2619.3105446986588, 2862.770978321771, 2870.8564571771326, 2879.2226098953583, 5617.927002922848, 5768.89435356092, 5769.9711501442225, 5773.682447465346, 5812.651240925474, 4434.728600282632, 5084.186530155232, 5246.658967167122, 5690.687012214368, 5692.7722891083895, 4739.980904105565, 5634.014047541746, 5664.433556644302, 5674.858128546819, 5710.885782284331, 4600.953990460186, 5464.781408743605, 5485.50630443262, 5513.195894832713, 5536.200734761138, 4363.105563359567, 4944.604431645532, 5191.273221749034, 5443.755031023693, 5639.802606908738, 4883.949950760603, 5137.8715532112, 5625.971870140623, 5889.911651325147, 5962.493188079062, 3859.3053250414073, 3892.435596838386, 3914.451976723204, 3924.3328634132836, 3926.0173612325593, 5456.744948661751, 5611.971940140274, 5747.109198074305, 5823.1847541343395, 5852.268466441695, 4509.9774501128595, 5324.494173053554, 5602.579806514609, 5621.437856214346, 5627.324721033502, 5623.325200975909, 5637.661740295595, 5638.774449021993, 5653.0, 5682.516986056232, 4956.7769450375545, 5448.828501872116, 5496.835094947158, 5506.394296627448, 5519.597267170064, 4886.731229782396, 5028.396592408788, 5584.218209450762, 5633.6056476047925, 5659.745311460912, 4478.245878784589, 5209.218617207298, 5506.669599824023, 5510.008198524304, 5555.2778138841695], "value": 3985.5709465023456, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.022074206482, 701.7789396340156, 711.7508871894836, 766.8619648463274, 814.4950130918832, 14132.576022719322, 14980.925095374536, 15087.170205638698, 15095.773563396544, 15115.244237788122, 13714.24571648559, 13838.031337806358, 13868.09857359271, 13903.860961390408, 13936.721265574683, 868.6438560190339, 871.8474267003281, 884.7168905950099, 891.233539156325, 894.9955250223773, 897.5287973813735, 901.8106197698459, 902.6389444222298, 902.7427183252775, 902.8284625921087, 884.9247813935823, 918.6830543462495, 938.648006997376, 940.8494640857464, 942.9481378524179, 922.5802259971697, 931.7111695374422, 932.8600709893536, 935.8455854784021, 939.3143005605878, 703.0473708125519, 704.6828926982878, 705.1150805738765, 706.2055187913597, 709.3651182191909, 11180.496877640444, 11378.431078446045, 14164.36260368286, 14917.254137293092, 14954.700905981928, 13531.526396576073, 13631.250281234528, 13814.861851381458, 13895.79156312656, 13896.513622023282, 10746.140308775279, 11368.715782105432, 11586.768264634744, 11652.592159274385, 12133.575324863676, 3561.679448849616, 3638.5269914911155, 3654.104744337628, 3670.926581468382, 3769.1707824278615, 98652.01347986572, 98963.0103698961, 99278.50360748223, 100221.0, 100228.49885750524, 10619.575216991389, 10641.5211315491, 10873.130149588014, 10907.890921090688, 10920.781584368267, 17619.119044047748, 21192.046357913932, 21928.45178870541, 21929.0, 21941.780582194293, 7410.110786705522, 7411.629418529052, 7480.513766605262, 7489.101307842985, 7561.09266887977, 4173.728707633994, 4183.393407955829, 4185.204811085884, 4279.272523670983, 4340.153670034376, 3580.122869896892, 3639.8544058237376, 3659.469376940329, 3680.227152297994, 3684.871029513954, 626.840910558439, 627.3005598757353, 633.7781776378323, 649.1334069017914, 650.612885333226, 650.1450592470981, 666.9966650166718, 677.4174210179242, 692.9986169984325, 695.4471195399669, 8864.06666033896, 9716.869662327523, 9936.850947235796, 10133.543990520444, 10435.895641043644, 677.3937326093119, 686.7115811359241, 689.8482333886537, 695.5687473766297, 706.5548704316351, 4741.66808323421, 4836.540528649773, 4876.0, 4876.609871210295, 4879.072976134523, 96090.51954740181, 96380.0, 97260.51369743106, 97441.0, 99056.0, 73606.63196683982, 74654.0, 74665.0, 86148.0, 88443.55778221197, 38384.42423363652, 68255.83130253106, 74424.0, 75420.86868697083, 76010.85983710249, 10677.359358438518, 10712.89287107119, 10827.566897324019, 10846.783064338826, 10883.292585981886, 43952.78023609862, 47220.52779472162, 49664.75167624139, 50253.0, 51890.0, 60415.69792151011, 64213.71572568616, 65059.0, 66698.66650666716, 67866.6426671454, 12331.383430828244, 12465.5013799447, 12555.309457979898, 12974.805377919527, 13224.735505290033, 14145.646358841112, 14177.574672759834, 14180.787288190892, 14399.64000899944, 14966.32651530662, 13221.471141154247, 13333.799468605603, 13347.132436391992, 13351.866481335452, 13537.59387218385, 13234.404451799499, 13314.46742130304, 13372.264525450804, 13392.598222053353, 13455.327233638474, 12843.614691559269, 13176.011799114913, 13194.208347499181, 13537.526186583422, 13557.0, 8283.58582070882, 10877.67366978992, 10933.398663073289, 11149.442527873736, 11271.718207044889, 9408.871164483347, 10249.180065594883, 10616.203784716332, 10805.729856753644, 10839.0], "value": 7375.1825482407685, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 119.0, 118.0, 128.0, 177.0, 119.0, 119.0, 119.0, 122.0], "value": 124.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 137.0, 113.0, 180.0, 109.0, 146.0, 149.0, 118.0, 167.0, 143.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 225.0, 230.0, 266.0, 280.0, 200.0, 198.0, 198.0, 196.0, 199.0], "value": 219.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 60.0, 91.0, 51.0, 85.0, 85.0, 54.0, 91.0, 73.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 83.0, 72.0, 78.0, 75.0, 99.0, 101.0, 89.0, 84.0], "value": 83.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 91.0, 85.0, 79.0, 133.0, 139.0, 84.0, 88.0, 87.0], "value": 96.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 98.0, 96.0, 96.0, 96.0, 100.0, 95.0, 98.0], "value": 96.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 145.0, 138.0, 94.0, 134.0, 80.0, 144.0, 143.0, 113.0, 90.0], "value": 117.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 64.0, 66.0, 67.0, 64.0, 64.0, 65.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 69.0, 79.0, 76.0, 69.0, 68.0, 74.0, 69.0, 71.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 93.0, 88.0, 90.0, 90.0, 90.0, 93.0, 89.0, 93.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 136.0, 158.0, 137.0, 150.0, 156.0, 154.0, 142.0, 189.0, 179.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 176.0, 173.0, 175.0, 176.0, 176.0, 178.0, 234.0, 173.0, 202.0], "value": 184.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 66.0, 75.0, 87.0, 67.0, 64.0, 81.0, 90.0], "value": 73.5, "unit": "score"}]}]} 19:23:01 INFO - Return code: 0 19:23:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:23:01 ERROR - # TBPL SUCCESS # 19:23:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:23:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:23:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:23:01 INFO - 2017-02-05 19:23:01.215 screenresolution[1929:19200] starting screenresolution argv=screenresolution get 19:23:01 INFO - 2017-02-05 19:23:01.218 screenresolution[1929:19200] Display 0: 1600x1200x32@60 19:23:01 INFO - 2017-02-05 19:23:01.224 screenresolution[1930:19203] starting screenresolution argv=screenresolution list 19:23:01 INFO - Available Modes on Display 0 19:23:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:23:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:23:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:23:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:23:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:23:01 INFO - Intel Iris: 19:23:01 INFO - Chipset Model: Intel Iris 19:23:01 INFO - Type: GPU 19:23:01 INFO - Bus: Built-In 19:23:01 INFO - VRAM (Dynamic, Max): 1536 MB 19:23:01 INFO - Vendor: Intel (0x8086) 19:23:01 INFO - Device ID: 0x0a2e 19:23:01 INFO - Revision ID: 0x0009 19:23:01 INFO - Displays: 19:23:01 INFO - Display: 19:23:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:23:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:23:01 INFO - Display Serial Number: 1600x1200 60 19:23:01 INFO - Main Display: Yes 19:23:01 INFO - Mirror: Off 19:23:01 INFO - Online: Yes 19:23:01 INFO - Rotation: Supported 19:23:01 INFO - Return code: 0 19:23:01 INFO - Running post-action listener: _resource_record_post_action 19:23:01 INFO - [mozharness: 2017-02-06 03:23:01.463292Z] Finished run-tests step (success) 19:23:01 INFO - Running post-run listener: _resource_record_post_run 19:23:01 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 1525248; Write bytes: 556627456; Read time: 11; Write time: 1669 19:23:01 INFO - TinderboxPrint: CPU usage
54.4% 19:23:01 INFO - TinderboxPrint: I/O read bytes / time
1,525,248 / 11 19:23:01 INFO - TinderboxPrint: I/O write bytes / time
556,627,456 / 1,669 19:23:01 INFO - TinderboxPrint: CPU idle
2,189.0 (45.6%) 19:23:01 INFO - TinderboxPrint: CPU system
965.7 (20.1%) 19:23:01 INFO - TinderboxPrint: CPU user
1,651.0 (34.4%) 19:23:01 INFO - TinderboxPrint: Swap in / out
253,112,320 / 0 19:23:01 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 243851776; Write bytes: 238511616; Read time: 18063; Write time: 499 19:23:01 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 1525248; Write bytes: 300675072; Read time: 11; Write time: 1118 19:23:01 INFO - Running post-run listener: _upload_blobber_files 19:23:01 INFO - Blob upload gear active. 19:23:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:23: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 19:23: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'] 19:23: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 19:23:02 INFO - (blobuploader) - INFO - Open directory for files ... 19:23:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:23:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:23:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:23:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:23:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:23:03 INFO - (blobuploader) - INFO - Done attempting. 19:23:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:23:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:23:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:23:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:23:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:23:04 INFO - (blobuploader) - INFO - Done attempting. 19:23:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:23:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:23:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:23:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:23:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:23:05 INFO - (blobuploader) - INFO - Done attempting. 19:23:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:23:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:23:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:23:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:23:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:23:07 INFO - (blobuploader) - INFO - Done attempting. 19:23:07 INFO - (blobuploader) - INFO - Iteration through files over. 19:23:07 INFO - Return code: 0 19:23:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:23:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:23:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0b67710be5496db7883ee5962314f65a358f622c873ac07e2d4fc61581562fb9ec13cba752da4c8acb19056882352a0312d8d866444e08a425e337b37062cec", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87519650f41a0daf8d24f88df74d9651d82c970c55224e380e760fe39f3066c413b7751160398f2f78c32f0ef4825622954ed5c1ebfa7914885938d1e8170011", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dba0d708bc3f70d9801ae877fcb8ad79d0c94427a63a795c857cf937dd3ded53faeaa7faf35366c046a2596afb9d2e96ae4f163fcd47c7fa9a308dc6206be843", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b891b4701a3d16aa0ba8157e2a6447d4b490676f59840ee30fa4e15ac72604420431d4497f879e52d88607df446956d4ebf96e45bbc5625d1ccd7a629b5ae57c"} 19:23:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:23:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:23:07 INFO - Contents: 19:23:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0b67710be5496db7883ee5962314f65a358f622c873ac07e2d4fc61581562fb9ec13cba752da4c8acb19056882352a0312d8d866444e08a425e337b37062cec", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87519650f41a0daf8d24f88df74d9651d82c970c55224e380e760fe39f3066c413b7751160398f2f78c32f0ef4825622954ed5c1ebfa7914885938d1e8170011", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dba0d708bc3f70d9801ae877fcb8ad79d0c94427a63a795c857cf937dd3ded53faeaa7faf35366c046a2596afb9d2e96ae4f163fcd47c7fa9a308dc6206be843", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b891b4701a3d16aa0ba8157e2a6447d4b490676f59840ee30fa4e15ac72604420431d4497f879e52d88607df446956d4ebf96e45bbc5625d1ccd7a629b5ae57c"} 19:23:07 INFO - Running post-run listener: copy_logs_to_upload_dir 19:23:07 INFO - Copying logs to upload dir... 19:23:07 INFO - mkdir: /builds/slave/test/build/upload/logs 19:23:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.773859 ========= master_lag: 1.23 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-05 19:23:09.067801) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-05 19:23:09.075716) ========= 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.8ixrJK0iyO/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.WwkuqfxomI/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0b67710be5496db7883ee5962314f65a358f622c873ac07e2d4fc61581562fb9ec13cba752da4c8acb19056882352a0312d8d866444e08a425e337b37062cec", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87519650f41a0daf8d24f88df74d9651d82c970c55224e380e760fe39f3066c413b7751160398f2f78c32f0ef4825622954ed5c1ebfa7914885938d1e8170011", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dba0d708bc3f70d9801ae877fcb8ad79d0c94427a63a795c857cf937dd3ded53faeaa7faf35366c046a2596afb9d2e96ae4f163fcd47c7fa9a308dc6206be843", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b891b4701a3d16aa0ba8157e2a6447d4b490676f59840ee30fa4e15ac72604420431d4497f879e52d88607df446956d4ebf96e45bbc5625d1ccd7a629b5ae57c"} build_url:https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011056 build_url: 'https://queue.taskcluster.net/v1/task/ITQJl9t9R_6L_rqO_CFbsw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0b67710be5496db7883ee5962314f65a358f622c873ac07e2d4fc61581562fb9ec13cba752da4c8acb19056882352a0312d8d866444e08a425e337b37062cec", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87519650f41a0daf8d24f88df74d9651d82c970c55224e380e760fe39f3066c413b7751160398f2f78c32f0ef4825622954ed5c1ebfa7914885938d1e8170011", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dba0d708bc3f70d9801ae877fcb8ad79d0c94427a63a795c857cf937dd3ded53faeaa7faf35366c046a2596afb9d2e96ae4f163fcd47c7fa9a308dc6206be843", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b891b4701a3d16aa0ba8157e2a6447d4b490676f59840ee30fa4e15ac72604420431d4497f879e52d88607df446956d4ebf96e45bbc5625d1ccd7a629b5ae57c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-05 19:23:09.116934) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:23:09.117311) ========= 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.8ixrJK0iyO/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.WwkuqfxomI/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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.005149 ========= master_lag: 0.35 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:23:09.468104) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2017-02-05 19:23:09.468432) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2017-02-05 19:23:14.052363) ========= ========= Total master_lag: 1.71 =========