builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0264 starttime: 1486087964.82 results: success (0) buildid: 20170202164009 builduid: a3241d0ffd8340b9b2ae833b52b1c830 revision: c8102da699dba43d85eb80b70956e80c6793feca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 18:12:44.820647) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 18:12:44.821091) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 18:12:44.821379) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 18:12:45.302561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 18:12:45.302964) ========= 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.41r3Jqqnap/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.WcQxllSi36/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-02 18:12:45-- 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% 153M=0s 2017-02-02 18:12:45 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101029 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 18:12:45.428923) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 18:12:45.432251) ========= 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.41r3Jqqnap/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.WcQxllSi36/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.024416 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 18:12:45.481039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-02 18:12:45.484411) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c8102da699dba43d85eb80b70956e80c6793feca --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 c8102da699dba43d85eb80b70956e80c6793feca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.41r3Jqqnap/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.WcQxllSi36/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-02 18:12:45,594 truncating revision to first 12 chars 2017-02-02 18:12:45,594 Setting DEBUG logging. 2017-02-02 18:12:45,594 attempt 1/10 2017-02-02 18:12:45,595 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c8102da699db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-02 18:12:47,578 unpacking tar archive at: mozilla-central-c8102da699db/testing/mozharness/ program finished with exit code 0 elapsedTime=2.266883 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-02 18:12:47.777530) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 18:12:47.777856) ========= script_repo_revision: c8102da699dba43d85eb80b70956e80c6793feca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 18:12:47.778246) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 18:12:47.778525) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 18:12:47.797753) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-02 18:12:47.798103) ========= /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.41r3Jqqnap/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.WcQxllSi36/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 18:12:48 INFO - MultiFileLogger online at 20170202 18:12:48 in /builds/slave/test 18:12:48 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 18:12:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:12:48 INFO - {'append_to_log': False, 18:12:48 INFO - 'base_work_dir': '/builds/slave/test', 18:12:48 INFO - 'blob_upload_branch': 'Firefox', 18:12:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:12:48 INFO - 'branch': 'Firefox', 18:12:48 INFO - 'buildbot_json_path': 'buildprops.json', 18:12:48 INFO - 'config_files': ('talos/mac_config.py',), 18:12:48 INFO - 'default_actions': ('clobber', 18:12:48 INFO - 'read-buildbot-config', 18:12:48 INFO - 'download-and-extract', 18:12:48 INFO - 'populate-webroot', 18:12:48 INFO - 'create-virtualenv', 18:12:48 INFO - 'install', 18:12:48 INFO - 'run-tests'), 18:12:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:12:48 INFO - 'download_minidump_stackwalk': True, 18:12:48 INFO - 'download_symbols': 'ondemand', 18:12:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:12:48 INFO - 'tooltool.py': '/tools/tooltool.py', 18:12:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:12:48 INFO - '/tools/misc-python/virtualenv.py')}, 18:12:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:12:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:12:48 INFO - 'installer_path': 'installer.exe', 18:12:48 INFO - 'log_level': 'info', 18:12:48 INFO - 'log_name': 'talos', 18:12:48 INFO - 'log_to_console': True, 18:12:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:12:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:12:48 INFO - 'opt_config_files': (), 18:12:48 INFO - 'pip_index': False, 18:12:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:12:48 INFO - 'cmd': ('bash', 18:12:48 INFO - '-c', 18:12:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:12:48 INFO - 'enabled': True, 18:12:48 INFO - 'halt_on_failure': False, 18:12:48 INFO - 'name': 'check_screen_resolution'},), 18:12:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:12:48 INFO - 'cmd': ('bash', 18:12:48 INFO - '-c', 18:12:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:12:48 INFO - 'enabled': True, 18:12:48 INFO - 'halt_on_failure': False, 18:12:48 INFO - 'name': 'check_screen_resolution'},), 18:12:48 INFO - 'run_cmd_checks_enabled': True, 18:12:48 INFO - 'sps_profile': False, 18:12:48 INFO - 'sps_profile_interval': 0, 18:12:48 INFO - 'suite': 'dromaeojs-e10s', 18:12:48 INFO - 'system_bits': '32', 18:12:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:12:48 INFO - 'title': 't-yosemite-r7-0264', 18:12:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:12:48 INFO - 'use_talos_json': True, 18:12:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:12:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:12:48 INFO - 'work_dir': 'build'} 18:12:48 INFO - [mozharness: 2017-02-03 02:12:48.011515Z] Running clobber step. 18:12:48 INFO - Running pre-action listener: _resource_record_pre_action 18:12:48 INFO - Running main action method: clobber 18:12:48 INFO - rmtree: /builds/slave/test/build 18:12:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:12:50 INFO - Running post-action listener: _resource_record_post_action 18:12:50 INFO - [mozharness: 2017-02-03 02:12:50.452657Z] Finished clobber step (success) 18:12:50 INFO - [mozharness: 2017-02-03 02:12:50.452791Z] Running read-buildbot-config step. 18:12:50 INFO - Running pre-action listener: _resource_record_pre_action 18:12:50 INFO - Running main action method: read_buildbot_config 18:12:50 INFO - Using buildbot properties: 18:12:50 INFO - { 18:12:50 INFO - "project": "", 18:12:50 INFO - "product": "firefox", 18:12:50 INFO - "script_repo_revision": "production", 18:12:50 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 18:12:50 INFO - "repository": "", 18:12:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 18:12:50 INFO - "buildid": "20170202164009", 18:12:50 INFO - "pgo_build": "False", 18:12:50 INFO - "basedir": "/builds/slave/test", 18:12:50 INFO - "buildnumber": 41, 18:12:50 INFO - "slavename": "t-yosemite-r7-0264", 18:12:50 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 18:12:50 INFO - "platform": "yosemite_r7", 18:12:50 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:12:50 INFO - "branch": "mozilla-central", 18:12:50 INFO - "repo_path": "mozilla-central", 18:12:50 INFO - "revision": "c8102da699dba43d85eb80b70956e80c6793feca", 18:12:50 INFO - "stage_platform": "macosx64", 18:12:50 INFO - "builduid": "a3241d0ffd8340b9b2ae833b52b1c830", 18:12:50 INFO - "slavebuilddir": "test" 18:12:50 INFO - } 18:12:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 18:12:50 INFO - Running post-action listener: _resource_record_post_action 18:12:50 INFO - [mozharness: 2017-02-03 02:12:50.456288Z] Finished read-buildbot-config step (success) 18:12:50 INFO - [mozharness: 2017-02-03 02:12:50.456435Z] Running download-and-extract step. 18:12:50 INFO - Running pre-action listener: _resource_record_pre_action 18:12:50 INFO - Running main action method: download_and_extract 18:12:50 INFO - mkdir: /builds/slave/test/build/tests 18:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:50 INFO - trying https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 18:12:50 INFO - Downloading https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/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 18:12:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/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 18:12:51 INFO - Downloaded 1199 bytes. 18:12:51 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 18:12:51 INFO - Using the following test package requirements: 18:12:51 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 18:12:51 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:12:51 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 18:12:51 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:12:51 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 18:12:51 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:12:51 INFO - u'jsshell-mac.zip'], 18:12:51 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:12:51 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 18:12:51 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 18:12:51 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:12:51 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 18:12:51 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:12:51 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 18:12:51 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:12:51 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 18:12:51 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:12:51 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 18:12:51 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:12:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 18:12:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:12:51 INFO - Fetch https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 18:12:53 INFO - Expected file size: 34849469 18:12:53 INFO - Obtained file size: 34849469 18:13:00 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 18:13:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 18:13:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:13:00 INFO - Fetch https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 18:13:01 INFO - Expected file size: 34849469 18:13:01 INFO - Obtained file size: 34849469 18:13:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 18:13:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:13:08 INFO - Fetch https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 18:13:09 INFO - Expected file size: 14403454 18:13:09 INFO - Obtained file size: 14403454 18:13:10 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')]} 18:13:10 INFO - trying https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:13:10 INFO - Downloading https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 18:13:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/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 18:13:12 INFO - Downloaded 70174639 bytes. 18:13:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:13:12 INFO - mkdir: /builds/slave/test/properties 18:13:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:13:12 INFO - Writing to file /builds/slave/test/properties/build_url 18:13:12 INFO - Contents: 18:13:12 INFO - build_url:https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:13:12 INFO - Running post-action listener: _resource_record_post_action 18:13:12 INFO - Running post-action listener: set_extra_try_arguments 18:13:12 INFO - [mozharness: 2017-02-03 02:13:12.959705Z] Finished download-and-extract step (success) 18:13:12 INFO - [mozharness: 2017-02-03 02:13:12.959857Z] Running populate-webroot step. 18:13:12 INFO - Running pre-action listener: _resource_record_pre_action 18:13:12 INFO - Running main action method: populate_webroot 18:13:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:13:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:13:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:13:12 INFO - '--tppagecycles', 18:13:12 INFO - '7'], 18:13:12 INFO - 'tests': ['tsvgm']}}, 18:13:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:13:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:13:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:13:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:13:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:13:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:13:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:13:12 INFO - 'talos_options': ['--disable-e10s'], 18:13:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:13:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:13:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:13:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:13:12 INFO - 'talos_options': ['--disable-e10s'], 18:13:12 INFO - 'tests': ['damp', 'tps']}, 18:13:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:13:12 INFO - 'tests': ['damp', 'tps']}, 18:13:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:13:12 INFO - 'tests': ['dromaeo_dom']}, 18:13:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:13:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:13:12 INFO - 'tests': ['basic_compositor_video']}, 18:13:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:13:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:13:12 INFO - 'tests': ['a11yr', 18:13:12 INFO - 'ts_paint', 18:13:12 INFO - 'tpaint', 18:13:12 INFO - 'sessionrestore', 18:13:12 INFO - 'sessionrestore_no_auto_restore', 18:13:12 INFO - 'tabpaint']}, 18:13:12 INFO - 'other-e10s': {'tests': ['a11yr', 18:13:12 INFO - 'ts_paint', 18:13:12 INFO - 'tpaint', 18:13:12 INFO - 'sessionrestore', 18:13:12 INFO - 'sessionrestore_no_auto_restore', 18:13:12 INFO - 'tabpaint']}, 18:13:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:13:12 INFO - 'ts_paint', 18:13:12 INFO - 'tpaint', 18:13:12 INFO - 'sessionrestore', 18:13:12 INFO - 'sessionrestore_no_auto_restore', 18:13:12 INFO - 'tabpaint']}, 18:13:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:13:12 INFO - 'ts_paint', 18:13:12 INFO - 'tpaint', 18:13:12 INFO - 'sessionrestore', 18:13:12 INFO - 'sessionrestore_no_auto_restore', 18:13:12 INFO - 'tabpaint']}, 18:13:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:13:12 INFO - 'tests': ['a11yr', 18:13:12 INFO - 'ts_paint', 18:13:12 INFO - 'tpaint', 18:13:12 INFO - 'sessionrestore', 18:13:12 INFO - 'sessionrestore_no_auto_restore', 18:13:12 INFO - 'tabpaint']}, 18:13:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:13:12 INFO - 'tests': ['a11yr', 18:13:12 INFO - 'ts_paint', 18:13:12 INFO - 'tpaint', 18:13:12 INFO - 'sessionrestore', 18:13:12 INFO - 'sessionrestore_no_auto_restore', 18:13:12 INFO - 'tabpaint']}, 18:13:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:13:12 INFO - 'tests': ['tsvgx', 18:13:12 INFO - 'tsvgr_opacity', 18:13:12 INFO - 'tart', 18:13:12 INFO - 'tscrollx', 18:13:12 INFO - 'cart', 18:13:12 INFO - 'tsvg_static']}, 18:13:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:13:12 INFO - 'tsvgr_opacity', 18:13:12 INFO - 'tart', 18:13:12 INFO - 'tscrollx', 18:13:12 INFO - 'cart', 18:13:12 INFO - 'tsvg_static']}, 18:13:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:13:12 INFO - 'talos_options': ['--disable-e10s'], 18:13:12 INFO - 'tests': ['tp5o']}, 18:13:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:13:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:13:12 INFO - 'talos_options': ['--disable-e10s', 18:13:12 INFO - '--xperf_path', 18:13:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:13:12 INFO - 'tests': ['tp5n']}, 18:13:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:13:12 INFO - 'talos_options': ['--xperf_path', 18:13:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:13:12 INFO - 'tests': ['tp5n']}}, 18:13:12 INFO - 'talos.zip': {'path': '', 18:13:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:13:12 INFO - Running post-action listener: _resource_record_post_action 18:13:12 INFO - [mozharness: 2017-02-03 02:13:12.977985Z] Finished populate-webroot step (success) 18:13:12 INFO - [mozharness: 2017-02-03 02:13:12.978120Z] Running create-virtualenv step. 18:13:12 INFO - Running pre-action listener: _resource_record_pre_action 18:13:12 INFO - Running main action method: create_virtualenv 18:13:12 INFO - Creating virtualenv /builds/slave/test/build/venv 18:13:12 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 18:13:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:13:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:13:13 INFO - Using real prefix '/tools/python27' 18:13:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:13:13 INFO - Installing distribute.............................................................................................................................................................................................done. 18:13:16 INFO - Installing pip.................done. 18:13:16 INFO - Return code: 0 18:13:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:13:16 INFO - Reading from file tmpfile_stdout 18:13:16 INFO - Output received: 18:13:16 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) 18:13:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:16 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 0x1097a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f0c73d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109581d30>, '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 0x1094a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109576be8>, '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.41r3Jqqnap/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.WcQxllSi36/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 18:13:16 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 18:13:16 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 18:13:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41r3Jqqnap/Render', 18:13:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:16 INFO - 'HOME': '/Users/cltbld', 18:13:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:16 INFO - 'LOGNAME': 'cltbld', 18:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:16 INFO - 'MOZ_NO_REMOTE': '1', 18:13:16 INFO - 'NO_EM_RESTART': '1', 18:13:16 INFO - 'PAGER': '/bin/cat', 18:13:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:16 INFO - 'PWD': '/builds/slave/test', 18:13:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:16 INFO - 'SHELL': '/bin/bash', 18:13:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcQxllSi36/Listeners', 18:13:16 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 18:13:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:16 INFO - 'USER': 'cltbld', 18:13:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:16 INFO - 'XPC_FLAGS': '0x0', 18:13:16 INFO - 'XPC_SERVICE_NAME': '0', 18:13:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:13:17 INFO - Cleaning up... 18:13:17 INFO - Return code: 0 18:13:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f0c73d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109581d30>, '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 0x1094a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109576be8>, '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.41r3Jqqnap/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.WcQxllSi36/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 18:13:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:13:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41r3Jqqnap/Render', 18:13:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:17 INFO - 'HOME': '/Users/cltbld', 18:13:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:17 INFO - 'LOGNAME': 'cltbld', 18:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:17 INFO - 'MOZ_NO_REMOTE': '1', 18:13:17 INFO - 'NO_EM_RESTART': '1', 18:13:17 INFO - 'PAGER': '/bin/cat', 18:13:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:17 INFO - 'PWD': '/builds/slave/test', 18:13:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:17 INFO - 'SHELL': '/bin/bash', 18:13:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcQxllSi36/Listeners', 18:13:17 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 18:13:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:17 INFO - 'USER': 'cltbld', 18:13:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:17 INFO - 'XPC_FLAGS': '0x0', 18:13:17 INFO - 'XPC_SERVICE_NAME': '0', 18:13:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:17 INFO - Downloading/unpacking psutil>=3.1.1 18:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:13:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:13:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:13:21 INFO - Installing collected packages: psutil 18:13:21 INFO - Running setup.py install for psutil 18:13:21 INFO - building 'psutil._psutil_osx' extension 18:13:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:13:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:13:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:13:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 18:13:21 INFO - building 'psutil._psutil_posix' extension 18:13:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:13:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:13:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:13:21 INFO - ^ 18:13:21 INFO - 1 warning generated. 18:13:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:13:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:13:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:13:22 INFO - Successfully installed psutil 18:13:22 INFO - Cleaning up... 18:13:22 INFO - Return code: 0 18:13:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:13:22 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')]} 18:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:22 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')]} 18:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:22 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 0x1097a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f0c73d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109581d30>, '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 0x1094a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109576be8>, '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.41r3Jqqnap/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.WcQxllSi36/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 18:13:22 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 18:13:22 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 18:13:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41r3Jqqnap/Render', 18:13:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:22 INFO - 'HOME': '/Users/cltbld', 18:13:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:22 INFO - 'LOGNAME': 'cltbld', 18:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:22 INFO - 'MOZ_NO_REMOTE': '1', 18:13:22 INFO - 'NO_EM_RESTART': '1', 18:13:22 INFO - 'PAGER': '/bin/cat', 18:13:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:22 INFO - 'PWD': '/builds/slave/test', 18:13:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:22 INFO - 'SHELL': '/bin/bash', 18:13:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcQxllSi36/Listeners', 18:13:22 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 18:13:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:22 INFO - 'USER': 'cltbld', 18:13:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:22 INFO - 'XPC_FLAGS': '0x0', 18:13:22 INFO - 'XPC_SERVICE_NAME': '0', 18:13:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:13:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:13:25 INFO - Installing collected packages: mozsystemmonitor 18:13:25 INFO - Running setup.py install for mozsystemmonitor 18:13:25 INFO - Successfully installed mozsystemmonitor 18:13:25 INFO - Cleaning up... 18:13:25 INFO - Return code: 0 18:13:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:13:25 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')]} 18:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:25 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')]} 18:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:25 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 0x1097a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f0c73d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109581d30>, '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 0x1094a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109576be8>, '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.41r3Jqqnap/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.WcQxllSi36/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 18:13:25 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 18:13:25 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 18:13:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41r3Jqqnap/Render', 18:13:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:25 INFO - 'HOME': '/Users/cltbld', 18:13:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:25 INFO - 'LOGNAME': 'cltbld', 18:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:25 INFO - 'MOZ_NO_REMOTE': '1', 18:13:25 INFO - 'NO_EM_RESTART': '1', 18:13:25 INFO - 'PAGER': '/bin/cat', 18:13:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:25 INFO - 'PWD': '/builds/slave/test', 18:13:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:25 INFO - 'SHELL': '/bin/bash', 18:13:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcQxllSi36/Listeners', 18:13:25 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 18:13:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:25 INFO - 'USER': 'cltbld', 18:13:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:25 INFO - 'XPC_FLAGS': '0x0', 18:13:25 INFO - 'XPC_SERVICE_NAME': '0', 18:13:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:25 INFO - Downloading/unpacking jsonschema==2.5.1 18:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:13:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:28 INFO - Downloading functools32-3.2.3-2.tar.gz 18:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:13:28 INFO - warning: no files found matching '*.txt' 18:13:28 INFO - no previously-included directories found matching 'build' 18:13:28 INFO - no previously-included directories found matching 'dist' 18:13:28 INFO - no previously-included directories found matching '.git*' 18:13:28 INFO - Installing collected packages: jsonschema, functools32 18:13:28 INFO - Running setup.py install for functools32 18:13:28 INFO - warning: no files found matching '*.txt' 18:13:28 INFO - no previously-included directories found matching 'build' 18:13:28 INFO - no previously-included directories found matching 'dist' 18:13:28 INFO - no previously-included directories found matching '.git*' 18:13:28 INFO - Successfully installed jsonschema functools32 18:13:28 INFO - Cleaning up... 18:13:28 INFO - Return code: 0 18:13:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1097a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f0c73d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109581d30>, '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 0x1094a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109576be8>, '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.41r3Jqqnap/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.WcQxllSi36/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 18:13:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:13:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41r3Jqqnap/Render', 18:13:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:28 INFO - 'HOME': '/Users/cltbld', 18:13:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:28 INFO - 'LOGNAME': 'cltbld', 18:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:28 INFO - 'MOZ_NO_REMOTE': '1', 18:13:28 INFO - 'NO_EM_RESTART': '1', 18:13:28 INFO - 'PAGER': '/bin/cat', 18:13:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:28 INFO - 'PWD': '/builds/slave/test', 18:13:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:28 INFO - 'SHELL': '/bin/bash', 18:13:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcQxllSi36/Listeners', 18:13:28 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 18:13:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:28 INFO - 'USER': 'cltbld', 18:13:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:28 INFO - 'XPC_FLAGS': '0x0', 18:13:28 INFO - 'XPC_SERVICE_NAME': '0', 18:13:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:13:29 INFO - Cleaning up... 18:13:29 INFO - Return code: 0 18:13:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:29 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 0x1097a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f0c73d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109581d30>, '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 0x1094a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109576be8>, '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.41r3Jqqnap/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.WcQxllSi36/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 18:13:29 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 18:13:29 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 18:13:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41r3Jqqnap/Render', 18:13:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:29 INFO - 'HOME': '/Users/cltbld', 18:13:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:29 INFO - 'LOGNAME': 'cltbld', 18:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:29 INFO - 'MOZ_NO_REMOTE': '1', 18:13:29 INFO - 'NO_EM_RESTART': '1', 18:13:29 INFO - 'PAGER': '/bin/cat', 18:13:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:29 INFO - 'PWD': '/builds/slave/test', 18:13:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:29 INFO - 'SHELL': '/bin/bash', 18:13:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcQxllSi36/Listeners', 18:13:29 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 18:13:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:29 INFO - 'USER': 'cltbld', 18:13:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:29 INFO - 'XPC_FLAGS': '0x0', 18:13:29 INFO - 'XPC_SERVICE_NAME': '0', 18:13:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:29 INFO - Downloading/unpacking blobuploader==1.2.4 18:13:29 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 18:13:29 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 18:13:29 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 18:13:29 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 18:13:29 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 18:13:29 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 18:13:32 INFO - Downloading blobuploader-1.2.4.tar.gz 18:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:13:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:13:32 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 18:13:32 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 18:13:32 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 18:13:32 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 18:13:32 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 18:13:32 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 18:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:13:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:13:32 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 18:13:32 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 18:13:32 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 18:13:32 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 18:13:32 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 18:13:32 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 18:13:33 INFO - Downloading docopt-0.6.1.tar.gz 18:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:13:33 INFO - Installing collected packages: blobuploader, requests, docopt 18:13:33 INFO - Running setup.py install for blobuploader 18:13:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:13:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:13:33 INFO - Running setup.py install for requests 18:13:34 INFO - Running setup.py install for docopt 18:13:34 INFO - Successfully installed blobuploader requests docopt 18:13:34 INFO - Cleaning up... 18:13:34 INFO - Return code: 0 18:13:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:34 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 0x1097a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f0c73d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109581d30>, '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 0x1094a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109576be8>, '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.41r3Jqqnap/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.WcQxllSi36/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 18:13:34 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 18:13:34 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 18:13:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41r3Jqqnap/Render', 18:13:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:34 INFO - 'HOME': '/Users/cltbld', 18:13:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:34 INFO - 'LOGNAME': 'cltbld', 18:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:34 INFO - 'MOZ_NO_REMOTE': '1', 18:13:34 INFO - 'NO_EM_RESTART': '1', 18:13:34 INFO - 'PAGER': '/bin/cat', 18:13:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:34 INFO - 'PWD': '/builds/slave/test', 18:13:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:34 INFO - 'SHELL': '/bin/bash', 18:13:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcQxllSi36/Listeners', 18:13:34 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 18:13:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:34 INFO - 'USER': 'cltbld', 18:13:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:34 INFO - 'XPC_FLAGS': '0x0', 18:13:34 INFO - 'XPC_SERVICE_NAME': '0', 18:13:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:13:34 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-AZgKY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:13:34 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-4jOOdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:13:34 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-T1z9NB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:13:34 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-me3CB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:13:35 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-kzkMTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:13:35 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-ntnoSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:13:35 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-aumq1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:13:35 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-z5WIP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:13:35 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-MnGA0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:13:35 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Tbohtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:13:35 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-k1zZAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:13:35 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-yJoHXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:13:35 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-CEVTRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:13:36 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-YzTyKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:13:36 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-ncn9xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:13:36 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-jctXfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:13:36 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-KVMPbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:13:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:13:36 INFO - Running setup.py install for manifestparser 18:13:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:13:36 INFO - Running setup.py install for mozcrash 18:13:36 INFO - Running setup.py install for mozdebug 18:13:36 INFO - Running setup.py install for mozdevice 18:13:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:13:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:13:37 INFO - Running setup.py install for mozfile 18:13:37 INFO - Running setup.py install for mozhttpd 18:13:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:13:37 INFO - Running setup.py install for mozinfo 18:13:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:13:37 INFO - Running setup.py install for mozInstall 18:13:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:13:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:13:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:13:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:13:37 INFO - Running setup.py install for mozleak 18:13:37 INFO - Running setup.py install for mozlog 18:13:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:13:37 INFO - Running setup.py install for moznetwork 18:13:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:13:38 INFO - Running setup.py install for mozprocess 18:13:38 INFO - Running setup.py install for mozprofile 18:13:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:13:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:13:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:13:38 INFO - Running setup.py install for mozrunner 18:13:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:13:38 INFO - Running setup.py install for mozscreenshot 18:13:38 INFO - Running setup.py install for moztest 18:13:38 INFO - Running setup.py install for mozversion 18:13:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:13:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:13:38 INFO - Cleaning up... 18:13:38 INFO - Return code: 0 18:13:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:13:38 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')]} 18:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13: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')]} 18:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:39 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 0x1097a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f0c73d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109581d30>, '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 0x1094a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109576be8>, '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.41r3Jqqnap/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.WcQxllSi36/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 18:13:39 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 18:13:39 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 18:13:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41r3Jqqnap/Render', 18:13:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:39 INFO - 'HOME': '/Users/cltbld', 18:13:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:39 INFO - 'LOGNAME': 'cltbld', 18:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:39 INFO - 'MOZ_NO_REMOTE': '1', 18:13:39 INFO - 'NO_EM_RESTART': '1', 18:13:39 INFO - 'PAGER': '/bin/cat', 18:13:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:39 INFO - 'PWD': '/builds/slave/test', 18:13:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:39 INFO - 'SHELL': '/bin/bash', 18:13:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcQxllSi36/Listeners', 18:13:39 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 18:13:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:39 INFO - 'USER': 'cltbld', 18:13:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:39 INFO - 'XPC_FLAGS': '0x0', 18:13:39 INFO - 'XPC_SERVICE_NAME': '0', 18:13:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:13:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:13:40 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-eq8Y4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:13:40 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)) 18:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:13:40 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-263WX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:13:40 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)) 18:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:13:40 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-BvFV4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:13:40 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)) 18:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:13:40 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-hOe2sP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:13:40 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)) 18:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:13:40 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-_xy8ul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:13:40 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)) 18:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:13:40 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-SeuoJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:13:40 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)) 18:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:13:40 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-DL29Vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:13:40 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)) 18:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:13:40 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-aJjjPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:13:40 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)) 18:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:13:40 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-KuIpo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:13:40 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)) 18:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:13:40 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-JYY1Cw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:13:41 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)) 18:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:13:41 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-V05Ljl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:13:41 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)) 18:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:13:41 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-37KgaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:13:41 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)) 18:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:13:41 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-tTwwzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:13:41 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)) 18:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:13:41 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-7QvlQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:13:41 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)) 18:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:13:41 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-UvPUjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:13:41 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)) 18:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:13:41 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-8nFmXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:13:41 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)) 18:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:13:41 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-bvexLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:13:41 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)) 18:13:41 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)) 18:13:41 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)) 18:13:41 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)) 18:13:41 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)) 18:13:41 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)) 18:13:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:13:44 INFO - Downloading blessings-1.6.tar.gz 18:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:13:45 INFO - Installing collected packages: blessings 18:13:45 INFO - Running setup.py install for blessings 18:13:45 INFO - Successfully installed blessings 18:13:45 INFO - Cleaning up... 18:13:45 INFO - Return code: 0 18:13:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:13:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:13:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:13:45 INFO - Reading from file tmpfile_stdout 18:13:45 INFO - Current package versions: 18:13:45 INFO - blessings == 1.6 18:13:45 INFO - blobuploader == 1.2.4 18:13:45 INFO - docopt == 0.6.1 18:13:45 INFO - functools32 == 3.2.3-2 18:13:45 INFO - jsonschema == 2.5.1 18:13:45 INFO - manifestparser == 1.1 18:13:45 INFO - mozInstall == 1.12 18:13:45 INFO - mozcrash == 1.0 18:13:45 INFO - mozdebug == 0.1 18:13:45 INFO - mozdevice == 0.49 18:13:45 INFO - mozfile == 1.2 18:13:45 INFO - mozhttpd == 0.7 18:13:45 INFO - mozinfo == 0.9 18:13:45 INFO - mozleak == 0.1 18:13:45 INFO - mozlog == 3.4 18:13:45 INFO - moznetwork == 0.27 18:13:45 INFO - mozprocess == 0.24 18:13:45 INFO - mozprofile == 0.28 18:13:45 INFO - mozrunner == 6.13 18:13:45 INFO - mozscreenshot == 0.1 18:13:45 INFO - mozsystemmonitor == 0.3 18:13:45 INFO - moztest == 0.8 18:13:45 INFO - mozversion == 1.4 18:13:45 INFO - psutil == 3.1.1 18:13:45 INFO - requests == 1.2.3 18:13:45 INFO - wsgiref == 0.1.2 18:13:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f0c73d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109581d30>, '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 0x1094a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109576be8>, '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.41r3Jqqnap/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.WcQxllSi36/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 18:13:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:13:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:13:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41r3Jqqnap/Render', 18:13:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:45 INFO - 'HOME': '/Users/cltbld', 18:13:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:45 INFO - 'LOGNAME': 'cltbld', 18:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:45 INFO - 'MOZ_NO_REMOTE': '1', 18:13:45 INFO - 'NO_EM_RESTART': '1', 18:13:45 INFO - 'PAGER': '/bin/cat', 18:13:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:45 INFO - 'PWD': '/builds/slave/test', 18:13:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:45 INFO - 'SHELL': '/bin/bash', 18:13:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcQxllSi36/Listeners', 18:13:45 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 18:13:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:45 INFO - 'USER': 'cltbld', 18:13:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:45 INFO - 'XPC_FLAGS': '0x0', 18:13:45 INFO - 'XPC_SERVICE_NAME': '0', 18:13:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:45 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)) 18:13:45 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)) 18:13:45 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)) 18:13:45 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)) 18:13:45 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)) 18:13:45 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)) 18:13:45 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)) 18:13:45 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)) 18:13:45 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)) 18:13:45 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)) 18:13:45 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)) 18:13:45 INFO - Cleaning up... 18:13:45 INFO - Return code: 0 18:13:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:13:45 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 0x1097a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2f0c73d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109581d30>, '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 0x1094a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109576be8>, '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.41r3Jqqnap/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.WcQxllSi36/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 18:13:45 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 18:13:45 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 18:13:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41r3Jqqnap/Render', 18:13:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:45 INFO - 'HOME': '/Users/cltbld', 18:13:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:45 INFO - 'LOGNAME': 'cltbld', 18:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:45 INFO - 'MOZ_NO_REMOTE': '1', 18:13:45 INFO - 'NO_EM_RESTART': '1', 18:13:45 INFO - 'PAGER': '/bin/cat', 18:13:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:45 INFO - 'PWD': '/builds/slave/test', 18:13:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:45 INFO - 'SHELL': '/bin/bash', 18:13:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcQxllSi36/Listeners', 18:13:45 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 18:13:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:45 INFO - 'USER': 'cltbld', 18:13:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:45 INFO - 'XPC_FLAGS': '0x0', 18:13:45 INFO - 'XPC_SERVICE_NAME': '0', 18:13:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:13:46 INFO - Cleaning up... 18:13:46 INFO - Return code: 0 18:13:46 INFO - Running post-action listener: _resource_record_post_action 18:13:46 INFO - Running post-action listener: _start_resource_monitoring 18:13:46 INFO - Starting resource monitoring. 18:13:46 INFO - [mozharness: 2017-02-03 02:13:46.100113Z] Finished create-virtualenv step (success) 18:13:46 INFO - [mozharness: 2017-02-03 02:13:46.101047Z] Running install step. 18:13:46 INFO - Running pre-action listener: _resource_record_pre_action 18:13:46 INFO - Running main action method: install 18:13:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:13:46 INFO - Reading from file tmpfile_stdout 18:13:46 INFO - Detecting whether we're running mozinstall >=1.0... 18:13:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:13:46 INFO - Reading from file tmpfile_stdout 18:13:46 INFO - Output received: 18:13:46 INFO - Usage: mozinstall [options] installer 18:13:46 INFO - Options: 18:13:46 INFO - -h, --help show this help message and exit 18:13:46 INFO - -d DEST, --destination=DEST 18:13:46 INFO - Directory to install application into. [default: 18:13:46 INFO - "/builds/slave/test"] 18:13:46 INFO - --app=APP Application being installed. [default: firefox] 18:13:46 INFO - mkdir: /builds/slave/test/build/application 18:13:46 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'] 18:13:46 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 18:14:08 INFO - Reading from file tmpfile_stdout 18:14:08 INFO - Output received: 18:14:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:14:08 INFO - Running post-action listener: _resource_record_post_action 18:14:08 INFO - [mozharness: 2017-02-03 02:14:08.361012Z] Finished install step (success) 18:14:08 INFO - [mozharness: 2017-02-03 02:14:08.361171Z] Running run-tests step. 18:14:08 INFO - Running pre-action listener: _resource_record_pre_action 18:14:08 INFO - Running main action method: run_tests 18:14:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:14:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:14:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:14:08 INFO - 2017-02-02 18:14:08.375 screenresolution[1628:7308] starting screenresolution argv=screenresolution get 18:14:08 INFO - 2017-02-02 18:14:08.378 screenresolution[1628:7308] Display 0: 1600x1200x32@60 18:14:08 INFO - 2017-02-02 18:14:08.384 screenresolution[1629:7311] starting screenresolution argv=screenresolution list 18:14:08 INFO - Available Modes on Display 0 18:14:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:14:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:14:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:14:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:14:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:14:08 INFO - Intel Iris: 18:14:08 INFO - Chipset Model: Intel Iris 18:14:08 INFO - Type: GPU 18:14:08 INFO - Bus: Built-In 18:14:08 INFO - VRAM (Dynamic, Max): 1536 MB 18:14:08 INFO - Vendor: Intel (0x8086) 18:14:08 INFO - Device ID: 0x0a2e 18:14:08 INFO - Revision ID: 0x0009 18:14:08 INFO - Displays: 18:14:08 INFO - Display: 18:14:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:14:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:14:08 INFO - Display Serial Number: 1600x1200 60 18:14:08 INFO - Main Display: Yes 18:14:08 INFO - Mirror: Off 18:14:08 INFO - Online: Yes 18:14:08 INFO - Rotation: Supported 18:14:08 INFO - Return code: 0 18:14:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:14:08 INFO - Python 2.7.3 18:14:08 INFO - Return code: 0 18:14:08 INFO - grabbing minidump binary from tooltool 18:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:08 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 0x109581d30>, '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 0x1094a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109576be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:14:08 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 18:14:08 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 18:14:08 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 18:14:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:14:08 INFO - Return code: 0 18:14:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:14:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:14:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:14:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:14:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:14:08 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/NawbCs0fTn-cUin1sHbYsg/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 18:14:08 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/NawbCs0fTn-cUin1sHbYsg/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 18:14:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41r3Jqqnap/Render', 18:14:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:08 INFO - 'HOME': '/Users/cltbld', 18:14:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:08 INFO - 'LOGNAME': 'cltbld', 18:14:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:14:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:08 INFO - 'MOZ_NO_REMOTE': '1', 18:14:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:14:08 INFO - 'NO_EM_RESTART': '1', 18:14:08 INFO - 'PAGER': '/bin/cat', 18:14:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:08 INFO - 'PWD': '/builds/slave/test', 18:14:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:14:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:08 INFO - 'SHELL': '/bin/bash', 18:14:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WcQxllSi36/Listeners', 18:14:08 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 18:14:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:08 INFO - 'USER': 'cltbld', 18:14:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:08 INFO - 'XPC_FLAGS': '0x0', 18:14:08 INFO - 'XPC_SERVICE_NAME': '0', 18:14:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:08 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/NawbCs0fTn-cUin1sHbYsg/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 18:14:08 INFO - mozversion application_buildid: 20170202164009 18:14:08 INFO - mozversion application_changeset: c8102da699dba43d85eb80b70956e80c6793feca 18:14:08 INFO - mozversion application_display_name: Nightly 18:14:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:14:08 INFO - mozversion application_name: Firefox 18:14:08 INFO - mozversion application_remotingname: firefox 18:14:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:14:08 INFO - mozversion application_vendor: Mozilla 18:14:08 INFO - mozversion application_version: 54.0a1 18:14:08 INFO - mozversion platform_buildid: 20170202164009 18:14:08 INFO - mozversion platform_changeset: c8102da699dba43d85eb80b70956e80c6793feca 18:14:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:14:08 INFO - mozversion platform_version: 54.0a1 18:14:08 INFO - using testdate: 1486088048 18:14:08 INFO - actual date: 1486088048 18:14:08 INFO - starting webserver on 'localhost:49244' 18:14:08 INFO - SUITE-START | Running 2 tests 18:14:08 INFO - TEST-START | dromaeo_css 18:14:08 INFO - operating with platform_type : mac_ 18:14:08 INFO - Initialising browser for dromaeo_css test... 18:14:08 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmp8MiXpW/profile http://localhost:49244/getInfo.html) 18:14:11 INFO - PROCESS | 1639 | 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] 18:14:11 INFO - PROCESS | 1639 | 2017-02-02 18:14:11.842 plugin-container[1641:7482] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 18:14:11 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:14:11 INFO - PROCESS | 1639 | 2017-02-02 18:14:11.846 plugin-container[1641:7482] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 18:14:11 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:14:11 INFO - PROCESS | 1639 | 2017-02-02 18:14:11.846 plugin-container[1641:7482] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:14:11 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 18:14:11 INFO - PROCESS | 1639 | colorDepth:24 18:14:11 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 18:14:11 INFO - PROCESS | 1639 | __metrics 18:14:12 ERROR - PROCESS | 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 18:14:12 INFO - PROCESS | 1639 | 1486088052014 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/tmp8MiXpW/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmp8MiXpW/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmp8MiXpW/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmp8MiXpW/profile/extensions/talos-powers@TalosPowersService.js:55:9 18:14:12 INFO - TEST-INFO | 1639: exit 0 18:14:12 INFO - Browser initialized. 18:14:12 INFO - Running cycle 1/1 for dromaeo_css test... 18:14:12 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmp8MiXpW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:14:15 INFO - PROCESS | 1642 | 2017-02-02 18:14:15.263 plugin-container[1643:7604] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 18:14:15 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:14:15 INFO - PROCESS | 1642 | 2017-02-02 18:14:15.264 plugin-container[1643:7604] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 18:14:15 INFO - PROCESS | 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:14:15 INFO - PROCESS | 1642 | 2017-02-02 18:14:15.264 plugin-container[1643:7604] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:14:24 INFO - PROCESS | 1642 | RSS: Main: 233357312 18:14:24 INFO - PROCESS | 1642 | 18:17:27 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 18:17:29 INFO - PROCESS | 1642 | RSS: Main: 258580480 18:17:29 INFO - PROCESS | 1642 | 18:19:13 INFO - PROCESS | 1642 | ************************* 18:19:13 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 18:19:13 INFO - PROCESS | 1642 | 18:19:13 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:19:13 INFO - PROCESS | 1642 | Full stack: 18:19:13 INFO - PROCESS | 1642 | ************************* 18:20:31 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 18:20:32 INFO - PROCESS | 1642 | RSS: Main: 265273344 18:20:32 INFO - PROCESS | 1642 | 18:23:34 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 18:23:34 INFO - PROCESS | 1642 | RSS: Main: 275988480 18:23:34 INFO - PROCESS | 1642 | 18:26:36 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 18:26:37 INFO - PROCESS | 1642 | RSS: Main: 269000704 18:26:37 INFO - PROCESS | 1642 | 18:29:40 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 18:29:41 INFO - PROCESS | 1642 | RSS: Main: 274960384 18:29:41 INFO - PROCESS | 1642 | 18:32:43 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 18:32:43 INFO - PROCESS | 1642 | RSS: Main: 276992000 18:32:43 INFO - PROCESS | 1642 | 18:32:43 INFO - PROCESS | 1642 | __start_tp_report 18:32:43 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 18:32:43 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 18:32:43 INFO - PROCESS | 1642 | |i|pagename|runs| 18:32:43 INFO - PROCESS | 1642 | |0;dojo.html;3353.7317014638825;3375.139339468435;3412.436947903596;3416.248425346426;3434.6908778209954;4192.580741925806;4606.848287928018;5490.69801160936;5678.403767604399;5754.2519472468575;5554.305711786016;5684.147377893308;5688.744006519706;5733.799317023905;5857.092150716646;4989.575886049672;5071.543561079502;5082.51716086973;5142.280080788692;5188.896222075557;5170.870728231786;5278.604104692164;5290.285811415448;5290.867728306804;5364.678119312854;5135.74321283938;5180.5337519623035;5273.077211488013;5299.993001329735;5328.200769884529;5186.455422180655;5199.402068762103;5238.109521381374;5281.39263984639;5317.813876514303;5171.974140129313;5193.714345710984;5246.711430871301;5263.894722105575;5281.181416880389;5025.045241404122;5226.3989641191365;5748.45389687979;5760.107183386582;5794.739236734357;6132.447291485822;6187.659678717669;6199.690015499207;6200.751969921198;6255.562110652256;6213.099100630428;6214.937850621481;6226.159468471744;6229.3770622937345;6238.688065596747;5893.263342082239;5922.615030023035;5940.881182376372;5952.8809423812145;5987.101934709828;5678.176664383641;6138.78514252008;6197.783077592263;6216.813495595139;6240.032794916795;6073.696315184223;6111.135969295249;6121.785737499166;6142.775043102407;6193.256809182927;6133.509319254449;6179.969100154561;6181.258249010148;6213.96893015532;6230.158928544679;6174;6201.6899155042065;6236.563440559208;6241.095041219089;6269.561130720897;5978.4021597839865;6081.695915204222;6199.721012554446;6211;6238.6880655967925;4953.356063711694;4988.301637770715;4995.300657907896;5028.421731500925;5063.341765570526;4442.089371678798;4456.930336719164;4476.306172543261;4482.977585112054;4525.140223357617;5752.9712351437975;5948.286205655262;5951.732172052268;5951.821445356646;5969.164316995624;6164.6917654117115;6175.505959523227;6180.227471566054;6184.938150618436;6221.502279817604;5880.911786323209;5895.263092113486;5904.970475147683;5910.674912879746;5927.8221653350465;5457.5633949283965;5458.536024437888;5483.890322193533;5500.3949565547755;5502.174673798882;6166.260048794174;6220.34686357935;6282.905756413749;6356.968215158895;6367.172267605181;6229.096780966644;6236.6258024518675;6239.719212635351;6242.28213755424;6257.186565746424;6390.360963903572;6454.483641308778;6458.451031662361;6458.67706614658;6460.806175814733;6127.571070025056;6130.551011451207;6156.5998210116195;6162.630242185483;6232.937670623236;6093.786717465045;6136.059583474799;6218.689065546614;6234.096056071753;6255.374462553708;6063.333033366414;6180.196574445294;6190.81427557174;6202;6216.968915155395;6057;6084.239470066242;6106.7640410362355;6122.733612273432;6124.448799608057;5963.731632076654;5990.850228744316;6055.5458340623745;6066.272047354346;6079.118527813531;6129.724162412791;6204.441600255998;6212.316645169119;6214.627122372672;6219.595726277777;5847.1229315603;5892.793752218652;5928.288605367384;6063.6664983426335;6066.605670631395 18:32:43 INFO - PROCESS | 1642 | |1;ext.html;467.67730266116376;494.2956287290612;501.4158505341275;503.6298320734262;526.0189746123481;31626.841865790666;38671.99999999996;39744.41022359106;41485;41544.96137596561;42815.35776963348;43702.344464833055;43803.342949855774;43807.12385752283;44023.559764402344;9261.722148335544;10926.726831829188;11434.485448154854;11598.59404920828;11598.826017609743;11297.26567773092;11391.259568128087;11404.828927566094;11419.942900285487;11428.914253145938;11400.315981041123;11418.14363922705;11433.256838305526;11453.656390308304;11456.255343402694;11345.26255793375;11396.772064558745;11405.828912566276;11417.31496110236;11431.314121152758;11110.388928608923;11193.104551635932;11229.55081796727;11232.21374503785;11239;38160.61839381598;38309.80845095785;38488.422673659916;38632.80683596592;38749.41875871864;3958.3270843956598;3960.7418532359775;3971.801409929521;3985.4221137934837;4040.6363427291685;23752.524949501087;28993.71006289931;29131.70868291311;29280.70719292801;29817.552736708967;3122.266267427153;3137.8274194919272;3148.8740450381956;3216.5014422764507;3243.0919342584116;447786;469794;499031.5048424735;514563;615776;58626.12060819091;58819.823603528544;59311.70344148252;59358.70320648369;59532.939700125105;60419.79160416767;60847;60994;61086;61325;15234.009789363878;15459.149746764037;15487.612809679847;15489.5353139406;15792;11977.760444791056;12079.577214797615;12091.334976576372;12100.818487722516;12121.212121212093;17914.641707165785;18078.819211807713;18108.728369074473;18136.45590632283;18159.818401815814;7002.782926719627;7504.737334193277;7706.460547761603;7830.882536761953;7874.3857509210475;751.2412463411885;847.4449235750593;881.722257488889;890.8396488632109;893.2630579771715;30020.399592008038;30364.84817575898;30743.77024919023;31394.843025785183;31544.52683209708;930.5905401623264;1031.4224034540682;1066.1151244467073;1091.3233795047122;1169.1698893785338;15435.614109647124;15833.920830395775;15911.68176636484;16070.955387899983;16099.678006439806;668679;669770;671030;672820;675254;47222.76388618035;47540;47595.04809903783;47616.04767904692;47919.520804792206;1157.6989982604416;1307.3724612186013;1403.8736513713816;1421.2680469558186;1444.5377479206552;25323.98704051891;25842.483150337262;32527.512087318235;33477.49783753197;33686;54575.6356091085;54620.45379546312;55189.17216241679;55196;55289.72355138198;477915;571237;574939;577574;578050;22141.889290553445;23275.185368512022;27027.729722702523;27218.78173599621;27291.454170916866;47753.522464774906;48547.02905941791;49568.75215623899;49699;49872.75063624659;39553;39628.622282663135;39737.80131099326;40454;40645.390319144644;38918;39331;40288.3956740655;40412.3938140934;40955.59044409518;37645.05887352728;37830.43254351242;37938;38410.231795364496;38548.229035419696;29446.558301625064;33378;33463.66536334605;34960.475592865616;35127;24892.253232403058;25232.74767252304;25536;25612.743872561037;25729.8421571026 18:32:43 INFO - PROCESS | 1642 | |2;jquery.html;381.40881633468115;384.8268279274327;394.47928734071024;396.5697218517907;416.05347833678377;14736;16583.66832663346;20160.899195504022;21576;21598.8120653364;20354.59290814183;21708.457288567755;21778.782212177874;22077.779222207773;22172.223972160977;4932.6793758405765;5322.7072511011875;5806.506446952014;5889.998700220973;5896.823095307126;5529.253550770655;5642.322921249456;5744.4829965303115;5753.280839895013;5760.711964401784;5699.800506982257;5760.654360738348;5763.1355296705415;5766.423357664242;5787.450192231731;5519.862003449946;5721.170430287627;5723.656580605177;5749.770009199627;5775.27809023872;5088.313077734496;5092;5097.668651537638;5105.489451054902;5107.20838270065;25092.247232583053;25407.49185016308;25838.87080564604;25876.611850822253;26019.21942341733;2414.3360575841607;2589.1585234798767;2702;2764.903228387017;2800.635917330754;9904.554295056667;14576.489822856149;15108.622284442867;15223.543293701206;15601.69100920333;1482.5774654223494;1800.20790852026;1812.5921667624812;1881;1912.9617407651908;109411;115837;139269.9839518448;140803;142247;11586.942065289619;11765.470553825098;11807;11822.822657660143;11937.940310298392;12633.873661263453;15143.242837858283;15187.164705941279;15194.240287985556;15247.094113235846;6533.509986751013;7025;8347.415680902279;8517;8536.8719469208;7683.731069412655;8217.630206640715;8228.053773816087;8365.874511882326;8432.409731318872;4587.42657167854;4652.697574657636;4657.836975705834;4678.157931572349;4740.786664600101;1698.4480043985754;1991.8008199179967;1995.4412764425983;1995.8303544198616;2005.1678553400175;1007.7883644434604;1011.7217765114506;1018.9388636681823;1034.6844212515105;1053.7839742852698;21050.78949210519;21554.784452155276;21613.567728645652;21717.565648686937;21739.565208695738;840.6301227459898;1024.4979959819634;1044.968650940473;1044.9738756530996;1048.3552615141632;9812.509374531244;10378.910214427528;11148.498317575728;11304.830427543593;11308.886911130949;630850;699175;720653;723738;724278;145649;146257.53742462653;153406.46593534146;154018.229908852;164092;999.6651121874254;1021.0963297481782;1051.122312868748;1055.024102704995;1056.6777132974516;19904.303349382702;20065.39803805888;20361.185552578325;20456.954304569423;20465;56914.43085569257;57396;58838;58900;59889.401105988385;84891.5755421219;85085;86160.56919715612;86911;87254;7973.9601301995435;7983.321417679563;8003.639836207268;8342.708005219789;8359.874601880854;8980.012198658273;10442.321249118782;11802.409879506162;12431.37843107859;12785.232886026868;10501.212409069198;10807.513661885077;10877.510512027136;10943.890561094287;10975;10244.487775611338;10472.581096756045;10637.255392122477;10764.623238186627;10929.672109836718;10369.807472140801;10855;11005.944970275417;11269.943650281695;11662.183647144619;6877.862442751217;7305.926940730525;7314.378277846443;7500.9249907500225;8352.958235208785;9108.863367049367;10973.945130274298;10986.560537578407;11014.614488492864;11047.839976802641 18:32:43 INFO - PROCESS | 1642 | |3;mootools.html;1330.3614265152728;1395.7557427450197;1420.6874487612722;1424.2522675595317;1435.3110506956662;8088.878666820003;8166.142555031725;8375.455595386296;8468.57657117144;8501.744947651565;7665.731699390522;7694.384449244061;8149.348052155829;8337.082920878698;8353.874691879626;2028.6855537391727;2213.900374483152;2253.256425379629;2280.6464997925264;2298.000369839125;2269.217120093565;2309.3533810533077;2310.5378924215142;2315.097112126272;2316.444053427182;2205.9558808823813;2262.2534563593977;2276.3967548599635;2289.107248173214;2293.6444851048113;2162.4701948022835;2218.9889050554725;2229.977700222993;2248.2355998960434;2253.864768113918;2028.1380413324277;2094.8743075415523;2262.423082114067;2331.8484298520543;2343.3321503371626;8107.959460202661;8307.709230176915;8318.750437486886;8406.957965210197;8442.83114337716;5042.042012017741;5165.74171291434;5186.144286192812;5191.610629202825;5203.505666961632;3381.695647391722;3392.08413728292;3406.7838573904432;3462;3521.7886926784477;1223.7674841780122;1225.5159212111166;1258.2387655468492;1280.5262053040342;1289.6260084575463;10309.896901030968;10368.948155259252;10416.739581510523;10547.683569492927;10562.20783441245;4384.714993525411;4610.792514336863;4682.508336624605;4695.5069717679835;4723.614574639785;9379.062093790702;9466;9471.431714097176;9484.573194206278;9501.667441639647;5217.139172036572;5220.530152286236;5225.4774522548205;5229.294045303835;5231.110711179109;4556.726596404226;4654.604358629486;4708.4820669726305;4751.287306903923;4763.095011947719;3817.2938006468894;3852.1317161176808;3889.8833035008997;3908.511436070491;3946.881593552198;1251.730877861246;1277.6358737759695;1286.8777466140702;1292.4571679894466;1294.6633875192329;766.7278116268756;835.8370117826965;892.1479986612769;900.9954950225338;936.8594710793435;4987;5397.136458166753;5485.6434331768305;5655.4910058094965;5781.595288329777;858.3605214115399;985.7831277119022;987.7678745494803;1018.8166130096506;1043.89561043895;3694.852205911787;3787.7348585598743;3826.7090302339966;3834.7699138051807;3902.726809123334;9452.90547094534;9779.41323520591;9800.019998000143;9804.264680149017;9838.508074596384;9115.954420227989;9537.332386733;9684.903150968541;9795.902040979641;9798.804023919482;7680.731174408869;7879.960600196962;7895.802604934923;7899.763007109796;7912.4856884302335;4852.539008794159;5655.660660360391;5674.765383731234;5770.5095066919785;5813.534917206698;7670.8849367260655;8221.17788221173;8912.55437228123;9016.2786977043;9052.502112383881;8551.700690475804;8755.562221889008;9083.909160908306;9187.356885017985;9273;6996.965015175095;7145.82135446618;7287.526310789782;7294.197638259893;7295.671694773854;7465.514741541782;7532.811679708051;7857.685692572233;8038.799030024296;8070.152633973348;7027.262137475696;7068.858622827412;7125.714971401086;7153.284671532805;7226.530275532074;7020.508564400648;7030.156381234285;7055.788326350218;7064.470164737562;7066.57600543969;6252.155958945484;6327.746890124527;6369;6404.455621272058;6407.199100112486;4947.2579113133315;4988.900221995613;4999.375078115236;5014.272930424995;5062.038212739568;4949;4958.404991400911;5050.974745126251;5119.385673719177;5165.096108180978 18:32:43 INFO - PROCESS | 1642 | |4;prototype.html;333.38490485055075;349.4792758789403;368.91722793600775;369.07178446207774;379.22448592628075;5194.54552725237;5455.618106732531;5583.664980101197;5611.7755289788465;5623.690697011673;4996.850094497171;5450.04624190767;5491.972540137303;5513.338399392079;5519.69641669708;3246.155999440151;3985.980070099645;4038.97980510097;4137.662220845228;4148.917021659565;3644.744867859251;4150.3359462486005;4153.709240353177;4166.479235079205;4198.769067701275;4107.897302567445;4128.938065929014;4133.73130746502;4134.3591743279685;4184.916301673965;4117.505899292074;4118.341065429547;4136.400221967813;4138.97930510347;4157.729747566398;2608.778253848406;3039.4377040247623;3354.8825791097192;3560.2523470071314;3570.696490798285;4537.478190008125;4697.224957881946;5355.116405793039;5374.543163831079;5374.946250537484;4158.147579746144;4563.794629241692;4713.363695901078;4722.504137065593;4767.878294159101;4552.7479943015605;5456.91814622781;5731.541476681856;5789.131630255453;5856.209411729405;3129.9217519561967;3885.747426417274;3914.5498267699295;3928.508936382952;3991.3613821788663;5261.105612045923;5653.773849046033;5880.70596470179;5901.616394934315;6098.817035488943;3246.3831871944253;3887.125396785757;3922.921196670938;3969.384745364473;4029;3992.6207010333974;4002.3196056670436;4003.6997225208224;4015.8996025099023;4070.247004304154;3865.536135663738;4515.412996310459;4674.836380726658;4679.485256621769;4743.810247590127;4733.502982186889;5302.072137375943;5821.592488525847;5839.970800146057;5863.237779088691;1287.0347239570322;1292.476546998467;1292.9870701293055;1296.3259105265208;1299.142565906497;813.4468561378201;871.7079778274349;884.2748945864458;887.8224355128871;893.9374243802871;4972.925406118911;5022.447530771612;5130.769115389817;5172.586193104543;5227.837158519117;5027.114831938024;5673.943260567424;5708.315002199763;5751.511121554631;5754;4436.201483732894;4702.506236845082;4793.496682848251;5172.379314482287;5227.294315267391;2624.7244039375973;2871.8133321334462;2915.8396288203926;2973.795612776829;3004.9632876657956;4986.808442596741;5551.139573366135;5897.410258974154;5914.792982245601;5949.583529153005;5831.854203644858;5853.239078919713;6125.632462052291;6169.691515424211;6171.3771647049825;5783.537317014629;6219.315875253718;6226.315105338409;6252.687365631609;6269.025257044108;5837.591368604157;5881.676737688675;5972.402005127783;6082.452579267887;6127.417895299939;4940.7035577865445;5821.76712931478;5919.852003699942;5927.940720592911;5970.223845911498;4763.7141771493825;5122.538971492583;5685.829425117253;6086.995645718407;6185.00054946719;3758.4362345648374;3942.5663177051074;3947.8223479944045;3957.783641160959;3962.3660214365564;5699.487046165865;6014.368491308524;6038.245219347582;6040.909386359121;6043.519337762276;5029.823956161663;5439.673619582838;5473.589480788877;5839.569305520175;5872.853178670567;5539.362973258127;5707.914381284367;5855.092460668603;5866.2960444746905;5886.94113058864;5165.92251116226;5175.404828444626;5298.827480732881;5490.486088903185;5610.943890561042;5154.5103215194495;5770.826875193751;5815.79644712433;5820.388859169726;5823.7670493181495;4569.954300457086;4766.856994290177;5059.924101138559;5330.2804121443105;5436.65067945634 18:32:43 INFO - PROCESS | 1642 | |5;yui.html;690.7168061094952;693.7953303775386;780.0054929964294;811.2374368093992;825.645940657322;14629.853701462982;15358.616034599141;15563.68872622547;15581;15592.220388980548;13983.510577129777;14582.635434114152;14678.853211467882;14711.779323310158;14712.043717158378;858.8368210040072;876.9079246679103;879.9164079412477;880.2517859819167;881.7442941546976;853.3727710133047;871.1680345270283;876.6361959786681;891.888513935758;894.472261365794;876.1895246896627;876.5792419638577;878.2929741558044;879.8020445399766;883.4787475389519;853.1042405474227;871.7559083456642;872.6204101215928;872.6422166911567;875.7941883657336;638.2213699286863;640.4108220437209;653.6894974886939;656.8456412743002;657.1063353838775;12320.630381088582;15165.696686066327;15206.695866082728;15215.163166025975;15770.526884193378;12425.502979880794;12508.937455312756;12585.685357866127;12606.621801345882;12932.41804118817;11423.314601123959;11584.18910676253;11697.473613687405;11713.355765432898;12014.459349329214;3674.1182116292166;3719.609441008682;3729.459228411892;3863.826127824255;3864.7294689371756;83940.06209782629;84141;102889.4855525725;103152.48423757833;103529.48235258776;10376.584936602452;10920.672379828618;11011.229213955106;11047.779044419067;11273.71815704614;22060.669089963663;22130.114795408324;22250.55498890013;22270.55458890813;22284.54589538624;7703.114141873644;7759.224077592308;7759.379249660014;7857;7945.48354356965;4181.832726690959;4310.7198032128435;4312.892177695583;4349.3475978603465;4358.476982762026;3427.4687423449404;3506.736994725406;3511.4030614795547;3550.1479644885044;3553.875614353485;551.2915903064543;632.3739497897141;635.3487675133026;642.9517786166057;649.8992656138306;538.5018857556744;594.8661551150957;644.8452371430823;661.84777501175;668.3784080804801;9713.805723885624;10010.64962726301;10015.899841001643;10027.699169024942;10045.497725113715;604.338249616669;633.379288297471;639.792067578039;676.8763852005745;693.1439672005171;4106.568810274938;4447.644188464915;4727.432708075053;4785.114753770564;4827.692875710383;96840.1263949434;99678.50160749294;99997;100155;101168.49415752874;56409.71795140998;57599.424005760244;74575.25424745683;83720.58139709262;83733.16266837376;64134;67453.66273168602;67734.66132669305;68353.65823170853;68975.65512172406;10754.51604677807;10762.838557421801;10862.945685271523;11039.558417663526;11055.83416248773;47669.52330476789;48124.75937620289;48309.75845120892;48777.75611121922;51319;54677.45322546724;55232.44767552273;62517.43706407376;62879.37120628735;62892.685536572026;12547.686307842378;12609.621711348675;12716.554920577735;12808.871911280768;12931.676708082374;13220.471181152647;13744.381502832197;14369.281535922953;14512.564623061326;14575.708485830437;11626.593069242535;13491.05562610608;13570.93214533921;13897.079664059384;13939.930300348433;11432.599859004895;13010.414531345923;13241.139325943783;13888.236147012012;13983.370748316554;10842.566297348018;10944.343339399662;13202.471901123847;13214.735705285648;13482.66293342635;9466.574004169966;10969.670909872717;11118.277311974696;11314.943425282821;11329.716757080809;7648.961755191189;8943.821123577622;10763.892361076601;10936.617218397318;10963 18:32:43 INFO - PROCESS | 1642 | __end_tp_report 18:32:43 INFO - PROCESS | 1642 | __start_cc_report 18:32:43 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,390 18:32:43 INFO - PROCESS | 1642 | __end_cc_report 18:32:43 INFO - PROCESS | 1642 | __startTimestamp1486089163904__endTimestamp 18:32:43 INFO - PROCESS | 1642 | 18:32:43 INFO - PROCESS | 1642 | ------- Summary: start ------- 18:32:43 INFO - PROCESS | 1642 | Number of tests: 6 18:32:43 INFO - PROCESS | 1642 | 18:32:43 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5749.24 Median:6055.55 stddev:648.06 (10.7%) stddev-sans-first:622.20 18:32:43 INFO - PROCESS | 1642 | Values: 3353.7 3375.1 3412.4 3416.2 3434.7 4192.6 4606.8 5490.7 5678.4 5754.3 5554.3 5684.1 5688.7 5733.8 5857.1 4989.6 5071.5 5082.5 5142.3 5188.9 5170.9 5278.6 5290.3 5290.9 5364.7 5135.7 5180.5 5273.1 5300.0 5328.2 5186.5 5199.4 5238.1 5281.4 5317.8 5172.0 5193.7 5246.7 5263.9 5281.2 5025.0 5226.4 5748.5 5760.1 5794.7 6132.4 6187.7 6199.7 6200.8 6255.6 6213.1 6214.9 6226.2 6229.4 6238.7 5893.3 5922.6 5940.9 5952.9 5987.1 5678.2 6138.8 6197.8 6216.8 6240.0 6073.7 6111.1 6121.8 6142.8 6193.3 6133.5 6180.0 6181.3 6214.0 6230.2 6174.0 6201.7 6236.6 6241.1 6269.6 5978.4 6081.7 6199.7 6211.0 6238.7 4953.4 4988.3 4995.3 5028.4 5063.3 4442.1 4456.9 4476.3 4483.0 4525.1 5753.0 5948.3 5951.7 5951.8 5969.2 6164.7 6175.5 6180.2 6184.9 6221.5 5880.9 5895.3 5905.0 5910.7 5927.8 5457.6 5458.5 5483.9 5500.4 5502.2 6166.3 6220.3 6282.9 6357.0 6367.2 6229.1 6236.6 6239.7 6242.3 6257.2 6390.4 6454.5 6458.5 6458.7 6460.8 6127.6 6130.6 6156.6 6162.6 6232.9 6093.8 6136.1 6218.7 6234.1 6255.4 6063.3 6180.2 6190.8 6202.0 6217.0 6057.0 6084.2 6106.8 6122.7 6124.4 5963.7 5990.9 6055.5 6066.3 6079.1 6129.7 6204.4 6212.3 6214.6 6219.6 5847.1 5892.8 5928.3 6063.7 6066.6 18:32:43 INFO - PROCESS | 1642 | 18:32:43 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:71026.87 Median:37884.22 stddev:156245.52 (412.4%) stddev-sans-first:156594.01 18:32:43 INFO - PROCESS | 1642 | Values: 467.7 494.3 501.4 503.6 526.0 31626.8 38672.0 39744.4 41485.0 41545.0 42815.4 43702.3 43803.3 43807.1 44023.6 9261.7 10926.7 11434.5 11598.6 11598.8 11297.3 11391.3 11404.8 11419.9 11428.9 11400.3 11418.1 11433.3 11453.7 11456.3 11345.3 11396.8 11405.8 11417.3 11431.3 11110.4 11193.1 11229.6 11232.2 11239.0 38160.6 38309.8 38488.4 38632.8 38749.4 3958.3 3960.7 3971.8 3985.4 4040.6 23752.5 28993.7 29131.7 29280.7 29817.6 3122.3 3137.8 3148.9 3216.5 3243.1 447786.0 469794.0 499031.5 514563.0 615776.0 58626.1 58819.8 59311.7 59358.7 59532.9 60419.8 60847.0 60994.0 61086.0 61325.0 15234.0 15459.1 15487.6 15489.5 15792.0 11977.8 12079.6 12091.3 12100.8 12121.2 17914.6 18078.8 18108.7 18136.5 18159.8 7002.8 7504.7 7706.5 7830.9 7874.4 751.2 847.4 881.7 890.8 893.3 30020.4 30364.8 30743.8 31394.8 31544.5 930.6 1031.4 1066.1 1091.3 1169.2 15435.6 15833.9 15911.7 16071.0 16099.7 668679.0 669770.0 671030.0 672820.0 675254.0 47222.8 47540.0 47595.0 47616.0 47919.5 1157.7 1307.4 1403.9 1421.3 1444.5 25324.0 25842.5 32527.5 33477.5 33686.0 54575.6 54620.5 55189.2 55196.0 55289.7 477915.0 571237.0 574939.0 577574.0 578050.0 22141.9 23275.2 27027.7 27218.8 27291.5 47753.5 48547.0 49568.8 49699.0 49872.8 39553.0 39628.6 39737.8 40454.0 40645.4 38918.0 39331.0 40288.4 40412.4 40955.6 37645.1 37830.4 37938.0 38410.2 38548.2 29446.6 33378.0 33463.7 34960.5 35127.0 24892.3 25232.7 25536.0 25612.7 25729.8 18:32:43 INFO - PROCESS | 1642 | 18:32:43 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:39276.73 Median:21759.17 stddev:117063.10 (538.0%) stddev-sans-first:117355.06 18:32:43 INFO - PROCESS | 1642 | Values: 381.4 384.8 394.5 396.6 416.1 14736.0 16583.7 20160.9 21576.0 21598.8 20354.6 21708.5 21778.8 22077.8 22172.2 4932.7 5322.7 5806.5 5890.0 5896.8 5529.3 5642.3 5744.5 5753.3 5760.7 5699.8 5760.7 5763.1 5766.4 5787.5 5519.9 5721.2 5723.7 5749.8 5775.3 5088.3 5092.0 5097.7 5105.5 5107.2 25092.2 25407.5 25838.9 25876.6 26019.2 2414.3 2589.2 2702.0 2764.9 2800.6 9904.6 14576.5 15108.6 15223.5 15601.7 1482.6 1800.2 1812.6 1881.0 1913.0 109411.0 115837.0 139270.0 140803.0 142247.0 11586.9 11765.5 11807.0 11822.8 11937.9 12633.9 15143.2 15187.2 15194.2 15247.1 6533.5 7025.0 8347.4 8517.0 8536.9 7683.7 8217.6 8228.1 8365.9 8432.4 4587.4 4652.7 4657.8 4678.2 4740.8 1698.4 1991.8 1995.4 1995.8 2005.2 1007.8 1011.7 1018.9 1034.7 1053.8 21050.8 21554.8 21613.6 21717.6 21739.6 840.6 1024.5 1045.0 1045.0 1048.4 9812.5 10378.9 11148.5 11304.8 11308.9 630850.0 699175.0 720653.0 723738.0 724278.0 145649.0 146257.5 153406.5 154018.2 164092.0 999.7 1021.1 1051.1 1055.0 1056.7 19904.3 20065.4 20361.2 20457.0 20465.0 56914.4 57396.0 58838.0 58900.0 59889.4 84891.6 85085.0 86160.6 86911.0 87254.0 7974.0 7983.3 8003.6 8342.7 8359.9 8980.0 10442.3 11802.4 12431.4 12785.2 10501.2 10807.5 10877.5 10943.9 10975.0 10244.5 10472.6 10637.3 10764.6 10929.7 10369.8 10855.0 11005.9 11269.9 11662.2 6877.9 7305.9 7314.4 7500.9 8353.0 9108.9 10973.9 10986.6 11014.6 11047.8 18:32:43 INFO - PROCESS | 1642 | 18:32:43 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5380.50 Median:5223.00 stddev:2884.44 (55.2%) stddev-sans-first:2876.47 18:32:43 INFO - PROCESS | 1642 | Values: 1330.4 1395.8 1420.7 1424.3 1435.3 8088.9 8166.1 8375.5 8468.6 8501.7 7665.7 7694.4 8149.3 8337.1 8353.9 2028.7 2213.9 2253.3 2280.6 2298.0 2269.2 2309.4 2310.5 2315.1 2316.4 2206.0 2262.3 2276.4 2289.1 2293.6 2162.5 2219.0 2230.0 2248.2 2253.9 2028.1 2094.9 2262.4 2331.8 2343.3 8108.0 8307.7 8318.8 8407.0 8442.8 5042.0 5165.7 5186.1 5191.6 5203.5 3381.7 3392.1 3406.8 3462.0 3521.8 1223.8 1225.5 1258.2 1280.5 1289.6 10309.9 10368.9 10416.7 10547.7 10562.2 4384.7 4610.8 4682.5 4695.5 4723.6 9379.1 9466.0 9471.4 9484.6 9501.7 5217.1 5220.5 5225.5 5229.3 5231.1 4556.7 4654.6 4708.5 4751.3 4763.1 3817.3 3852.1 3889.9 3908.5 3946.9 1251.7 1277.6 1286.9 1292.5 1294.7 766.7 835.8 892.1 901.0 936.9 4987.0 5397.1 5485.6 5655.5 5781.6 858.4 985.8 987.8 1018.8 1043.9 3694.9 3787.7 3826.7 3834.8 3902.7 9452.9 9779.4 9800.0 9804.3 9838.5 9116.0 9537.3 9684.9 9795.9 9798.8 7680.7 7880.0 7895.8 7899.8 7912.5 4852.5 5655.7 5674.8 5770.5 5813.5 7670.9 8221.2 8912.6 9016.3 9052.5 8551.7 8755.6 9083.9 9187.4 9273.0 6997.0 7145.8 7287.5 7294.2 7295.7 7465.5 7532.8 7857.7 8038.8 8070.2 7027.3 7068.9 7125.7 7153.3 7226.5 7020.5 7030.2 7055.8 7064.5 7066.6 6252.2 6327.7 6369.0 6404.5 6407.2 4947.3 4988.9 4999.4 5014.3 5062.0 4949.0 4958.4 5051.0 5119.4 5165.1 18:32:43 INFO - PROCESS | 1642 | 18:32:43 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4615.57 Median:5160.22 stddev:1448.34 (28.1%) stddev-sans-first:1416.29 18:32:43 INFO - PROCESS | 1642 | Values: 333.4 349.5 368.9 369.1 379.2 5194.5 5455.6 5583.7 5611.8 5623.7 4996.9 5450.0 5492.0 5513.3 5519.7 3246.2 3986.0 4039.0 4137.7 4148.9 3644.7 4150.3 4153.7 4166.5 4198.8 4107.9 4128.9 4133.7 4134.4 4184.9 4117.5 4118.3 4136.4 4139.0 4157.7 2608.8 3039.4 3354.9 3560.3 3570.7 4537.5 4697.2 5355.1 5374.5 5374.9 4158.1 4563.8 4713.4 4722.5 4767.9 4552.7 5456.9 5731.5 5789.1 5856.2 3129.9 3885.7 3914.5 3928.5 3991.4 5261.1 5653.8 5880.7 5901.6 6098.8 3246.4 3887.1 3922.9 3969.4 4029.0 3992.6 4002.3 4003.7 4015.9 4070.2 3865.5 4515.4 4674.8 4679.5 4743.8 4733.5 5302.1 5821.6 5840.0 5863.2 1287.0 1292.5 1293.0 1296.3 1299.1 813.4 871.7 884.3 887.8 893.9 4972.9 5022.4 5130.8 5172.6 5227.8 5027.1 5673.9 5708.3 5751.5 5754.0 4436.2 4702.5 4793.5 5172.4 5227.3 2624.7 2871.8 2915.8 2973.8 3005.0 4986.8 5551.1 5897.4 5914.8 5949.6 5831.9 5853.2 6125.6 6169.7 6171.4 5783.5 6219.3 6226.3 6252.7 6269.0 5837.6 5881.7 5972.4 6082.5 6127.4 4940.7 5821.8 5919.9 5927.9 5970.2 4763.7 5122.5 5685.8 6087.0 6185.0 3758.4 3942.6 3947.8 3957.8 3962.4 5699.5 6014.4 6038.2 6040.9 6043.5 5029.8 5439.7 5473.6 5839.6 5872.9 5539.4 5707.9 5855.1 5866.3 5886.9 5165.9 5175.4 5298.8 5490.5 5610.9 5154.5 5770.8 5815.8 5820.4 5823.8 4570.0 4766.9 5059.9 5330.3 5436.7 18:32:43 INFO - PROCESS | 1642 | 18:32:43 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:18945.43 Median:3985.65 stddev:26386.15 (662.0%) stddev-sans-first:26424.57 18:32:43 INFO - PROCESS | 1642 | Values: 690.7 693.8 780.0 811.2 825.6 14629.9 15358.6 15563.7 15581.0 15592.2 13983.5 14582.6 14678.9 14711.8 14712.0 858.8 876.9 879.9 880.3 881.7 853.4 871.2 876.6 891.9 894.5 876.2 876.6 878.3 879.8 883.5 853.1 871.8 872.6 872.6 875.8 638.2 640.4 653.7 656.8 657.1 12320.6 15165.7 15206.7 15215.2 15770.5 12425.5 12508.9 12585.7 12606.6 12932.4 11423.3 11584.2 11697.5 11713.4 12014.5 3674.1 3719.6 3729.5 3863.8 3864.7 83940.1 84141.0 102889.5 103152.5 103529.5 10376.6 10920.7 11011.2 11047.8 11273.7 22060.7 22130.1 22250.6 22270.6 22284.5 7703.1 7759.2 7759.4 7857.0 7945.5 4181.8 4310.7 4312.9 4349.3 4358.5 3427.5 3506.7 3511.4 3550.1 3553.9 551.3 632.4 635.3 643.0 649.9 538.5 594.9 644.8 661.8 668.4 9713.8 10010.6 10015.9 10027.7 10045.5 604.3 633.4 639.8 676.9 693.1 4106.6 4447.6 4727.4 4785.1 4827.7 96840.1 99678.5 99997.0 100155.0 101168.5 56409.7 57599.4 74575.3 83720.6 83733.2 64134.0 67453.7 67734.7 68353.7 68975.7 10754.5 10762.8 10862.9 11039.6 11055.8 47669.5 48124.8 48309.8 48777.8 51319.0 54677.5 55232.4 62517.4 62879.4 62892.7 12547.7 12609.6 12716.6 12808.9 12931.7 13220.5 13744.4 14369.3 14512.6 14575.7 11626.6 13491.1 13570.9 13897.1 13939.9 11432.6 13010.4 13241.1 13888.2 13983.4 10842.6 10944.3 13202.5 13214.7 13482.7 9466.6 10969.7 11118.3 11314.9 11329.7 7649.0 8943.8 10763.9 10936.6 10963.0 18:32:43 INFO - PROCESS | 1642 | -------- Summary: end -------- 18:32:43 INFO - PROCESS | 1642 | 18:32:44 INFO - TEST-INFO | 1642: exit 0 18:32:44 INFO - TEST-OK | dromaeo_css | took 1115590ms 18:32:44 INFO - TEST-START | kraken 18:32:44 INFO - operating with platform_type : mac_ 18:32:44 INFO - Initialising browser for kraken test... 18:32:44 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpwdqi5H/profile http://localhost:49244/getInfo.html) 18:32:47 INFO - PROCESS | 1655 | 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] 18:32:47 INFO - PROCESS | 1655 | 2017-02-02 18:32:47.308 plugin-container[1656:9908] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 18:32:47 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:32:47 INFO - PROCESS | 1655 | 2017-02-02 18:32:47.310 plugin-container[1656:9908] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 18:32:47 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:32:47 INFO - PROCESS | 1655 | 2017-02-02 18:32:47.310 plugin-container[1656:9908] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:32:47 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 18:32:47 INFO - PROCESS | 1655 | colorDepth:24 18:32:47 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 18:32:47 INFO - PROCESS | 1655 | __metrics 18:32:47 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 18:32:47 INFO - PROCESS | 1655 | 1486089167492 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/tmpwdqi5H/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpwdqi5H/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpwdqi5H/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpwdqi5H/profile/extensions/talos-powers@TalosPowersService.js:55:9 18:32:48 INFO - TEST-INFO | 1655: exit 0 18:32:48 INFO - Browser initialized. 18:32:48 INFO - Running cycle 1/1 for kraken test... 18:32:48 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpwdqi5H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:32:50 INFO - PROCESS | 1657 | 2017-02-02 18:32:50.518 plugin-container[1658:10028] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 18:32:50 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:32:50 INFO - PROCESS | 1657 | 2017-02-02 18:32:50.518 plugin-container[1658:10028] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 18:32:50 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:32:50 INFO - PROCESS | 1657 | 2017-02-02 18:32:50.519 plugin-container[1658:10028] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:33:00 INFO - PROCESS | 1657 | RSS: Main: 233762816 18:33:00 INFO - PROCESS | 1657 | 18:33:03 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 18:33:04 INFO - PROCESS | 1657 | RSS: Main: 247287808 18:33:04 INFO - PROCESS | 1657 | 18:33:06 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 18:33:07 INFO - PROCESS | 1657 | RSS: Main: 255336448 18:33:07 INFO - PROCESS | 1657 | 18:33:11 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 18:33:11 INFO - PROCESS | 1657 | RSS: Main: 257998848 18:33:11 INFO - PROCESS | 1657 | 18:33:13 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 18:33:14 INFO - PROCESS | 1657 | RSS: Main: 260243456 18:33:14 INFO - PROCESS | 1657 | 18:33:16 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:33:16 INFO - PROCESS | 1657 | RSS: Main: 260620288 18:33:16 INFO - PROCESS | 1657 | 18:33:19 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 18:33:20 INFO - PROCESS | 1657 | RSS: Main: 266379264 18:33:20 INFO - PROCESS | 1657 | 18:33:23 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 18:33:24 INFO - PROCESS | 1657 | RSS: Main: 265801728 18:33:24 INFO - PROCESS | 1657 | 18:33:27 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 18:33:27 INFO - PROCESS | 1657 | RSS: Main: 265990144 18:33:27 INFO - PROCESS | 1657 | 18:33:29 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:33:30 INFO - PROCESS | 1657 | RSS: Main: 265310208 18:33:30 INFO - PROCESS | 1657 | 18:33:32 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:33:32 INFO - PROCESS | 1657 | RSS: Main: 265293824 18:33:32 INFO - PROCESS | 1657 | 18:33:35 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:33:35 INFO - PROCESS | 1657 | RSS: Main: 265240576 18:33:35 INFO - PROCESS | 1657 | 18:33:38 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:33:39 INFO - PROCESS | 1657 | RSS: Main: 265768960 18:33:39 INFO - PROCESS | 1657 | 18:33:42 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:33:43 INFO - PROCESS | 1657 | RSS: Main: 265420800 18:33:43 INFO - PROCESS | 1657 | 18:33:44 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 18:33:45 INFO - PROCESS | 1657 | RSS: Main: 267399168 18:33:45 INFO - PROCESS | 1657 | 18:33:45 INFO - PROCESS | 1657 | __start_tp_report 18:33:45 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 18:33:45 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 18:33:45 INFO - PROCESS | 1657 | |i|pagename|runs| 18:33:45 INFO - PROCESS | 1657 | |0;ai-astar;104;117;119;117;118;116;127;117;117;117 18:33:45 INFO - PROCESS | 1657 | |1;audio-beat-detection;142;115;110;150;111;111;116;141;160;115 18:33:45 INFO - PROCESS | 1657 | |2;audio-dft;197;209;222;291;202;224;184;182;267;273 18:33:45 INFO - PROCESS | 1657 | |3;audio-fft;81;58;60;86;57;49;57;64;94;55 18:33:45 INFO - PROCESS | 1657 | |4;audio-oscillator;121;57;69;98;96;100;109;84;71;81 18:33:45 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;88;86;87;86;107;105;88;88;131;114 18:33:45 INFO - PROCESS | 1657 | |6;imaging-darkroom;95;96;96;95;95;96;94;133;95;104 18:33:45 INFO - PROCESS | 1657 | |7;imaging-desaturate;112;95;93;92;125;98;79;143;141;146 18:33:45 INFO - PROCESS | 1657 | |8;json-parse-financial;55;58;91;94;90;57;58;64;65;63 18:33:45 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;67;74;71;78;71;81;58;83;100;98 18:33:45 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;90;89;90;89;87;89;117;87;87;87 18:33:45 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;142;139;139;144;139;140;141;147;188;141 18:33:45 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;230;190;178;176;178;176;181;225;217;176 18:33:45 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;68;72;62;74;87;88;85;87;85;84 18:33:45 INFO - PROCESS | 1657 | __end_tp_report 18:33:45 INFO - PROCESS | 1657 | __start_cc_report 18:33:45 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,971 18:33:45 INFO - PROCESS | 1657 | __end_cc_report 18:33:45 INFO - PROCESS | 1657 | __startTimestamp1486089225127__endTimestamp 18:33:45 INFO - PROCESS | 1657 | 18:33:45 INFO - PROCESS | 1657 | ------- Summary: start ------- 18:33:45 INFO - PROCESS | 1657 | Number of tests: 14 18:33:45 INFO - PROCESS | 1657 | 18:33:45 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:116.90 Median:117.00 stddev:5.53 (4.7%) stddev-sans-first:3.35 18:33:45 INFO - PROCESS | 1657 | Values: 104.0 117.0 119.0 117.0 118.0 116.0 127.0 117.0 117.0 117.0 18:33:45 INFO - PROCESS | 1657 | 18:33:45 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:127.10 Median:128.50 stddev:19.00 (14.8%) stddev-sans-first:19.37 18:33:45 INFO - PROCESS | 1657 | Values: 142.0 115.0 110.0 150.0 111.0 111.0 116.0 141.0 160.0 115.0 18:33:45 INFO - PROCESS | 1657 | 18:33:45 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:225.10 Median:223.00 stddev:38.78 (17.4%) stddev-sans-first:39.77 18:33:45 INFO - PROCESS | 1657 | Values: 197.0 209.0 222.0 291.0 202.0 224.0 184.0 182.0 267.0 273.0 18:33:45 INFO - PROCESS | 1657 | 18:33:45 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:66.10 Median:62.00 stddev:15.22 (24.5%) stddev-sans-first:15.16 18:33:45 INFO - PROCESS | 1657 | Values: 81.0 58.0 60.0 86.0 57.0 49.0 57.0 64.0 94.0 55.0 18:33:45 INFO - PROCESS | 1657 | 18:33:45 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:88.60 Median:76.00 stddev:19.75 (26.0%) stddev-sans-first:17.12 18:33:45 INFO - PROCESS | 1657 | Values: 121.0 57.0 69.0 98.0 96.0 100.0 109.0 84.0 71.0 81.0 18:33:45 INFO - PROCESS | 1657 | 18:33:45 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:98.00 Median:86.50 stddev:15.58 (18.0%) stddev-sans-first:16.10 18:33:45 INFO - PROCESS | 1657 | Values: 88.0 86.0 87.0 86.0 107.0 105.0 88.0 88.0 131.0 114.0 18:33:45 INFO - PROCESS | 1657 | 18:33:45 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:99.90 Median:95.00 stddev:11.97 (12.6%) stddev-sans-first:12.56 18:33:45 INFO - PROCESS | 1657 | Values: 95.0 96.0 96.0 95.0 95.0 96.0 94.0 133.0 95.0 104.0 18:33:45 INFO - PROCESS | 1657 | 18:33:45 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:112.40 Median:85.50 stddev:24.63 (28.8%) stddev-sans-first:26.13 18:33:45 INFO - PROCESS | 1657 | Values: 112.0 95.0 93.0 92.0 125.0 98.0 79.0 143.0 141.0 146.0 18:33:45 INFO - PROCESS | 1657 | 18:33:45 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:69.50 Median:64.50 stddev:15.66 (24.3%) stddev-sans-first:15.70 18:33:45 INFO - PROCESS | 1657 | Values: 55.0 58.0 91.0 94.0 90.0 57.0 58.0 64.0 65.0 63.0 18:33:45 INFO - PROCESS | 1657 | 18:33:45 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:78.10 Median:76.00 stddev:13.14 (17.3%) stddev-sans-first:13.30 18:33:45 INFO - PROCESS | 1657 | Values: 67.0 74.0 71.0 78.0 71.0 81.0 58.0 83.0 100.0 98.0 18:33:45 INFO - PROCESS | 1657 | 18:33:45 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:89.00 stddev:9.15 (10.3%) stddev-sans-first:9.70 18:33:45 INFO - PROCESS | 1657 | Values: 90.0 89.0 90.0 89.0 87.0 89.0 117.0 87.0 87.0 87.0 18:33:45 INFO - PROCESS | 1657 | 18:33:45 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:141.50 stddev:14.97 (10.6%) stddev-sans-first:15.81 18:33:45 INFO - PROCESS | 1657 | Values: 142.0 139.0 139.0 144.0 139.0 140.0 141.0 147.0 188.0 141.0 18:33:45 INFO - PROCESS | 1657 | 18:33:45 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.70 Median:185.50 stddev:22.21 (12.0%) stddev-sans-first:19.01 18:33:45 INFO - PROCESS | 1657 | Values: 230.0 190.0 178.0 176.0 178.0 176.0 181.0 225.0 217.0 176.0 18:33:45 INFO - PROCESS | 1657 | 18:33:45 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.20 Median:85.00 stddev:9.37 (11.0%) stddev-sans-first:9.02 18:33:45 INFO - PROCESS | 1657 | Values: 68.0 72.0 62.0 74.0 87.0 88.0 85.0 87.0 85.0 84.0 18:33:45 INFO - PROCESS | 1657 | -------- Summary: end -------- 18:33:45 INFO - PROCESS | 1657 | 18:33:46 INFO - TEST-INFO | 1657: exit 0 18:33:46 INFO - TEST-OK | kraken | took 61513ms 18:33:46 INFO - SUITE-END | took 1177s 18:33:46 INFO - Completed test suite (00:19:37) 18:33:46 INFO - javascript benchmark 18:33:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7295.05552042786, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.7317014638825, 3375.139339468435, 3412.436947903596, 3416.248425346426, 3434.6908778209954, 4192.580741925806, 4606.848287928018, 5490.69801160936, 5678.403767604399, 5754.2519472468575, 5554.305711786016, 5684.147377893308, 5688.744006519706, 5733.799317023905, 5857.092150716646, 4989.575886049672, 5071.543561079502, 5082.51716086973, 5142.280080788692, 5188.896222075557, 5170.870728231786, 5278.604104692164, 5290.285811415448, 5290.867728306804, 5364.678119312854, 5135.74321283938, 5180.5337519623035, 5273.077211488013, 5299.993001329735, 5328.200769884529, 5186.455422180655, 5199.402068762103, 5238.109521381374, 5281.39263984639, 5317.813876514303, 5171.974140129313, 5193.714345710984, 5246.711430871301, 5263.894722105575, 5281.181416880389, 5025.045241404122, 5226.3989641191365, 5748.45389687979, 5760.107183386582, 5794.739236734357, 6132.447291485822, 6187.659678717669, 6199.690015499207, 6200.751969921198, 6255.562110652256, 6213.099100630428, 6214.937850621481, 6226.159468471744, 6229.3770622937345, 6238.688065596747, 5893.263342082239, 5922.615030023035, 5940.881182376372, 5952.8809423812145, 5987.101934709828, 5678.176664383641, 6138.78514252008, 6197.783077592263, 6216.813495595139, 6240.032794916795, 6073.696315184223, 6111.135969295249, 6121.785737499166, 6142.775043102407, 6193.256809182927, 6133.509319254449, 6179.969100154561, 6181.258249010148, 6213.96893015532, 6230.158928544679, 6174.0, 6201.6899155042065, 6236.563440559208, 6241.095041219089, 6269.561130720897, 5978.4021597839865, 6081.695915204222, 6199.721012554446, 6211.0, 6238.6880655967925, 4953.356063711694, 4988.301637770715, 4995.300657907896, 5028.421731500925, 5063.341765570526, 4442.089371678798, 4456.930336719164, 4476.306172543261, 4482.977585112054, 4525.140223357617, 5752.9712351437975, 5948.286205655262, 5951.732172052268, 5951.821445356646, 5969.164316995624, 6164.6917654117115, 6175.505959523227, 6180.227471566054, 6184.938150618436, 6221.502279817604, 5880.911786323209, 5895.263092113486, 5904.970475147683, 5910.674912879746, 5927.8221653350465, 5457.5633949283965, 5458.536024437888, 5483.890322193533, 5500.3949565547755, 5502.174673798882, 6166.260048794174, 6220.34686357935, 6282.905756413749, 6356.968215158895, 6367.172267605181, 6229.096780966644, 6236.6258024518675, 6239.719212635351, 6242.28213755424, 6257.186565746424, 6390.360963903572, 6454.483641308778, 6458.451031662361, 6458.67706614658, 6460.806175814733, 6127.571070025056, 6130.551011451207, 6156.5998210116195, 6162.630242185483, 6232.937670623236, 6093.786717465045, 6136.059583474799, 6218.689065546614, 6234.096056071753, 6255.374462553708, 6063.333033366414, 6180.196574445294, 6190.81427557174, 6202.0, 6216.968915155395, 6057.0, 6084.239470066242, 6106.7640410362355, 6122.733612273432, 6124.448799608057, 5963.731632076654, 5990.850228744316, 6055.5458340623745, 6066.272047354346, 6079.118527813531, 6129.724162412791, 6204.441600255998, 6212.316645169119, 6214.627122372672, 6219.595726277777, 5847.1229315603, 5892.793752218652, 5928.288605367384, 6063.6664983426335, 6066.605670631395], "value": 5708.174323567232, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.67730266116376, 494.2956287290612, 501.4158505341275, 503.6298320734262, 526.0189746123481, 31626.841865790666, 38671.99999999996, 39744.41022359106, 41485.0, 41544.96137596561, 42815.35776963348, 43702.344464833055, 43803.342949855774, 43807.12385752283, 44023.559764402344, 9261.722148335544, 10926.726831829188, 11434.485448154854, 11598.59404920828, 11598.826017609743, 11297.26567773092, 11391.259568128087, 11404.828927566094, 11419.942900285487, 11428.914253145938, 11400.315981041123, 11418.14363922705, 11433.256838305526, 11453.656390308304, 11456.255343402694, 11345.26255793375, 11396.772064558745, 11405.828912566276, 11417.31496110236, 11431.314121152758, 11110.388928608923, 11193.104551635932, 11229.55081796727, 11232.21374503785, 11239.0, 38160.61839381598, 38309.80845095785, 38488.422673659916, 38632.80683596592, 38749.41875871864, 3958.3270843956598, 3960.7418532359775, 3971.801409929521, 3985.4221137934837, 4040.6363427291685, 23752.524949501087, 28993.71006289931, 29131.70868291311, 29280.70719292801, 29817.552736708967, 3122.266267427153, 3137.8274194919272, 3148.8740450381956, 3216.5014422764507, 3243.0919342584116, 447786.0, 469794.0, 499031.5048424735, 514563.0, 615776.0, 58626.12060819091, 58819.823603528544, 59311.70344148252, 59358.70320648369, 59532.939700125105, 60419.79160416767, 60847.0, 60994.0, 61086.0, 61325.0, 15234.009789363878, 15459.149746764037, 15487.612809679847, 15489.5353139406, 15792.0, 11977.760444791056, 12079.577214797615, 12091.334976576372, 12100.818487722516, 12121.212121212093, 17914.641707165785, 18078.819211807713, 18108.728369074473, 18136.45590632283, 18159.818401815814, 7002.782926719627, 7504.737334193277, 7706.460547761603, 7830.882536761953, 7874.3857509210475, 751.2412463411885, 847.4449235750593, 881.722257488889, 890.8396488632109, 893.2630579771715, 30020.399592008038, 30364.84817575898, 30743.77024919023, 31394.843025785183, 31544.52683209708, 930.5905401623264, 1031.4224034540682, 1066.1151244467073, 1091.3233795047122, 1169.1698893785338, 15435.614109647124, 15833.920830395775, 15911.68176636484, 16070.955387899983, 16099.678006439806, 668679.0, 669770.0, 671030.0, 672820.0, 675254.0, 47222.76388618035, 47540.0, 47595.04809903783, 47616.04767904692, 47919.520804792206, 1157.6989982604416, 1307.3724612186013, 1403.8736513713816, 1421.2680469558186, 1444.5377479206552, 25323.98704051891, 25842.483150337262, 32527.512087318235, 33477.49783753197, 33686.0, 54575.6356091085, 54620.45379546312, 55189.17216241679, 55196.0, 55289.72355138198, 477915.0, 571237.0, 574939.0, 577574.0, 578050.0, 22141.889290553445, 23275.185368512022, 27027.729722702523, 27218.78173599621, 27291.454170916866, 47753.522464774906, 48547.02905941791, 49568.75215623899, 49699.0, 49872.75063624659, 39553.0, 39628.622282663135, 39737.80131099326, 40454.0, 40645.390319144644, 38918.0, 39331.0, 40288.3956740655, 40412.3938140934, 40955.59044409518, 37645.05887352728, 37830.43254351242, 37938.0, 38410.231795364496, 38548.229035419696, 29446.558301625064, 33378.0, 33463.66536334605, 34960.475592865616, 35127.0, 24892.253232403058, 25232.74767252304, 25536.0, 25612.743872561037, 25729.8421571026], "value": 20270.91602834207, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.40881633468115, 384.8268279274327, 394.47928734071024, 396.5697218517907, 416.05347833678377, 14736.0, 16583.66832663346, 20160.899195504022, 21576.0, 21598.8120653364, 20354.59290814183, 21708.457288567755, 21778.782212177874, 22077.779222207773, 22172.223972160977, 4932.6793758405765, 5322.7072511011875, 5806.506446952014, 5889.998700220973, 5896.823095307126, 5529.253550770655, 5642.322921249456, 5744.4829965303115, 5753.280839895013, 5760.711964401784, 5699.800506982257, 5760.654360738348, 5763.1355296705415, 5766.423357664242, 5787.450192231731, 5519.862003449946, 5721.170430287627, 5723.656580605177, 5749.770009199627, 5775.27809023872, 5088.313077734496, 5092.0, 5097.668651537638, 5105.489451054902, 5107.20838270065, 25092.247232583053, 25407.49185016308, 25838.87080564604, 25876.611850822253, 26019.21942341733, 2414.3360575841607, 2589.1585234798767, 2702.0, 2764.903228387017, 2800.635917330754, 9904.554295056667, 14576.489822856149, 15108.622284442867, 15223.543293701206, 15601.69100920333, 1482.5774654223494, 1800.20790852026, 1812.5921667624812, 1881.0, 1912.9617407651908, 109411.0, 115837.0, 139269.9839518448, 140803.0, 142247.0, 11586.942065289619, 11765.470553825098, 11807.0, 11822.822657660143, 11937.940310298392, 12633.873661263453, 15143.242837858283, 15187.164705941279, 15194.240287985556, 15247.094113235846, 6533.509986751013, 7025.0, 8347.415680902279, 8517.0, 8536.8719469208, 7683.731069412655, 8217.630206640715, 8228.053773816087, 8365.874511882326, 8432.409731318872, 4587.42657167854, 4652.697574657636, 4657.836975705834, 4678.157931572349, 4740.786664600101, 1698.4480043985754, 1991.8008199179967, 1995.4412764425983, 1995.8303544198616, 2005.1678553400175, 1007.7883644434604, 1011.7217765114506, 1018.9388636681823, 1034.6844212515105, 1053.7839742852698, 21050.78949210519, 21554.784452155276, 21613.567728645652, 21717.565648686937, 21739.565208695738, 840.6301227459898, 1024.4979959819634, 1044.968650940473, 1044.9738756530996, 1048.3552615141632, 9812.509374531244, 10378.910214427528, 11148.498317575728, 11304.830427543593, 11308.886911130949, 630850.0, 699175.0, 720653.0, 723738.0, 724278.0, 145649.0, 146257.53742462653, 153406.46593534146, 154018.229908852, 164092.0, 999.6651121874254, 1021.0963297481782, 1051.122312868748, 1055.024102704995, 1056.6777132974516, 19904.303349382702, 20065.39803805888, 20361.185552578325, 20456.954304569423, 20465.0, 56914.43085569257, 57396.0, 58838.0, 58900.0, 59889.401105988385, 84891.5755421219, 85085.0, 86160.56919715612, 86911.0, 87254.0, 7973.9601301995435, 7983.321417679563, 8003.639836207268, 8342.708005219789, 8359.874601880854, 8980.012198658273, 10442.321249118782, 11802.409879506162, 12431.37843107859, 12785.232886026868, 10501.212409069198, 10807.513661885077, 10877.510512027136, 10943.890561094287, 10975.0, 10244.487775611338, 10472.581096756045, 10637.255392122477, 10764.623238186627, 10929.672109836718, 10369.807472140801, 10855.0, 11005.944970275417, 11269.943650281695, 11662.183647144619, 6877.862442751217, 7305.926940730525, 7314.378277846443, 7500.9249907500225, 8352.958235208785, 9108.863367049367, 10973.945130274298, 10986.560537578407, 11014.614488492864, 11047.839976802641], "value": 9792.249061062901, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.3614265152728, 1395.7557427450197, 1420.6874487612722, 1424.2522675595317, 1435.3110506956662, 8088.878666820003, 8166.142555031725, 8375.455595386296, 8468.57657117144, 8501.744947651565, 7665.731699390522, 7694.384449244061, 8149.348052155829, 8337.082920878698, 8353.874691879626, 2028.6855537391727, 2213.900374483152, 2253.256425379629, 2280.6464997925264, 2298.000369839125, 2269.217120093565, 2309.3533810533077, 2310.5378924215142, 2315.097112126272, 2316.444053427182, 2205.9558808823813, 2262.2534563593977, 2276.3967548599635, 2289.107248173214, 2293.6444851048113, 2162.4701948022835, 2218.9889050554725, 2229.977700222993, 2248.2355998960434, 2253.864768113918, 2028.1380413324277, 2094.8743075415523, 2262.423082114067, 2331.8484298520543, 2343.3321503371626, 8107.959460202661, 8307.709230176915, 8318.750437486886, 8406.957965210197, 8442.83114337716, 5042.042012017741, 5165.74171291434, 5186.144286192812, 5191.610629202825, 5203.505666961632, 3381.695647391722, 3392.08413728292, 3406.7838573904432, 3462.0, 3521.7886926784477, 1223.7674841780122, 1225.5159212111166, 1258.2387655468492, 1280.5262053040342, 1289.6260084575463, 10309.896901030968, 10368.948155259252, 10416.739581510523, 10547.683569492927, 10562.20783441245, 4384.714993525411, 4610.792514336863, 4682.508336624605, 4695.5069717679835, 4723.614574639785, 9379.062093790702, 9466.0, 9471.431714097176, 9484.573194206278, 9501.667441639647, 5217.139172036572, 5220.530152286236, 5225.4774522548205, 5229.294045303835, 5231.110711179109, 4556.726596404226, 4654.604358629486, 4708.4820669726305, 4751.287306903923, 4763.095011947719, 3817.2938006468894, 3852.1317161176808, 3889.8833035008997, 3908.511436070491, 3946.881593552198, 1251.730877861246, 1277.6358737759695, 1286.8777466140702, 1292.4571679894466, 1294.6633875192329, 766.7278116268756, 835.8370117826965, 892.1479986612769, 900.9954950225338, 936.8594710793435, 4987.0, 5397.136458166753, 5485.6434331768305, 5655.4910058094965, 5781.595288329777, 858.3605214115399, 985.7831277119022, 987.7678745494803, 1018.8166130096506, 1043.89561043895, 3694.852205911787, 3787.7348585598743, 3826.7090302339966, 3834.7699138051807, 3902.726809123334, 9452.90547094534, 9779.41323520591, 9800.019998000143, 9804.264680149017, 9838.508074596384, 9115.954420227989, 9537.332386733, 9684.903150968541, 9795.902040979641, 9798.804023919482, 7680.731174408869, 7879.960600196962, 7895.802604934923, 7899.763007109796, 7912.4856884302335, 4852.539008794159, 5655.660660360391, 5674.765383731234, 5770.5095066919785, 5813.534917206698, 7670.8849367260655, 8221.17788221173, 8912.55437228123, 9016.2786977043, 9052.502112383881, 8551.700690475804, 8755.562221889008, 9083.909160908306, 9187.356885017985, 9273.0, 6996.965015175095, 7145.82135446618, 7287.526310789782, 7294.197638259893, 7295.671694773854, 7465.514741541782, 7532.811679708051, 7857.685692572233, 8038.799030024296, 8070.152633973348, 7027.262137475696, 7068.858622827412, 7125.714971401086, 7153.284671532805, 7226.530275532074, 7020.508564400648, 7030.156381234285, 7055.788326350218, 7064.470164737562, 7066.57600543969, 6252.155958945484, 6327.746890124527, 6369.0, 6404.455621272058, 6407.199100112486, 4947.2579113133315, 4988.900221995613, 4999.375078115236, 5014.272930424995, 5062.038212739568, 4949.0, 4958.404991400911, 5050.974745126251, 5119.385673719177, 5165.096108180978], "value": 4392.304312065012, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.38490485055075, 349.4792758789403, 368.91722793600775, 369.07178446207774, 379.22448592628075, 5194.54552725237, 5455.618106732531, 5583.664980101197, 5611.7755289788465, 5623.690697011673, 4996.850094497171, 5450.04624190767, 5491.972540137303, 5513.338399392079, 5519.69641669708, 3246.155999440151, 3985.980070099645, 4038.97980510097, 4137.662220845228, 4148.917021659565, 3644.744867859251, 4150.3359462486005, 4153.709240353177, 4166.479235079205, 4198.769067701275, 4107.897302567445, 4128.938065929014, 4133.73130746502, 4134.3591743279685, 4184.916301673965, 4117.505899292074, 4118.341065429547, 4136.400221967813, 4138.97930510347, 4157.729747566398, 2608.778253848406, 3039.4377040247623, 3354.8825791097192, 3560.2523470071314, 3570.696490798285, 4537.478190008125, 4697.224957881946, 5355.116405793039, 5374.543163831079, 5374.946250537484, 4158.147579746144, 4563.794629241692, 4713.363695901078, 4722.504137065593, 4767.878294159101, 4552.7479943015605, 5456.91814622781, 5731.541476681856, 5789.131630255453, 5856.209411729405, 3129.9217519561967, 3885.747426417274, 3914.5498267699295, 3928.508936382952, 3991.3613821788663, 5261.105612045923, 5653.773849046033, 5880.70596470179, 5901.616394934315, 6098.817035488943, 3246.3831871944253, 3887.125396785757, 3922.921196670938, 3969.384745364473, 4029.0, 3992.6207010333974, 4002.3196056670436, 4003.6997225208224, 4015.8996025099023, 4070.247004304154, 3865.536135663738, 4515.412996310459, 4674.836380726658, 4679.485256621769, 4743.810247590127, 4733.502982186889, 5302.072137375943, 5821.592488525847, 5839.970800146057, 5863.237779088691, 1287.0347239570322, 1292.476546998467, 1292.9870701293055, 1296.3259105265208, 1299.142565906497, 813.4468561378201, 871.7079778274349, 884.2748945864458, 887.8224355128871, 893.9374243802871, 4972.925406118911, 5022.447530771612, 5130.769115389817, 5172.586193104543, 5227.837158519117, 5027.114831938024, 5673.943260567424, 5708.315002199763, 5751.511121554631, 5754.0, 4436.201483732894, 4702.506236845082, 4793.496682848251, 5172.379314482287, 5227.294315267391, 2624.7244039375973, 2871.8133321334462, 2915.8396288203926, 2973.795612776829, 3004.9632876657956, 4986.808442596741, 5551.139573366135, 5897.410258974154, 5914.792982245601, 5949.583529153005, 5831.854203644858, 5853.239078919713, 6125.632462052291, 6169.691515424211, 6171.3771647049825, 5783.537317014629, 6219.315875253718, 6226.315105338409, 6252.687365631609, 6269.025257044108, 5837.591368604157, 5881.676737688675, 5972.402005127783, 6082.452579267887, 6127.417895299939, 4940.7035577865445, 5821.76712931478, 5919.852003699942, 5927.940720592911, 5970.223845911498, 4763.7141771493825, 5122.538971492583, 5685.829425117253, 6086.995645718407, 6185.00054946719, 3758.4362345648374, 3942.5663177051074, 3947.8223479944045, 3957.783641160959, 3962.3660214365564, 5699.487046165865, 6014.368491308524, 6038.245219347582, 6040.909386359121, 6043.519337762276, 5029.823956161663, 5439.673619582838, 5473.589480788877, 5839.569305520175, 5872.853178670567, 5539.362973258127, 5707.914381284367, 5855.092460668603, 5866.2960444746905, 5886.94113058864, 5165.92251116226, 5175.404828444626, 5298.827480732881, 5490.486088903185, 5610.943890561042, 5154.5103215194495, 5770.826875193751, 5815.79644712433, 5820.388859169726, 5823.7670493181495, 4569.954300457086, 4766.856994290177, 5059.924101138559, 5330.2804121443105, 5436.65067945634], "value": 4164.40079726843, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.7168061094952, 693.7953303775386, 780.0054929964294, 811.2374368093992, 825.645940657322, 14629.853701462982, 15358.616034599141, 15563.68872622547, 15581.0, 15592.220388980548, 13983.510577129777, 14582.635434114152, 14678.853211467882, 14711.779323310158, 14712.043717158378, 858.8368210040072, 876.9079246679103, 879.9164079412477, 880.2517859819167, 881.7442941546976, 853.3727710133047, 871.1680345270283, 876.6361959786681, 891.888513935758, 894.472261365794, 876.1895246896627, 876.5792419638577, 878.2929741558044, 879.8020445399766, 883.4787475389519, 853.1042405474227, 871.7559083456642, 872.6204101215928, 872.6422166911567, 875.7941883657336, 638.2213699286863, 640.4108220437209, 653.6894974886939, 656.8456412743002, 657.1063353838775, 12320.630381088582, 15165.696686066327, 15206.695866082728, 15215.163166025975, 15770.526884193378, 12425.502979880794, 12508.937455312756, 12585.685357866127, 12606.621801345882, 12932.41804118817, 11423.314601123959, 11584.18910676253, 11697.473613687405, 11713.355765432898, 12014.459349329214, 3674.1182116292166, 3719.609441008682, 3729.459228411892, 3863.826127824255, 3864.7294689371756, 83940.06209782629, 84141.0, 102889.4855525725, 103152.48423757833, 103529.48235258776, 10376.584936602452, 10920.672379828618, 11011.229213955106, 11047.779044419067, 11273.71815704614, 22060.669089963663, 22130.114795408324, 22250.55498890013, 22270.55458890813, 22284.54589538624, 7703.114141873644, 7759.224077592308, 7759.379249660014, 7857.0, 7945.48354356965, 4181.832726690959, 4310.7198032128435, 4312.892177695583, 4349.3475978603465, 4358.476982762026, 3427.4687423449404, 3506.736994725406, 3511.4030614795547, 3550.1479644885044, 3553.875614353485, 551.2915903064543, 632.3739497897141, 635.3487675133026, 642.9517786166057, 649.8992656138306, 538.5018857556744, 594.8661551150957, 644.8452371430823, 661.84777501175, 668.3784080804801, 9713.805723885624, 10010.64962726301, 10015.899841001643, 10027.699169024942, 10045.497725113715, 604.338249616669, 633.379288297471, 639.792067578039, 676.8763852005745, 693.1439672005171, 4106.568810274938, 4447.644188464915, 4727.432708075053, 4785.114753770564, 4827.692875710383, 96840.1263949434, 99678.50160749294, 99997.0, 100155.0, 101168.49415752874, 56409.71795140998, 57599.424005760244, 74575.25424745683, 83720.58139709262, 83733.16266837376, 64134.0, 67453.66273168602, 67734.66132669305, 68353.65823170853, 68975.65512172406, 10754.51604677807, 10762.838557421801, 10862.945685271523, 11039.558417663526, 11055.83416248773, 47669.52330476789, 48124.75937620289, 48309.75845120892, 48777.75611121922, 51319.0, 54677.45322546724, 55232.44767552273, 62517.43706407376, 62879.37120628735, 62892.685536572026, 12547.686307842378, 12609.621711348675, 12716.554920577735, 12808.871911280768, 12931.676708082374, 13220.471181152647, 13744.381502832197, 14369.281535922953, 14512.564623061326, 14575.708485830437, 11626.593069242535, 13491.05562610608, 13570.93214533921, 13897.079664059384, 13939.930300348433, 11432.599859004895, 13010.414531345923, 13241.139325943783, 13888.236147012012, 13983.370748316554, 10842.566297348018, 10944.343339399662, 13202.471901123847, 13214.735705285648, 13482.66293342635, 9466.574004169966, 10969.670909872717, 11118.277311974696, 11314.943425282821, 11329.716757080809, 7648.961755191189, 8943.821123577622, 10763.892361076601, 10936.617218397318, 10963.0], "value": 7271.534603925709, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 119.0, 117.0, 118.0, 116.0, 127.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 115.0, 110.0, 150.0, 111.0, 111.0, 116.0, 141.0, 160.0, 115.0], "value": 127.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 209.0, 222.0, 291.0, 202.0, 224.0, 184.0, 182.0, 267.0, 273.0], "value": 225.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 60.0, 86.0, 57.0, 49.0, 57.0, 64.0, 94.0, 55.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 57.0, 69.0, 98.0, 96.0, 100.0, 109.0, 84.0, 71.0, 81.0], "value": 88.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 86.0, 107.0, 105.0, 88.0, 88.0, 131.0, 114.0], "value": 98.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 94.0, 133.0, 95.0, 104.0], "value": 99.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 95.0, 93.0, 92.0, 125.0, 98.0, 79.0, 143.0, 141.0, 146.0], "value": 112.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 91.0, 94.0, 90.0, 57.0, 58.0, 64.0, 65.0, 63.0], "value": 69.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 71.0, 78.0, 71.0, 81.0, 58.0, 83.0, 100.0, 98.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 90.0, 89.0, 87.0, 89.0, 117.0, 87.0, 87.0, 87.0], "value": 91.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 139.0, 144.0, 139.0, 140.0, 141.0, 147.0, 188.0, 141.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [230.0, 190.0, 178.0, 176.0, 178.0, 176.0, 181.0, 225.0, 217.0, 176.0], "value": 192.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 62.0, 74.0, 87.0, 88.0, 85.0, 87.0, 85.0, 84.0], "value": 79.2, "unit": "score"}]}]} 18:33:46 INFO - Return code: 0 18:33:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:33:46 ERROR - # TBPL SUCCESS # 18:33:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:33:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:33:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:33:46 INFO - 2017-02-02 18:33:46.412 screenresolution[1662:10411] starting screenresolution argv=screenresolution get 18:33:46 INFO - 2017-02-02 18:33:46.416 screenresolution[1662:10411] Display 0: 1600x1200x32@60 18:33:46 INFO - 2017-02-02 18:33:46.422 screenresolution[1663:10414] starting screenresolution argv=screenresolution list 18:33:46 INFO - Available Modes on Display 0 18:33:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:33:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:33:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:33:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:33:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:33:46 INFO - Intel Iris: 18:33:46 INFO - Chipset Model: Intel Iris 18:33:46 INFO - Type: GPU 18:33:46 INFO - Bus: Built-In 18:33:46 INFO - VRAM (Dynamic, Max): 1536 MB 18:33:46 INFO - Vendor: Intel (0x8086) 18:33:46 INFO - Device ID: 0x0a2e 18:33:46 INFO - Revision ID: 0x0009 18:33:46 INFO - Displays: 18:33:46 INFO - Display: 18:33:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:33:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:33:46 INFO - Display Serial Number: 1600x1200 60 18:33:46 INFO - Main Display: Yes 18:33:46 INFO - Mirror: Off 18:33:46 INFO - Online: Yes 18:33:46 INFO - Rotation: Supported 18:33:46 INFO - Return code: 0 18:33:46 INFO - Running post-action listener: _resource_record_post_action 18:33:46 INFO - [mozharness: 2017-02-03 02:33:46.663596Z] Finished run-tests step (success) 18:33:46 INFO - Running post-run listener: _resource_record_post_run 18:33:46 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 38775296; Write bytes: 556440064; Read time: 249; Write time: 1697 18:33:46 INFO - TinderboxPrint: CPU usage
54.7% 18:33:46 INFO - TinderboxPrint: I/O read bytes / time
38,775,296 / 249 18:33:46 INFO - TinderboxPrint: I/O write bytes / time
556,440,064 / 1,697 18:33:46 INFO - TinderboxPrint: CPU idle
2,173.9 (45.3%) 18:33:46 INFO - TinderboxPrint: CPU system
971.1 (20.2%) 18:33:46 INFO - TinderboxPrint: CPU user
1,656.6 (34.5%) 18:33:46 INFO - TinderboxPrint: Swap in / out
291,061,760 / 0 18:33:46 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 248742400; Write bytes: 241033216; Read time: 17883; Write time: 498 18:33:46 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 35305984; Write bytes: 301947392; Read time: 226; Write time: 1159 18:33:47 INFO - Running post-run listener: _upload_blobber_files 18:33:47 INFO - Blob upload gear active. 18:33:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:33:47 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 18:33:47 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'] 18:33:47 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 18:33:47 INFO - (blobuploader) - INFO - Open directory for files ... 18:33:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:33:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:33:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:33:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:33:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:33:48 INFO - (blobuploader) - INFO - Done attempting. 18:33:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:33:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:33:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:33:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:33:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:33:49 INFO - (blobuploader) - INFO - Done attempting. 18:33:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:33:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:33:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:33:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:33:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:33:50 INFO - (blobuploader) - INFO - Done attempting. 18:33:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:33:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:33:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:33:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:33:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:33:53 INFO - (blobuploader) - INFO - Done attempting. 18:33:53 INFO - (blobuploader) - INFO - Iteration through files over. 18:33:53 INFO - Return code: 0 18:33:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:33:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:33:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29ee32d49f5c209e546cfbdedae92d157ee72589f5e49a79b50c15e590c1720d40d8efe272c11611a7b04e7cf64e3b0c4eba76b220a35e6289e168bd108f96a3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f5357b3717235887b9b38441078e37acfdc1129c7e8953a8f835093ec8cf56ef3d0290c6e2487a0867de872e0e262b6fc6128d8d30fd4bc803b33fd2a9bcc85", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b6bb3f15640bbf6963a050bf18cd3ae4a8a7163fbd676f78ef7ffb5d75c770a68d869ee4adbe1af5a8ce73c4c352ce23328ae42266c21c4073be1d19f997e17", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ab88118d2584a411f08f32de715daab2c9f37a9ec60dd7759811e2a822fb086bcb6c14b40ee2536ed099206e888e531554e5da8413bdfae06c0b56665232e34"} 18:33:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:33:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:33:53 INFO - Contents: 18:33:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29ee32d49f5c209e546cfbdedae92d157ee72589f5e49a79b50c15e590c1720d40d8efe272c11611a7b04e7cf64e3b0c4eba76b220a35e6289e168bd108f96a3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f5357b3717235887b9b38441078e37acfdc1129c7e8953a8f835093ec8cf56ef3d0290c6e2487a0867de872e0e262b6fc6128d8d30fd4bc803b33fd2a9bcc85", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b6bb3f15640bbf6963a050bf18cd3ae4a8a7163fbd676f78ef7ffb5d75c770a68d869ee4adbe1af5a8ce73c4c352ce23328ae42266c21c4073be1d19f997e17", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ab88118d2584a411f08f32de715daab2c9f37a9ec60dd7759811e2a822fb086bcb6c14b40ee2536ed099206e888e531554e5da8413bdfae06c0b56665232e34"} 18:33:53 INFO - Running post-run listener: copy_logs_to_upload_dir 18:33:53 INFO - Copying logs to upload dir... 18:33:53 INFO - mkdir: /builds/slave/test/build/upload/logs 18:33:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.401647 ========= master_lag: 0.82 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-02 18:33:54.018729) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 18:33:54.029596) ========= 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.41r3Jqqnap/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.WcQxllSi36/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/29ee32d49f5c209e546cfbdedae92d157ee72589f5e49a79b50c15e590c1720d40d8efe272c11611a7b04e7cf64e3b0c4eba76b220a35e6289e168bd108f96a3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f5357b3717235887b9b38441078e37acfdc1129c7e8953a8f835093ec8cf56ef3d0290c6e2487a0867de872e0e262b6fc6128d8d30fd4bc803b33fd2a9bcc85", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b6bb3f15640bbf6963a050bf18cd3ae4a8a7163fbd676f78ef7ffb5d75c770a68d869ee4adbe1af5a8ce73c4c352ce23328ae42266c21c4073be1d19f997e17", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ab88118d2584a411f08f32de715daab2c9f37a9ec60dd7759811e2a822fb086bcb6c14b40ee2536ed099206e888e531554e5da8413bdfae06c0b56665232e34"} build_url:https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010638 build_url: 'https://queue.taskcluster.net/v1/task/NawbCs0fTn-cUin1sHbYsg/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/29ee32d49f5c209e546cfbdedae92d157ee72589f5e49a79b50c15e590c1720d40d8efe272c11611a7b04e7cf64e3b0c4eba76b220a35e6289e168bd108f96a3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f5357b3717235887b9b38441078e37acfdc1129c7e8953a8f835093ec8cf56ef3d0290c6e2487a0867de872e0e262b6fc6128d8d30fd4bc803b33fd2a9bcc85", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b6bb3f15640bbf6963a050bf18cd3ae4a8a7163fbd676f78ef7ffb5d75c770a68d869ee4adbe1af5a8ce73c4c352ce23328ae42266c21c4073be1d19f997e17", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ab88118d2584a411f08f32de715daab2c9f37a9ec60dd7759811e2a822fb086bcb6c14b40ee2536ed099206e888e531554e5da8413bdfae06c0b56665232e34"}' ========= master_lag: 0.50 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 18:33:54.544510) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 18:33:54.544826) ========= 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.41r3Jqqnap/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.WcQxllSi36/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.005023 ========= master_lag: 0.31 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 18:33:54.858451) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 18:33:54.858728) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 18:33:54.859091) ========= ========= Total master_lag: 1.71 =========