builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0134 starttime: 1493424184.75 results: success (0) buildid: 20170428170217 builduid: e681dd453564458cbe1eeced28325583 revision: b3b32894d9326d147238d9f071e1814ab3fdc850 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:03:04.749692) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 17:03:04.750245) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:03:04.750571) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 17:03:04.777149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:03:04.777746) ========= 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.CfTRj15bmy/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.LIQMI172vb/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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-04-28 17:03:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 173M=0s 2017-04-28 17:03:04 (173 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101292 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:03:04.904484) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:03:04.904854) ========= 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.CfTRj15bmy/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.LIQMI172vb/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.020400 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:03:04.953760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 17:03:04.954185) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b3b32894d9326d147238d9f071e1814ab3fdc850 --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 b3b32894d9326d147238d9f071e1814ab3fdc850 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CfTRj15bmy/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.LIQMI172vb/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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-04-28 17:03:05,039 truncating revision to first 12 chars 2017-04-28 17:03:05,040 Setting DEBUG logging. 2017-04-28 17:03:05,040 attempt 1/10 2017-04-28 17:03:05,040 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b3b32894d932?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-28 17:03:06,361 unpacking tar archive at: mozilla-central-b3b32894d932/testing/mozharness/ program finished with exit code 0 elapsedTime=1.581311 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 17:03:06.560144) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:03:06.560498) ========= script_repo_revision: b3b32894d9326d147238d9f071e1814ab3fdc850 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 17:03:06.560940) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:03:06.561219) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 17:03:06.582558) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-28 17:03:06.582863) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CfTRj15bmy/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.LIQMI172vb/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 17:03:06 INFO - MultiFileLogger online at 20170428 17:03:06 in /builds/slave/test 17:03:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:03:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:03:06 INFO - {'append_to_log': False, 17:03:06 INFO - 'base_work_dir': '/builds/slave/test', 17:03:06 INFO - 'blob_upload_branch': 'Firefox', 17:03:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:03:06 INFO - 'branch': 'Firefox', 17:03:06 INFO - 'buildbot_json_path': 'buildprops.json', 17:03:06 INFO - 'config_files': ('talos/mac_config.py',), 17:03:06 INFO - 'default_actions': ('clobber', 17:03:06 INFO - 'read-buildbot-config', 17:03:06 INFO - 'download-and-extract', 17:03:06 INFO - 'populate-webroot', 17:03:06 INFO - 'create-virtualenv', 17:03:06 INFO - 'install', 17:03:06 INFO - 'run-tests'), 17:03:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:03:06 INFO - 'download_minidump_stackwalk': True, 17:03:06 INFO - 'download_symbols': 'ondemand', 17:03:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:03:06 INFO - 'tooltool.py': '/tools/tooltool.py', 17:03:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:03:06 INFO - '/tools/misc-python/virtualenv.py')}, 17:03:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:03:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:03:06 INFO - 'gecko_profile': False, 17:03:06 INFO - 'gecko_profile_interval': 0, 17:03:06 INFO - 'installer_path': 'installer.exe', 17:03:06 INFO - 'log_level': 'info', 17:03:06 INFO - 'log_name': 'talos', 17:03:06 INFO - 'log_to_console': True, 17:03:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:03:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:03:06 INFO - 'opt_config_files': (), 17:03:06 INFO - 'pip_index': False, 17:03:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:03:06 INFO - 'cmd': ('bash', 17:03:06 INFO - '-c', 17:03:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:03:06 INFO - 'enabled': True, 17:03:06 INFO - 'halt_on_failure': False, 17:03:06 INFO - 'name': 'check_screen_resolution'},), 17:03:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:03:06 INFO - 'cmd': ('bash', 17:03:06 INFO - '-c', 17:03:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:03:06 INFO - 'enabled': True, 17:03:06 INFO - 'halt_on_failure': False, 17:03:06 INFO - 'name': 'check_screen_resolution'},), 17:03:06 INFO - 'run_cmd_checks_enabled': True, 17:03:06 INFO - 'suite': 'dromaeojs', 17:03:06 INFO - 'system_bits': '32', 17:03:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:03:06 INFO - 'title': 't-yosemite-r7-0134', 17:03:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:03:06 INFO - 'use_talos_json': True, 17:03:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:03:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:03:06 INFO - 'work_dir': 'build'} 17:03:06 INFO - [mozharness: 2017-04-29 00:03:06.794567Z] Running clobber step. 17:03:06 INFO - Running pre-action listener: _resource_record_pre_action 17:03:06 INFO - Running main action method: clobber 17:03:06 INFO - rmtree: /builds/slave/test/build 17:03:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:03:08 INFO - Running post-action listener: _resource_record_post_action 17:03:08 INFO - [mozharness: 2017-04-29 00:03:08.650458Z] Finished clobber step (success) 17:03:08 INFO - [mozharness: 2017-04-29 00:03:08.650613Z] Running read-buildbot-config step. 17:03:08 INFO - Running pre-action listener: _resource_record_pre_action 17:03:08 INFO - Running main action method: read_buildbot_config 17:03:08 INFO - Using buildbot properties: 17:03:08 INFO - { 17:03:08 INFO - "project": "", 17:03:08 INFO - "product": "firefox", 17:03:08 INFO - "script_repo_revision": "production", 17:03:08 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:03:08 INFO - "repository": "", 17:03:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:03:08 INFO - "buildid": "20170428170217", 17:03:08 INFO - "stage_platform": "macosx64", 17:03:08 INFO - "basedir": "/builds/slave/test", 17:03:08 INFO - "buildnumber": 49, 17:03:08 INFO - "platform": "yosemite_r7", 17:03:08 INFO - "mozci_request": { 17:03:08 INFO - "priority": 0, 17:03:08 INFO - "type": "trigger_all_talos_jobs", 17:03:08 INFO - "times": 6 17:03:08 INFO - }, 17:03:08 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:03:08 INFO - "slavebuilddir": "test", 17:03:08 INFO - "branch": "mozilla-central", 17:03:08 INFO - "revision": "b3b32894d9326d147238d9f071e1814ab3fdc850", 17:03:08 INFO - "slavename": "t-yosemite-r7-0134", 17:03:08 INFO - "builduid": "e681dd453564458cbe1eeced28325583", 17:03:08 INFO - "repo_path": "mozilla-central" 17:03:08 INFO - } 17:03:08 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg. 17:03:08 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json. 17:03:08 INFO - Running post-action listener: _resource_record_post_action 17:03:08 INFO - [mozharness: 2017-04-29 00:03:08.654456Z] Finished read-buildbot-config step (success) 17:03:08 INFO - [mozharness: 2017-04-29 00:03:08.654568Z] Running download-and-extract step. 17:03:08 INFO - Running pre-action listener: _resource_record_pre_action 17:03:08 INFO - Running main action method: download_and_extract 17:03:08 INFO - mkdir: /builds/slave/test/build/tests 17:03: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')]} 17:03:08 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json 17:03:08 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:03:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 17:03:09 INFO - Downloaded 1325 bytes. 17:03:09 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:03:09 INFO - Using the following test package requirements: 17:03:09 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:09 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 17:03:09 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:03:09 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:09 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:03:09 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:09 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:03:09 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:09 INFO - u'jsshell-mac.zip'], 17:03:09 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:09 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:03:09 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:03:09 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:09 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:03:09 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:09 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:03:09 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:09 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:03:09 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:03:09 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:03:09 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:03:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip 17:03:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:03:09 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:03:10 INFO - Content-Length response header: 52698163 17:03:10 INFO - Bytes received: 52698163 17:03:26 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:03:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip 17:03:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:03:26 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:03:27 INFO - Content-Length response header: 52698163 17:03:27 INFO - Bytes received: 52698163 17:03:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.talos.tests.zip 17:03:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:03:43 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:03:44 INFO - Content-Length response header: 14408809 17:03:44 INFO - Bytes received: 14408809 17:03:44 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')]} 17:03:44 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:03:44 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:03:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 17:03:46 INFO - Downloaded 71219323 bytes. 17:03:46 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:03:46 INFO - mkdir: /builds/slave/test/properties 17:03:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:03:46 INFO - Writing to file /builds/slave/test/properties/build_url 17:03:46 INFO - Contents: 17:03:46 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg 17:03:46 INFO - Running post-action listener: _resource_record_post_action 17:03:46 INFO - Running post-action listener: set_extra_try_arguments 17:03:46 INFO - [mozharness: 2017-04-29 00:03:46.371995Z] Finished download-and-extract step (success) 17:03:46 INFO - [mozharness: 2017-04-29 00:03:46.372089Z] Running populate-webroot step. 17:03:46 INFO - Running pre-action listener: _resource_record_pre_action 17:03:46 INFO - Running main action method: populate_webroot 17:03:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:03:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:03:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:03:46 INFO - '--tppagecycles', 17:03:46 INFO - '7'], 17:03:46 INFO - 'tests': ['tsvgm']}}, 17:03:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:03:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:03:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:03:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:03:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:03:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:03:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:03:46 INFO - 'talos_options': ['--disable-e10s'], 17:03:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:03:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:03:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:03:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:03:46 INFO - 'talos_options': ['--disable-e10s'], 17:03:46 INFO - 'tests': ['damp', 'tps']}, 17:03:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:03:46 INFO - 'tests': ['damp', 'tps']}, 17:03:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:03:46 INFO - 'tests': ['dromaeo_dom']}, 17:03:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:03:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:03:46 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:03:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:03:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:03:46 INFO - 'tests': ['a11yr', 17:03:46 INFO - 'ts_paint', 17:03:46 INFO - 'tpaint', 17:03:46 INFO - 'sessionrestore', 17:03:46 INFO - 'sessionrestore_no_auto_restore', 17:03:46 INFO - 'tabpaint']}, 17:03:46 INFO - 'other-e10s': {'tests': ['a11yr', 17:03:46 INFO - 'ts_paint', 17:03:46 INFO - 'tpaint', 17:03:46 INFO - 'sessionrestore', 17:03:46 INFO - 'sessionrestore_no_auto_restore', 17:03:46 INFO - 'tabpaint']}, 17:03:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:03:46 INFO - 'ts_paint', 17:03:46 INFO - 'tpaint', 17:03:46 INFO - 'sessionrestore', 17:03:46 INFO - 'sessionrestore_no_auto_restore', 17:03:46 INFO - 'tabpaint']}, 17:03:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:03:46 INFO - 'ts_paint', 17:03:46 INFO - 'tpaint', 17:03:46 INFO - 'sessionrestore', 17:03:46 INFO - 'sessionrestore_no_auto_restore', 17:03:46 INFO - 'tabpaint']}, 17:03:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:03:46 INFO - 'tests': ['a11yr', 17:03:46 INFO - 'ts_paint', 17:03:46 INFO - 'tpaint', 17:03:46 INFO - 'sessionrestore', 17:03:46 INFO - 'sessionrestore_no_auto_restore', 17:03:46 INFO - 'tabpaint']}, 17:03:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:03:46 INFO - 'tests': ['a11yr', 17:03:46 INFO - 'ts_paint', 17:03:46 INFO - 'tpaint', 17:03:46 INFO - 'sessionrestore', 17:03:46 INFO - 'sessionrestore_no_auto_restore', 17:03:46 INFO - 'tabpaint']}, 17:03:46 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 17:03:46 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 17:03:46 INFO - 'bloom_basic_ref']}, 17:03:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:03:46 INFO - 'tests': ['tsvgx', 17:03:46 INFO - 'tsvgr_opacity', 17:03:46 INFO - 'tart', 17:03:46 INFO - 'tscrollx', 17:03:46 INFO - 'cart', 17:03:46 INFO - 'tsvg_static']}, 17:03:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:03:46 INFO - 'tsvgr_opacity', 17:03:46 INFO - 'tart', 17:03:46 INFO - 'tscrollx', 17:03:46 INFO - 'cart', 17:03:46 INFO - 'tsvg_static']}, 17:03:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:03:46 INFO - 'talos_options': ['--disable-e10s'], 17:03:46 INFO - 'tests': ['tp5o']}, 17:03:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:03:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:03:46 INFO - 'talos_options': ['--disable-e10s', 17:03:46 INFO - '--xperf_path', 17:03:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:03:46 INFO - 'tests': ['tp5n']}, 17:03:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:03:46 INFO - 'talos_options': ['--xperf_path', 17:03:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:03:46 INFO - 'tests': ['tp5n']}}, 17:03:46 INFO - 'talos.zip': {'path': '', 17:03:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:03:46 INFO - Running post-action listener: _resource_record_post_action 17:03:46 INFO - [mozharness: 2017-04-29 00:03:46.391214Z] Finished populate-webroot step (success) 17:03:46 INFO - [mozharness: 2017-04-29 00:03:46.391322Z] Running create-virtualenv step. 17:03:46 INFO - Running pre-action listener: _resource_record_pre_action 17:03:46 INFO - Running main action method: create_virtualenv 17:03:46 INFO - Creating virtualenv /builds/slave/test/build/venv 17:03:46 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 17:03:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:03:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:03:46 INFO - Using real prefix '/tools/python27' 17:03:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:03:47 INFO - Installing distribute.............................................................................................................................................................................................done. 17:03:50 INFO - Installing pip.................done. 17:03:50 INFO - Return code: 0 17:03:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:03:50 INFO - Reading from file tmpfile_stdout 17:03:50 INFO - Output received: 17:03:50 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) 17:03:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:03: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')]} 17:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03: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')]} 17:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8e3d84e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad9d30>, '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 0x1089ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108acebe8>, '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.CfTRj15bmy/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.LIQMI172vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 17:03:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:03:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CfTRj15bmy/Render', 17:03:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:50 INFO - 'HOME': '/Users/cltbld', 17:03:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:50 INFO - 'LOGNAME': 'cltbld', 17:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:50 INFO - 'MOZ_NO_REMOTE': '1', 17:03:50 INFO - 'NO_EM_RESTART': '1', 17:03:50 INFO - 'PAGER': '/bin/cat', 17:03:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:50 INFO - 'PWD': '/builds/slave/test', 17:03:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:50 INFO - 'SHELL': '/bin/bash', 17:03:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LIQMI172vb/Listeners', 17:03:50 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 17:03:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:50 INFO - 'USER': 'cltbld', 17:03:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:50 INFO - 'XPC_FLAGS': '0x0', 17:03:50 INFO - 'XPC_SERVICE_NAME': '0', 17:03:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:50 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 17:03:50 INFO - Cleaning up... 17:03:50 INFO - Return code: 0 17:03:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:03: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')]} 17:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03: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')]} 17:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8e3d84e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad9d30>, '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 0x1089ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108acebe8>, '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.CfTRj15bmy/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.LIQMI172vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 17:03:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:03:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CfTRj15bmy/Render', 17:03:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:50 INFO - 'HOME': '/Users/cltbld', 17:03:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:50 INFO - 'LOGNAME': 'cltbld', 17:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:50 INFO - 'MOZ_NO_REMOTE': '1', 17:03:50 INFO - 'NO_EM_RESTART': '1', 17:03:50 INFO - 'PAGER': '/bin/cat', 17:03:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:50 INFO - 'PWD': '/builds/slave/test', 17:03:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:50 INFO - 'SHELL': '/bin/bash', 17:03:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LIQMI172vb/Listeners', 17:03:50 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 17:03:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:50 INFO - 'USER': 'cltbld', 17:03:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:50 INFO - 'XPC_FLAGS': '0x0', 17:03:50 INFO - 'XPC_SERVICE_NAME': '0', 17:03:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:50 INFO - Downloading/unpacking psutil>=3.1.1 17:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:03:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:03:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:03:54 INFO - Installing collected packages: psutil 17:03:54 INFO - Running setup.py install for psutil 17:03:54 INFO - building 'psutil._psutil_osx' extension 17:03:54 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 17:03:54 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 17:03:55 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 17:03:55 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 17:03:55 INFO - building 'psutil._psutil_posix' extension 17:03:55 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 17:03:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:03:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:03:55 INFO - ^ 17:03:55 INFO - 1 warning generated. 17:03:55 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 17:03:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:03:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:03:55 INFO - Successfully installed psutil 17:03:55 INFO - Cleaning up... 17:03:55 INFO - Return code: 0 17:03:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:03:55 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')]} 17:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:55 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')]} 17:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:55 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 0x108cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8e3d84e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad9d30>, '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 0x1089ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108acebe8>, '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.CfTRj15bmy/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.LIQMI172vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 17:03:55 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 17:03:55 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 17:03:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CfTRj15bmy/Render', 17:03:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:55 INFO - 'HOME': '/Users/cltbld', 17:03:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:55 INFO - 'LOGNAME': 'cltbld', 17:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:55 INFO - 'MOZ_NO_REMOTE': '1', 17:03:55 INFO - 'NO_EM_RESTART': '1', 17:03:55 INFO - 'PAGER': '/bin/cat', 17:03:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:55 INFO - 'PWD': '/builds/slave/test', 17:03:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:55 INFO - 'SHELL': '/bin/bash', 17:03:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LIQMI172vb/Listeners', 17:03:55 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 17:03:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:55 INFO - 'USER': 'cltbld', 17:03:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:55 INFO - 'XPC_FLAGS': '0x0', 17:03:55 INFO - 'XPC_SERVICE_NAME': '0', 17:03:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:03:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:03:58 INFO - Installing collected packages: mozsystemmonitor 17:03:58 INFO - Running setup.py install for mozsystemmonitor 17:03:58 INFO - Successfully installed mozsystemmonitor 17:03:58 INFO - Cleaning up... 17:03:58 INFO - Return code: 0 17:03:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8e3d84e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad9d30>, '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 0x1089ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108acebe8>, '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.CfTRj15bmy/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.LIQMI172vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 17:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:03:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CfTRj15bmy/Render', 17:03:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:03:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:03:58 INFO - 'HOME': '/Users/cltbld', 17:03:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:03:58 INFO - 'LOGNAME': 'cltbld', 17:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:58 INFO - 'MOZ_NO_REMOTE': '1', 17:03:58 INFO - 'NO_EM_RESTART': '1', 17:03:58 INFO - 'PAGER': '/bin/cat', 17:03:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:58 INFO - 'PWD': '/builds/slave/test', 17:03:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:03:58 INFO - 'SHELL': '/bin/bash', 17:03:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LIQMI172vb/Listeners', 17:03:58 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 17:03:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:03:58 INFO - 'USER': 'cltbld', 17:03:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:03:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:58 INFO - 'XPC_FLAGS': '0x0', 17:03:58 INFO - 'XPC_SERVICE_NAME': '0', 17:03:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:58 INFO - Downloading/unpacking jsonschema==2.5.1 17:03:58 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 17:03:58 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 17:03:58 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 17:03:58 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 17:03:58 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 17:03:58 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 17:04:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:04:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:04:01 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 17:04:01 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 17:04:01 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 17:04:01 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 17:04:01 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 17:04:01 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 17:04:01 INFO - Downloading functools32-3.2.3-2.tar.gz 17:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:04:02 INFO - warning: no files found matching '*.txt' 17:04:02 INFO - no previously-included directories found matching 'build' 17:04:02 INFO - no previously-included directories found matching 'dist' 17:04:02 INFO - no previously-included directories found matching '.git*' 17:04:02 INFO - Installing collected packages: jsonschema, functools32 17:04:02 INFO - Running setup.py install for functools32 17:04:02 INFO - warning: no files found matching '*.txt' 17:04:02 INFO - no previously-included directories found matching 'build' 17:04:02 INFO - no previously-included directories found matching 'dist' 17:04:02 INFO - no previously-included directories found matching '.git*' 17:04:02 INFO - Successfully installed jsonschema functools32 17:04:02 INFO - Cleaning up... 17:04:02 INFO - Return code: 0 17:04:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:04:02 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')]} 17:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:02 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')]} 17:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:03 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 0x108cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8e3d84e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad9d30>, '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 0x1089ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108acebe8>, '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.CfTRj15bmy/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.LIQMI172vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 17:04:03 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 17:04:03 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 17:04:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CfTRj15bmy/Render', 17:04:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:03 INFO - 'HOME': '/Users/cltbld', 17:04:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:03 INFO - 'LOGNAME': 'cltbld', 17:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:03 INFO - 'MOZ_NO_REMOTE': '1', 17:04:03 INFO - 'NO_EM_RESTART': '1', 17:04:03 INFO - 'PAGER': '/bin/cat', 17:04:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:03 INFO - 'PWD': '/builds/slave/test', 17:04:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:03 INFO - 'SHELL': '/bin/bash', 17:04:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LIQMI172vb/Listeners', 17:04:03 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 17:04:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:03 INFO - 'USER': 'cltbld', 17:04:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:03 INFO - 'XPC_FLAGS': '0x0', 17:04:03 INFO - 'XPC_SERVICE_NAME': '0', 17:04:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:04:03 INFO - Cleaning up... 17:04:03 INFO - Return code: 0 17:04:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:03 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 0x108cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8e3d84e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad9d30>, '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 0x1089ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108acebe8>, '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.CfTRj15bmy/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.LIQMI172vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 17:04:03 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 17:04:03 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 17:04:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CfTRj15bmy/Render', 17:04:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:03 INFO - 'HOME': '/Users/cltbld', 17:04:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:03 INFO - 'LOGNAME': 'cltbld', 17:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:03 INFO - 'MOZ_NO_REMOTE': '1', 17:04:03 INFO - 'NO_EM_RESTART': '1', 17:04:03 INFO - 'PAGER': '/bin/cat', 17:04:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:03 INFO - 'PWD': '/builds/slave/test', 17:04:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:03 INFO - 'SHELL': '/bin/bash', 17:04:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LIQMI172vb/Listeners', 17:04:03 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 17:04:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:03 INFO - 'USER': 'cltbld', 17:04:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:03 INFO - 'XPC_FLAGS': '0x0', 17:04:03 INFO - 'XPC_SERVICE_NAME': '0', 17:04:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:04 INFO - Downloading/unpacking blobuploader==1.2.4 17:04:04 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 17:04:04 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 17:04:04 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 17:04:04 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 17:04:04 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 17:04:04 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 17:04:06 INFO - Downloading blobuploader-1.2.4.tar.gz 17:04:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:04:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:04:07 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 17:04:07 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 17:04:07 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 17:04:07 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 17:04:07 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 17:04:07 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 17:04:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:04:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:04:07 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 17:04:07 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 17:04:07 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 17:04:07 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 17:04:07 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 17:04:07 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 17:04:08 INFO - Downloading docopt-0.6.1.tar.gz 17:04:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:04:08 INFO - Installing collected packages: blobuploader, requests, docopt 17:04:08 INFO - Running setup.py install for blobuploader 17:04:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:04:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:04:08 INFO - Running setup.py install for requests 17:04:08 INFO - Running setup.py install for docopt 17:04:09 INFO - Successfully installed blobuploader requests docopt 17:04:09 INFO - Cleaning up... 17:04:09 INFO - Return code: 0 17:04:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:09 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 0x108cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8e3d84e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad9d30>, '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 0x1089ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108acebe8>, '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.CfTRj15bmy/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.LIQMI172vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 17:04:09 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 17:04:09 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 17:04:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CfTRj15bmy/Render', 17:04:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:09 INFO - 'HOME': '/Users/cltbld', 17:04:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:09 INFO - 'LOGNAME': 'cltbld', 17:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:09 INFO - 'MOZ_NO_REMOTE': '1', 17:04:09 INFO - 'NO_EM_RESTART': '1', 17:04:09 INFO - 'PAGER': '/bin/cat', 17:04:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:09 INFO - 'PWD': '/builds/slave/test', 17:04:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:09 INFO - 'SHELL': '/bin/bash', 17:04:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LIQMI172vb/Listeners', 17:04:09 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 17:04:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:09 INFO - 'USER': 'cltbld', 17:04:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:09 INFO - 'XPC_FLAGS': '0x0', 17:04:09 INFO - 'XPC_SERVICE_NAME': '0', 17:04:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:04:09 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-ftAqbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:04:09 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-r7NJTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:04:09 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-WyiZ4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:04:09 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Ldifpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:04:09 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-pj8IwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:04:09 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-bk5d89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:04:10 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-z1XWV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:04:10 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-cGF1Ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:04:10 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-hHvdeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:04:10 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-GuTLru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:04:10 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-4s2uX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:04:10 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-GDGTmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:04:10 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-JYkPGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:04:10 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Ne6pPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:10 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Gx8DDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:04:10 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-XS_nnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:04:11 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Cy31tC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:04:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:04:11 INFO - Running setup.py install for manifestparser 17:04:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:04:11 INFO - Running setup.py install for mozcrash 17:04:11 INFO - Running setup.py install for mozdebug 17:04:11 INFO - Running setup.py install for mozdevice 17:04:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:04:11 INFO - Running setup.py install for mozfile 17:04:11 INFO - Running setup.py install for mozhttpd 17:04:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:04:12 INFO - Running setup.py install for mozinfo 17:04:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:04:12 INFO - Running setup.py install for mozInstall 17:04:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:04:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:04:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:04:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:04:12 INFO - Running setup.py install for mozleak 17:04:12 INFO - Running setup.py install for mozlog 17:04:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:04:12 INFO - Running setup.py install for moznetwork 17:04:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:04:12 INFO - Running setup.py install for mozprocess 17:04:12 INFO - Running setup.py install for mozprofile 17:04:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:04:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:04:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:04:13 INFO - Running setup.py install for mozrunner 17:04:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:04:13 INFO - Running setup.py install for mozscreenshot 17:04:13 INFO - Running setup.py install for moztest 17:04:13 INFO - Running setup.py install for mozversion 17:04:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:04:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:04:13 INFO - Cleaning up... 17:04:13 INFO - Return code: 0 17:04:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:13 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 0x108cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8e3d84e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad9d30>, '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 0x1089ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108acebe8>, '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.CfTRj15bmy/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.LIQMI172vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 17:04:13 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 17:04:13 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 17:04:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CfTRj15bmy/Render', 17:04:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:13 INFO - 'HOME': '/Users/cltbld', 17:04:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:13 INFO - 'LOGNAME': 'cltbld', 17:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:13 INFO - 'MOZ_NO_REMOTE': '1', 17:04:13 INFO - 'NO_EM_RESTART': '1', 17:04:13 INFO - 'PAGER': '/bin/cat', 17:04:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:13 INFO - 'PWD': '/builds/slave/test', 17:04:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:13 INFO - 'SHELL': '/bin/bash', 17:04:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LIQMI172vb/Listeners', 17:04:13 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 17:04:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:13 INFO - 'USER': 'cltbld', 17:04:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:13 INFO - 'XPC_FLAGS': '0x0', 17:04:13 INFO - 'XPC_SERVICE_NAME': '0', 17:04:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:04:14 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Mr85b2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:04:14 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)) 17:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:04:14 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-InP77c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:04:14 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)) 17:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:04:14 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-rjt20R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:04:14 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)) 17:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:04:14 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-1_1JC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 17:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:04:14 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-2nSNIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:04:14 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)) 17:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:04:14 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Wh3xMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:04:14 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)) 17:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:04:14 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-ONsLZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:04:14 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)) 17:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:04:14 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-slMiIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:04:14 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)) 17:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:04:14 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-_VbCO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:04:14 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)) 17:04:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:04:15 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-xTTmME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:04:15 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)) 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:04:15 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-EL5pZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:04:15 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)) 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:04:15 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-GBOhxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:04:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:04:15 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-ybqhAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:04:15 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)) 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:04:15 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-m4KQY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:04:15 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)) 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:15 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-ogiben-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:15 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)) 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:04:15 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-N157Us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:04:15 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)) 17:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:04:15 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Rg4IWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:04:15 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)) 17:04:15 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)) 17:04:15 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)) 17:04:15 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)) 17:04:15 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:15 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:04:15 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 17:04:15 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 17:04:15 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 17:04:15 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 17:04:15 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 17:04:15 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 17:04:18 INFO - Downloading blessings-1.6.tar.gz 17:04:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:04:18 INFO - Installing collected packages: blessings 17:04:18 INFO - Running setup.py install for blessings 17:04:18 INFO - Successfully installed blessings 17:04:18 INFO - Cleaning up... 17:04:18 INFO - Return code: 0 17:04:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:04:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:04:19 INFO - Reading from file tmpfile_stdout 17:04:19 INFO - Current package versions: 17:04:19 INFO - blessings == 1.6 17:04:19 INFO - blobuploader == 1.2.4 17:04:19 INFO - docopt == 0.6.1 17:04:19 INFO - functools32 == 3.2.3-2 17:04:19 INFO - jsonschema == 2.5.1 17:04:19 INFO - manifestparser == 1.1 17:04:19 INFO - mozInstall == 1.12 17:04:19 INFO - mozcrash == 1.0 17:04:19 INFO - mozdebug == 0.1 17:04:19 INFO - mozdevice == 0.50 17:04:19 INFO - mozfile == 1.2 17:04:19 INFO - mozhttpd == 0.7 17:04:19 INFO - mozinfo == 0.9 17:04:19 INFO - mozleak == 0.1 17:04:19 INFO - mozlog == 3.4 17:04:19 INFO - moznetwork == 0.27 17:04:19 INFO - mozprocess == 0.25 17:04:19 INFO - mozprofile == 0.28 17:04:19 INFO - mozrunner == 6.13 17:04:19 INFO - mozscreenshot == 0.1 17:04:19 INFO - mozsystemmonitor == 0.3 17:04:19 INFO - moztest == 0.8 17:04:19 INFO - mozversion == 1.4 17:04:19 INFO - psutil == 3.1.1 17:04:19 INFO - requests == 1.2.3 17:04:19 INFO - wsgiref == 0.1.2 17:04:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:19 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 0x108cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8e3d84e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad9d30>, '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 0x1089ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108acebe8>, '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.CfTRj15bmy/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.LIQMI172vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 17:04:19 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 17:04:19 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 17:04:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CfTRj15bmy/Render', 17:04:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:19 INFO - 'HOME': '/Users/cltbld', 17:04:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:19 INFO - 'LOGNAME': 'cltbld', 17:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:19 INFO - 'MOZ_NO_REMOTE': '1', 17:04:19 INFO - 'NO_EM_RESTART': '1', 17:04:19 INFO - 'PAGER': '/bin/cat', 17:04:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:19 INFO - 'PWD': '/builds/slave/test', 17:04:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:19 INFO - 'SHELL': '/bin/bash', 17:04:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LIQMI172vb/Listeners', 17:04:19 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 17:04:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:19 INFO - 'USER': 'cltbld', 17:04:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:19 INFO - 'XPC_FLAGS': '0x0', 17:04:19 INFO - 'XPC_SERVICE_NAME': '0', 17:04:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:19 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)) 17:04:19 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)) 17:04:19 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)) 17:04:19 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)) 17:04:19 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)) 17:04:19 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)) 17:04:19 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)) 17:04:19 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)) 17:04:19 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)) 17:04:19 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)) 17:04:19 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)) 17:04:19 INFO - Cleaning up... 17:04:19 INFO - Return code: 0 17:04:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:19 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 0x108cfbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cfe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8e3d84e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ad9d30>, '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 0x1089ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108acebe8>, '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.CfTRj15bmy/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.LIQMI172vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 17:04:19 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 17:04:19 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 17:04:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CfTRj15bmy/Render', 17:04:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:19 INFO - 'HOME': '/Users/cltbld', 17:04:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:19 INFO - 'LOGNAME': 'cltbld', 17:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:19 INFO - 'MOZ_NO_REMOTE': '1', 17:04:19 INFO - 'NO_EM_RESTART': '1', 17:04:19 INFO - 'PAGER': '/bin/cat', 17:04:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:19 INFO - 'PWD': '/builds/slave/test', 17:04:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:19 INFO - 'SHELL': '/bin/bash', 17:04:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LIQMI172vb/Listeners', 17:04:19 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 17:04:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:19 INFO - 'USER': 'cltbld', 17:04:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:19 INFO - 'XPC_FLAGS': '0x0', 17:04:19 INFO - 'XPC_SERVICE_NAME': '0', 17:04:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:04:19 INFO - Cleaning up... 17:04:19 INFO - Return code: 0 17:04:19 INFO - Running post-action listener: _resource_record_post_action 17:04:19 INFO - Running post-action listener: _start_resource_monitoring 17:04:19 INFO - Starting resource monitoring. 17:04:19 INFO - [mozharness: 2017-04-29 00:04:19.714972Z] Finished create-virtualenv step (success) 17:04:19 INFO - [mozharness: 2017-04-29 00:04:19.715877Z] Running install step. 17:04:19 INFO - Running pre-action listener: _resource_record_pre_action 17:04:19 INFO - Running main action method: install 17:04:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:04:19 INFO - Reading from file tmpfile_stdout 17:04:19 INFO - Detecting whether we're running mozinstall >=1.0... 17:04:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:04:20 INFO - Reading from file tmpfile_stdout 17:04:20 INFO - Output received: 17:04:20 INFO - Usage: mozinstall [options] installer 17:04:20 INFO - Options: 17:04:20 INFO - -h, --help show this help message and exit 17:04:20 INFO - -d DEST, --destination=DEST 17:04:20 INFO - Directory to install application into. [default: 17:04:20 INFO - "/builds/slave/test"] 17:04:20 INFO - --app=APP Application being installed. [default: firefox] 17:04:20 INFO - mkdir: /builds/slave/test/build/application 17:04:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:04:39 INFO - Reading from file tmpfile_stdout 17:04:39 INFO - Output received: 17:04:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:04:39 INFO - Running post-action listener: _resource_record_post_action 17:04:39 INFO - [mozharness: 2017-04-29 00:04:39.718593Z] Finished install step (success) 17:04:39 INFO - [mozharness: 2017-04-29 00:04:39.718741Z] Running run-tests step. 17:04:39 INFO - Running pre-action listener: _resource_record_pre_action 17:04:39 INFO - Running main action method: run_tests 17:04:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:04:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:04:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:04:39 INFO - 2017-04-28 17:04:39.732 screenresolution[2525:35391] starting screenresolution argv=screenresolution get 17:04:39 INFO - 2017-04-28 17:04:39.734 screenresolution[2525:35391] Display 0: 1600x1200x32@60 17:04:39 INFO - 2017-04-28 17:04:39.739 screenresolution[2526:35395] starting screenresolution argv=screenresolution list 17:04:39 INFO - Available Modes on Display 0 17:04:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:04:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:04:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:04:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:04:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:04:39 INFO - Intel Iris: 17:04:39 INFO - Chipset Model: Intel Iris 17:04:39 INFO - Type: GPU 17:04:39 INFO - Bus: Built-In 17:04:39 INFO - VRAM (Dynamic, Max): 1536 MB 17:04:39 INFO - Vendor: Intel (0x8086) 17:04:39 INFO - Device ID: 0x0a2e 17:04:39 INFO - Revision ID: 0x0009 17:04:39 INFO - Displays: 17:04:39 INFO - Display: 17:04:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:04:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:04:39 INFO - Display Serial Number: 1600x1200 60 17:04:39 INFO - Main Display: Yes 17:04:39 INFO - Mirror: Off 17:04:39 INFO - Online: Yes 17:04:39 INFO - Rotation: Supported 17:04:39 INFO - Return code: 0 17:04:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:04:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:04:39 INFO - Python 2.7.3 17:04:39 INFO - Return code: 0 17:04:39 INFO - grabbing minidump binary from tooltool 17:04: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')]} 17:04:39 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 0x108ad9d30>, '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 0x1089ffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108acebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:04:39 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 17:04:39 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 17:04:39 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 17:04:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:04:40 INFO - Return code: 0 17:04:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:04:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:04:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:04:40 INFO - ENV: RUST_BACKTRACE is now 1 17:04:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:04:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:04:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:04:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0134 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:04:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CfTRj15bmy/Render', 17:04:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:04:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:04:40 INFO - 'HOME': '/Users/cltbld', 17:04:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:04:40 INFO - 'LOGNAME': 'cltbld', 17:04:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:04:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:40 INFO - 'MOZ_NO_REMOTE': '1', 17:04:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:04:40 INFO - 'NO_EM_RESTART': '1', 17:04:40 INFO - 'PAGER': '/bin/cat', 17:04:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:40 INFO - 'PWD': '/builds/slave/test', 17:04:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:04:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:04:40 INFO - 'RUST_BACKTRACE': '1', 17:04:40 INFO - 'SHELL': '/bin/bash', 17:04:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LIQMI172vb/Listeners', 17:04:40 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 17:04:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:04:40 INFO - 'USER': 'cltbld', 17:04:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:04:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:40 INFO - 'XPC_FLAGS': '0x0', 17:04:40 INFO - 'XPC_SERVICE_NAME': '0', 17:04:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:04:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:04:40 INFO - mozversion application_buildid: 20170428075320 17:04:40 INFO - mozversion application_changeset: b3b32894d9326d147238d9f071e1814ab3fdc850 17:04:40 INFO - mozversion application_display_name: Nightly 17:04:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:04:40 INFO - mozversion application_name: Firefox 17:04:40 INFO - mozversion application_remotingname: firefox 17:04:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:04:40 INFO - mozversion application_vendor: Mozilla 17:04:40 INFO - mozversion application_version: 55.0a1 17:04:40 INFO - mozversion platform_buildid: 20170428075320 17:04:40 INFO - mozversion platform_changeset: b3b32894d9326d147238d9f071e1814ab3fdc850 17:04:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:04:40 INFO - mozversion platform_version: 55.0a1 17:04:40 INFO - using testdate: 1493424280 17:04:40 INFO - actual date: 1493424280 17:04:40 INFO - starting webserver on 'localhost:60279' 17:04:40 INFO - SUITE-START | Running 2 tests 17:04:40 INFO - TEST-START | dromaeo_css 17:04:40 INFO - operating with platform_type : mac_ 17:04:40 INFO - Initialising browser for dromaeo_css test... 17:04:40 INFO - TEST-INFO | started process 2536 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpwJTeBj/profile http://localhost:60279/getInfo.html) 17:04:42 INFO - PID 2536 | __metrics Screen width/height:1600/1200 17:04:42 INFO - PID 2536 | colorDepth:24 17:04:42 INFO - PID 2536 | Browser inner width/height: 1024/689 17:04:42 INFO - PID 2536 | __metrics 17:04:43 INFO - PID 2536 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:04:43 INFO - PID 2536 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:04:43 INFO - TEST-INFO | 2536: exit 0 17:04:43 INFO - Browser initialized. 17:04:43 INFO - Running cycle 1/1 for dromaeo_css test... 17:04:43 INFO - TEST-INFO | started process 2538 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpwJTeBj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:04:56 INFO - PID 2538 | RSS: Main: 242290688 17:04:56 INFO - PID 2538 | 17:08:00 INFO - PID 2538 | Cycle 1(1): loaded http://localhost:60279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60279/tests/dromaeo/cssquery-ext.html) 17:08:02 INFO - PID 2538 | RSS: Main: 402604032 17:08:02 INFO - PID 2538 | 17:09:46 INFO - PID 2538 | ************************* 17:09:46 INFO - PID 2538 | A coding exception was thrown and uncaught in a Task. 17:09:46 INFO - PID 2538 | 17:09:46 ERROR - PID 2538 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:09:46 INFO - PID 2538 | Full stack: 17:09:46 INFO - PID 2538 | ************************* 17:09:46 INFO - PID 2538 | ************************* 17:09:46 INFO - PID 2538 | A coding exception was thrown and uncaught in a Task. 17:09:46 INFO - PID 2538 | 17:09:46 ERROR - PID 2538 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:09:46 INFO - PID 2538 | Full stack: 17:09:46 INFO - PID 2538 | ************************* 17:09:46 INFO - PID 2538 | ************************* 17:09:46 INFO - PID 2538 | A coding exception was thrown and uncaught in a Task. 17:09:46 INFO - PID 2538 | 17:09:46 ERROR - PID 2538 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:09:46 INFO - PID 2538 | Full stack: 17:09:46 INFO - PID 2538 | ************************* 17:09:46 INFO - PID 2538 | ************************* 17:09:46 INFO - PID 2538 | A coding exception was thrown and uncaught in a Task. 17:09:46 INFO - PID 2538 | 17:09:46 ERROR - PID 2538 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:09:46 INFO - PID 2538 | Full stack: 17:09:46 INFO - PID 2538 | ************************* 17:11:05 INFO - PID 2538 | Cycle 1(1): loaded http://localhost:60279/tests/dromaeo/cssquery-ext.html (next: http://localhost:60279/tests/dromaeo/cssquery-jquery.html) 17:11:05 INFO - PID 2538 | RSS: Main: 366632960 17:11:05 INFO - PID 2538 | 17:14:08 INFO - PID 2538 | Cycle 1(1): loaded http://localhost:60279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60279/tests/dromaeo/cssquery-mootools.html) 17:14:08 INFO - PID 2538 | RSS: Main: 332091392 17:14:08 INFO - PID 2538 | 17:17:10 INFO - PID 2538 | Cycle 1(1): loaded http://localhost:60279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60279/tests/dromaeo/cssquery-prototype.html) 17:17:11 INFO - PID 2538 | RSS: Main: 336867328 17:17:11 INFO - PID 2538 | 17:20:15 INFO - PID 2538 | Cycle 1(1): loaded http://localhost:60279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60279/tests/dromaeo/cssquery-yui.html) 17:20:15 INFO - PID 2538 | RSS: Main: 330723328 17:20:15 INFO - PID 2538 | 17:23:18 INFO - PID 2538 | Cycle 1(1): loaded http://localhost:60279/tests/dromaeo/cssquery-yui.html (next: http://localhost:60279/tests/dromaeo/cssquery-dojo.html) 17:23:18 INFO - PID 2538 | RSS: Main: 373948416 17:23:18 INFO - PID 2538 | 17:23:18 INFO - PID 2538 | __start_tp_report 17:23:18 INFO - PID 2538 | _x_x_mozilla_page_load 17:23:18 INFO - PID 2538 | _x_x_mozilla_page_load_details 17:23:18 INFO - PID 2538 | |i|pagename|runs| 17:23:18 INFO - PID 2538 | |0;dojo.html;3419.760616756828;3446.948295775562;3451.2924850405666;3474.843632036558;3512.8934385668513;5824.970875145618;5833.766649334021;5994.940050599498;6022.42786935241;6027.342877701408;4913.410390753105;5867.7066146692605;5879.11813228016;5888.852778680535;5905.409459054093;5122.795088196477;5130.563902068328;5135.3067335909545;5135.794568217267;5143.81996630118;5261.316028916254;5265.3155089838265;5271.4464981177;5272.973635131819;5277.076511610453;5249.028929648009;5253.8459231715005;5258.50044245796;5268.710220937847;5269.578433725312;5259.368875734898;5261.789528418859;5270.525652691257;5274.077036518594;5281.287026251464;5077.822276220315;5191.740412979374;5212.843614691566;5222.321098257202;5250.396204436501;6019.097135429677;6019.608725432833;6068.544859135538;6074.939250607482;6102.206713127265;6226.87546249077;6327.335629758855;6327.683615819191;6339.651319177444;6341.365863413668;4931.605471562267;6310.463610593105;6320.115183874262;6416;6425.389587989133;5053.393592768891;6141.30190404341;6143.126346464326;6144.2319710036245;6165.229346331708;6559.7376104955265;6573.835654108686;6602.438792702674;6607;6613.702383392759;6186.072089186658;6245.125682404467;6281.59169653971;6286.842828929313;6327.272363678144;5333.919991200135;6372.872542549123;6398.616083035033;6406.263279722798;6411.230652321751;6256.874862502725;6288.371162883675;6306.905396419057;6314.210723659543;6323.20959880015;6181.536384771161;6259.71831267594;6326.841828954221;6328.272248691367;6341.682915854281;5111.7699703513435;5114.232865070195;5132.743362831843;5135.460776618476;5218.034663587248;4574.794134263966;4575.611073058761;4596.855202044876;4641.582257596832;4661.254199328091;6089.626763200599;6151.569390142737;6152.2924863640355;6156.799424112255;6164.537659675542;6249.96875015622;6321.715522801485;6428.5178611604315;6461.935380646133;6481.319461456574;6117.918752924011;6126.314740042852;6141.9558675025355;6145.477634401126;6148.508119350441;5612.915806262909;5616.66300022;5623.775048998076;5638.154276858504;5661.518770904519;5457.590680698884;6350.618962862243;6530.738770449128;6639.302873198245;6654.268030516542;6377.96811015942;6403.327650596807;6407.8718425630295;6466.191726034246;6472.255690595453;6678.83302917431;6686.398224159849;6686.465082793462;6688.83277918056;6698.966505167443;6244.469220116341;6312.337204593451;6345.96827015862;6363.713632886624;6375.203099612549;6306.9684651576445;6386.329435409215;6429.132067171059;6449.871002580016;6471.2234531856475;6231.158793562811;6279.026750853625;6294.0558916162945;6305.558610897193;6308.558400911892;4857;6211.9068213975925;6241.78153764616;6263.467605253604;6270.937290627217;6236.438720515175;6241.21984751906;6250.4687101595055;6253.437190652863;6260.812175634738;6281.183446151971;6287.842803929939;6288.056791481132;6291.905621415774;6303.275123360872;6026.698665066817;6127.785527506694;6227.501799856092;6242.2509298882605;6246.6876656166105 17:23:18 INFO - PID 2538 | |1;ext.html;774.4617490843866;802.1937952357881;814.2915663372864;1116.8883111688826;1132.9773404531916;27172.04897828574;37349.69276075338;37363.43954840679;37478.812605937;37549.873503794865;39807.60192398075;40111.79944100275;40239.59760402395;40246;40258.59741402585;5712.800051998181;8372.330213582929;8547.316214702809;8548.102449242833;8556.5293908835;6006.909896351558;8364.539950302731;8503.95748021259;8522.446041007315;8526.57367131644;8512.829743405158;8564.785880352978;8577;8589.527575983318;8643.740687779346;8510.148985101503;8523.786905327355;8559.27246184075;8564.48613083217;8584.999999999969;7661.731839385595;7981.92244047052;8333.749987500385;8416.957915210445;8434.36742244328;37276.254474910624;37426.625733742585;37475.812620936995;37527.06182345436;37546.24907501835;3622.040159357772;3650.890473285779;3652.579953305351;3655.342038433081;3655.8720444784303;30548;30665.233369165726;30673;30681;30686.38627227443;3105.596272484585;3138.5606015157896;3169.9207519811957;3186.283086305563;3192.2498212919945;208391.95804020882;280963.5951820248;281528.5923570389;281597;284424;50039.24941125886;50118.74940625273;50145;50167.74916125396;50183;41880.79059604683;51424.48575514197;51528.74235628798;51686.96626067458;51751.48248517542;14057.859421405656;14148.292585370691;14176.007679462338;14185.716285674229;14191.858081419054;10026.899731002597;10079;11493.310401375944;11570.59502917394;11592.362420066976;11023.283486573508;12359.073069519822;12530.81203781944;12539.184952978027;12541.498340066477;5096.566791822736;5188.9740551297;5192.92210616841;5209.505097015777;5215.087359712111;856.6316483911978;966.183574879226;1007.4056306779036;1026.874370053996;1031.1750599520353;24304.392390190387;24316;24345.51308973846;24351.391215219763;24355.756442435704;965.280865755017;1080.6595922284455;1115.50917596259;1118.072000239799;1158.7334912969895;12370.690732731753;12379.814302785466;12406.131570789958;12422;12423.751524969632;291032;292239;292379;292528;293040;52418.42744717665;52556;52570.73714631402;52601.7369913148;52713.47286527162;1493.1936754152853;1496.4163976049567;1538.230884557721;1541.175471122944;1544.6447317117127;20539.897300513403;22500.77499224987;23854.88072559626;23884.64173037371;24480.26559203227;37847.43228851514;37889;37925.620743792206;38013.049673758374;38109.047273818374;266981;267608;268011;268046;268659;29664.851675741484;34358.82820585881;34360.656393436744;34433.82783086068;34492.482612761334;36484.81757591195;43438;43589.56410435855;43595;43866.56133438625;27957.301067473476;29150.854245728635;29277.975270865416;30357.39285214239;30560.08319750411;29050.418991619626;29998.70001299959;30179.09462716122;30534.08397748071;30571.847140765043;34900.65099348974;35422.46866297059;36167.09582260464;36177.638223617425;36277;29239.97660081972;29409.411811763217;30101.096967091024;30446;30560.84719576388;22140;22495.550088998454;22603.43491412728;24721;25014.37464063413 17:23:18 INFO - PID 2538 | |2;jquery.html;384.4483166655849;400.25552472401347;424.1453471255419;437.5952244174138;457.28206715456724;10225;14782.96519243652;21243;21588.2444114456;21668.8916555417;21083.47291317718;21723.782762172374;22145.224917127904;22560.774392256073;22874.88562557185;5302.681839089667;6024.457798798118;6026.969865150668;6112.052631842072;6121.418465245794;3633.418653015518;3692.7230457715646;6063.393660633946;6178.691065446732;6183.628982261079;5808.709564521778;6076.756929722806;6100.603460775058;6113.23584551931;6128.693565321739;5851.3270973838125;6043.788467403664;6098.32918378978;6101.664408457533;6108.267007959029;5399.7030163341;5404.675719456845;5406.486383793534;5414.566834653218;5416.512513873731;25828.74171258282;26980.865095674395;27061.052863149696;27259.45481090387;27445.176644700692;2145.785421457842;2180.1715348167754;2185.3225500095023;2189.7262842144733;2191.3864118046813;15484.845151548452;16927.746083808754;17990.010549419778;17992.920424774555;18141.09294535268;1809.6109336492586;2074.5850829834094;2141.892905354726;2147.302126808793;2184.0390228299498;143907;144125.27937360245;145168;145711;158035.99999999884;11789.88210117905;12365.38173091342;12375.381230938418;12409.813852792215;12448.377581120907;16176.595585110466;16218.270177842025;16221.918890405708;16224.351025959066;16252.268647910872;8761.167689069529;8998.55007249635;9024.232940200025;9109.544522773835;9206.217471514996;7312.634368281565;7633.969414129021;8310.376721745772;8364.85205329073;8780.736577902673;6949.5830250184135;7237.0821732241;7650.6337211627815;7705.807354816062;7724.459287849909;2148.967765483519;2157.9352619421443;2159.6976423300753;2167.788855367516;2325.0002498925287;905.4114825363434;921.5115988526092;950.538988590533;964.62379671928;970.1850445625709;21181.78818211829;21776.564468710854;21782;21783.128674853146;21879.67180492294;908.9045650206765;956.7753275806979;994.4480813148772;999.6701088640731;1024.8257796174669;10866.456677166268;11260.774784504263;11274.887251127384;11324.207305488537;11336.43317834105;523872;525517;527193;527520;527705;111535.88464115417;130269;131078.34460827825;132565;138706;1166.9474873630538;1178.6699724077273;1194.1700518139983;1205.9758804823855;1207.0705556721275;18398.356057537923;18552.165152568436;18664.44006679802;18752.062396880374;19009.714854277474;53511.929761405336;54737;54935.72532137314;55240.44759552353;56906.7154664224;73548.63225683838;82407.5879620598;84062.57968710117;85467.14532854591;88275.55862220647;8497.74506764798;8591.398602097794;9000.459972401677;9068.005038891433;9117.498537580497;13865.653358666113;13885.791713124514;13894.305284735521;14046.438142474186;14419.206943618201;11662.88337116652;11693.298402095901;11879.406029698308;11969.880301196876;12118.575849845212;10173.28786984904;10553.314034587727;11141.66300044;11397;11561.190716649753;11770.293782373084;11833.881661183277;11972.281663100242;12125.333106679218;12254.019678425526;8780;8829.33779966518;8847.20375166238;8934.106589341014;9012.54937253148;11627.941860290644;11728.061755059403;11888.465019074336;11895.345755983504;11958.58144964922 17:23:18 INFO - PID 2538 | |3;mootools.html;1214.769193853168;1419.2903548225886;1434.992825035875;1435.5334516282212;1440.791085292632;11005.61480348188;11511.079113670907;11538.365389903553;11549.960503554688;11552.422378881043;10872.836907446395;11547.942260288708;11579;11600.477978490988;11653.825192622118;2493.5885578879465;2537.9111731089415;2541.466292078666;2541.733118022609;2543.9618405723927;2080.0847627044127;2366.503034362786;2487.3781554611346;2492.028109037477;2492.401823562341;1937.6339680525266;2011.4870707969446;2137.6579747240444;2164.4697049222964;2166.0469393466824;2346.2374728213313;2515.6603858479148;2523.2682522068576;2526.873656317177;2528.8229823912334;2483.180550418376;2500.0124950644395;2531.1014589820716;2534.9112781052577;2538.2385284414786;10987.285826421257;11223.943880280627;11242.831357529643;11259.042981346596;11259.718507037307;6405.51958603102;6645.40191382773;6653.4344580710695;6656.534042617019;6658.600483970978;4001.9526435603743;4149.128682976579;4240.321548552217;4242.490901091858;4257.723247988871;1228.4963165102265;1269.4033804112053;1310.0502135951454;1316.8024796280538;1317.3939987605713;15725.29236184363;16049.839501605067;16068.276927538289;16075.598110047225;16094.919525402298;5612.270404847343;5895.240981513413;5923.940760592339;6030.668313242813;6044.637321760621;13476.865231347758;13502;13512.391942362618;13530.729385412236;13542.526011589547;6764.864702706017;6768.76309329181;6768.898466523006;6781.152355955505;6781.830454238585;6007.639541627516;6047.667378294148;6149.016157414792;6212.099245609361;6229.96885015572;3997.2405243003736;4445.355423463579;4495.707778994355;4610.561996610317;4665.953340466552;1390.6788550876709;1434.5194359889344;1434.9139051656934;1455.7088582283586;1459.3943513442016;775.1589525365042;796.4743269442256;803.125031061463;807.8142027333746;815.0748899998545;5789.478946894799;6112.113743507255;6886;7067.151941766918;7129.572225666373;919.9586018629178;934.9719508414759;947.209080417845;960.4477425480377;984.7685793838442;3530.523379343807;3617.764845285048;3646.872359467406;3749.081475038633;4268.701190916606;13509.256990865597;14299.285035748171;14388.784168237486;14808.407663693331;14911.179885106207;14160.008799383944;14420.495282665266;14630.26848657563;14758.40966361355;14770.63073423173;7198;8139.186081391814;8226.876596851052;8375.204355586087;8450.154984501502;5900.940990590039;5933.970330148321;6551.181102362205;6707.765228216989;6808.489363297872;12878.484860605471;13051.934740326238;13077;13134.802977955147;13263.469461221443;13410.664733381744;13450.394732237268;13473.528426505025;13606.183628982293;13860;7993.240642138988;8249.917500825155;8255.793605159919;8278.751637450887;8279.62741676614;10304.011154545407;10390.908954559662;10494.47527623631;10503.684889453329;10525.578976841147;8490.193431623986;8621.137886211329;8889.73330800077;8958;9124.5437728112;8679.392442529215;8699.43453675509;8723.738287851374;8776.956115219638;8914.598843051948;7862.213778622092;8035.99550056243;8040.356771458386;8057;8074.798130046795;5867.471927526543;5874.794382196603;6039.124326972476;6058.42444967745;6171.1668924694595;5925.851853703692;6169.1054797053275;6173.1666225060835;6216.694494156278;6255.280642726145 17:23:18 INFO - PID 2538 | |4;prototype.html;385.51425204242645;399.69223697752733;403.58833989330884;404.51054224388486;413.53477337994735;4886.951130488694;5564.026295398305;5692.6299790513585;5783.624064435809;5786.826395208151;5475.397706252309;5595.832125036255;5610;5641.069223578115;5671.404502527237;4353.455818022747;4359.498657654379;4364.541723119067;4366.829677657845;4369.388285640013;3690.7231957603285;4107.562353176394;4375;4379.824807007716;4385.802638881242;3601.4957905893198;3984.342583473723;4190.664746820263;4223.767692776896;4365.126974605076;3611.9231441921;3616.782993020414;4143.440635514227;4178.770167640779;4181.581841815824;3583.516225309602;3585.8386372613295;3592.389293820057;3601.6398360164035;3606.332828426723;5394.703291318976;5557.833265002057;5583.637063590894;5592.161175823659;5600.543858596794;3701.3152566775234;4088.6729061674996;4397.273690312027;4927.77824997876;4959.900801983977;4890.16618767962;5626.887462250732;5644.407337229614;5900.672348721546;6009.09863520471;3866.6520013198947;3985.4420381146374;4028.9194216115516;4062.3094074007195;4076.3274059780397;5262.264132095996;5990.698232064654;6284.842878928018;6348.301686814447;6479.967600161969;3961.603839616015;3969.563348031714;3972.682185425159;3983.960160398417;3986.880393588197;3476.5306683597896;3790.7156963227867;4021.939670904939;4033.798310084484;4122.690798190148;4652.046330502239;4838.0004397273215;4847.248676455155;4884.8290309838985;4896.853094407174;6062.696865156725;6063.575549711478;6065.423784740443;6065.96967015171;6074;1338.8795008449092;1419.0846903747026;1425.6507155746701;1427.9718602606108;1427.985720142806;906.0939060939061;925.8102089071724;929.6327950459531;933.3886304470583;934.7336009237471;4691.319758634979;5789.739461724233;5795.1886735857015;5805;5810.535157187415;6270.905936410957;6288.685565721696;6315.652639104894;6341.682915854189;6366.745330186741;4828;4913.746994516376;5071.721055341992;5386.326709161355;5753.482186603226;3279.4588892832417;3295.7857739246874;3296.1924328539662;3310.6192787829227;3314.983425082859;6350.174477318012;6469.644169570719;6505.967470162619;6509.576877503042;6565.606063636197;6449.32282110381;6470.352964703492;6492.805215843532;6497.805065848032;6498.5126115541525;5065.974670126626;6330.588511746814;6475.7085931133215;6527.804165875032;6550.803475895731;5188.0661480933795;5344.438833922382;6003.45968862787;6194.4115309045565;6310.211223597051;5601.495865372136;5821.09772985188;6217.658028808278;6232.407921247474;6317.715702793477;5681.460261275172;6358.2687990879795;6491.221053473613;6583.531175809072;6586.37429444202;3853.5183102112237;3978.4629075074495;4081.7346872453195;4085.6731461483605;4093.263212621757;6309.085182648399;6334.746610135543;6349.746010159542;6354.459870911024;6371.948628476435;4908.460069392436;5655.688937108499;5831.620944638585;6092.329843717276;6140.631562106288;5285.365756109291;6126.724297406538;6129.662868542273;6139.631622102688;6199;5832.679202643895;5922.466977972003;5945.464908158287;5990.071538911301;6057.42454466825;5069.5944324454695;6158.907616385847;6175.197224360804;6177.722002509808;6188.381161883775;5783.161441590862;5929;5992.730327135377;6006.429389208019;6024.487918526975 17:23:18 INFO - PID 2538 | |5;yui.html;711.7757906259525;746.5371469688794;860.5095095795396;866.3285953386124;877.5612193903047;13195.538156164535;18220.453386398414;18859.33992310266;18865.05674716262;18894.52763680907;16065.357385704558;17257.82742172581;17405.3037878485;17413.912930435363;17423.564410889736;675.1358261425371;675.4495086504484;690.3269312420375;931.1991687149047;939.4316438554679;707.331571664777;968.7771812483134;971.1647982734843;975.1175186456232;983.7196399026279;1061.601899287767;1064.5103252503857;1065.3341661461586;1068.9737851662414;1072.9624463143791;1057.9841302380394;1058.7617785998088;1058.8041212375736;1063.8829728729834;1066.0884943373383;782.006851298853;786.1156199275815;787.94484386093;788.6727008291552;792.5244853088159;16175.514734557864;16274.430394936238;16351.182440878027;16795.916020419943;17022.063786491737;16755.994640321496;16756;16956.915215423967;17059.573510662332;17138.914305428516;13836.654083647889;14028.438862445591;14155.43378264868;14180.50368237117;14225.573232803032;3383.4586466165542;3406.471996840494;3407.505911642798;3410.6077801052948;3411.385950528904;127012;127863.36068319599;129408;130696.34651826775;130826;9598.42409455435;11129.387883666313;11967;12035;12183.634490965285;20124.59750805005;20181.697274540893;20260;20486.59026819455;20518.487037824172;6487.740490380332;7287.052683151156;7295.817604559928;7351;7425.777226683208;3484.756067075331;3616;3617.276544691072;3619.2580520993133;3627.383344831385;4162.313218318944;4254.808533615933;4255.021345090585;4256.531781504032;4684.203685373494;921.5346250143634;926.9721908342625;945.9905400945902;947.6493697331894;947.9099485548862;643.4369926314475;650.3626446082865;666.6133642487346;668.2715839734616;678.8778019956455;11214.719632009102;12031.736667649946;12106.152569320064;12154.392280385946;12424.254544727346;636.5289685632598;644.8839208942435;650.6876699184418;673.7810211681223;675.5743881354813;5265.842024739188;5659.547236221092;5785.1611516329895;5812.88374232513;5843.561732870052;106031;109142;111296.4435177819;111618;115943.42028289974;89050;95348;98032;99924;104639.47680261549;73893;89711;90453.09546904579;91275.54362228146;91325;9978.700638980843;10745.516451759533;11457.713557161138;11635.185537012328;11678.299302041905;42102.789486052374;42128.1574368517;42207.366889497294;42713.786431067645;42738.504152354515;45602;56059;56244.15633765415;57053.71473142608;57204;11060.502277397376;13073.346332683517;16126;16764;16874.493765187064;17836.3757268495;18532.722009169604;18534;18658.44024679262;18868.716969245197;16875;16877.40929067477;17459.214335354685;17599;17739.556511087325;16898.577535561708;16987.320507179575;17501.82498175002;17745.46763597094;17906.373276935246;16504.504864854072;16610.916945415196;16917.74623380675;16994.431169454554;17200.31198752086;11593.5362585499;11827.645170644895;12008.519659213884;12092.334921579397;12121.939390302992;12217.266963982189;12458.875411245772;12870.613881583567;13199.67000824987;13465.663358415726 17:23:18 INFO - PID 2538 | __end_tp_report 17:23:18 INFO - PID 2538 | __start_cc_report 17:23:18 INFO - PID 2538 | _x_x_mozilla_cycle_collect,1659 17:23:18 INFO - PID 2538 | __end_cc_report 17:23:18 INFO - PID 2538 | __startTimestamp1493425398286__endTimestamp 17:23:18 INFO - PID 2538 | 17:23:18 INFO - PID 2538 | ------- Summary: start ------- 17:23:18 INFO - PID 2538 | Number of tests: 6 17:23:18 INFO - PID 2538 | 17:23:18 INFO - PID 2538 | [#0] dojo.html Cycles:165 Average:5891.41 Median:6186.07 stddev:690.04 (11.2%) stddev-sans-first:664.36 17:23:18 INFO - PID 2538 | Values: 3419.8 3446.9 3451.3 3474.8 3512.9 5825.0 5833.8 5994.9 6022.4 6027.3 4913.4 5867.7 5879.1 5888.9 5905.4 5122.8 5130.6 5135.3 5135.8 5143.8 5261.3 5265.3 5271.4 5273.0 5277.1 5249.0 5253.8 5258.5 5268.7 5269.6 5259.4 5261.8 5270.5 5274.1 5281.3 5077.8 5191.7 5212.8 5222.3 5250.4 6019.1 6019.6 6068.5 6074.9 6102.2 6226.9 6327.3 6327.7 6339.7 6341.4 4931.6 6310.5 6320.1 6416.0 6425.4 5053.4 6141.3 6143.1 6144.2 6165.2 6559.7 6573.8 6602.4 6607.0 6613.7 6186.1 6245.1 6281.6 6286.8 6327.3 5333.9 6372.9 6398.6 6406.3 6411.2 6256.9 6288.4 6306.9 6314.2 6323.2 6181.5 6259.7 6326.8 6328.3 6341.7 5111.8 5114.2 5132.7 5135.5 5218.0 4574.8 4575.6 4596.9 4641.6 4661.3 6089.6 6151.6 6152.3 6156.8 6164.5 6250.0 6321.7 6428.5 6461.9 6481.3 6117.9 6126.3 6142.0 6145.5 6148.5 5612.9 5616.7 5623.8 5638.2 5661.5 5457.6 6350.6 6530.7 6639.3 6654.3 6378.0 6403.3 6407.9 6466.2 6472.3 6678.8 6686.4 6686.5 6688.8 6699.0 6244.5 6312.3 6346.0 6363.7 6375.2 6307.0 6386.3 6429.1 6449.9 6471.2 6231.2 6279.0 6294.1 6305.6 6308.6 4857.0 6211.9 6241.8 6263.5 6270.9 6236.4 6241.2 6250.5 6253.4 6260.8 6281.2 6287.8 6288.1 6291.9 6303.3 6026.7 6127.8 6227.5 6242.3 6246.7 17:23:18 INFO - PID 2538 | 17:23:18 INFO - PID 2538 | [#1] ext.html Cycles:180 Average:42793.15 Median:18775.54 stddev:72384.55 (385.5%) stddev-sans-first:72518.86 17:23:18 INFO - PID 2538 | Values: 774.5 802.2 814.3 1116.9 1133.0 27172.0 37349.7 37363.4 37478.8 37549.9 39807.6 40111.8 40239.6 40246.0 40258.6 5712.8 8372.3 8547.3 8548.1 8556.5 6006.9 8364.5 8504.0 8522.4 8526.6 8512.8 8564.8 8577.0 8589.5 8643.7 8510.1 8523.8 8559.3 8564.5 8585.0 7661.7 7981.9 8333.7 8417.0 8434.4 37276.3 37426.6 37475.8 37527.1 37546.2 3622.0 3650.9 3652.6 3655.3 3655.9 30548.0 30665.2 30673.0 30681.0 30686.4 3105.6 3138.6 3169.9 3186.3 3192.2 208392.0 280963.6 281528.6 281597.0 284424.0 50039.2 50118.7 50145.0 50167.7 50183.0 41880.8 51424.5 51528.7 51687.0 51751.5 14057.9 14148.3 14176.0 14185.7 14191.9 10026.9 10079.0 11493.3 11570.6 11592.4 11023.3 12359.1 12530.8 12539.2 12541.5 5096.6 5189.0 5192.9 5209.5 5215.1 856.6 966.2 1007.4 1026.9 1031.2 24304.4 24316.0 24345.5 24351.4 24355.8 965.3 1080.7 1115.5 1118.1 1158.7 12370.7 12379.8 12406.1 12422.0 12423.8 291032.0 292239.0 292379.0 292528.0 293040.0 52418.4 52556.0 52570.7 52601.7 52713.5 1493.2 1496.4 1538.2 1541.2 1544.6 20539.9 22500.8 23854.9 23884.6 24480.3 37847.4 37889.0 37925.6 38013.0 38109.0 266981.0 267608.0 268011.0 268046.0 268659.0 29664.9 34358.8 34360.7 34433.8 34492.5 36484.8 43438.0 43589.6 43595.0 43866.6 27957.3 29150.9 29278.0 30357.4 30560.1 29050.4 29998.7 30179.1 30534.1 30571.8 34900.7 35422.5 36167.1 36177.6 36277.0 29240.0 29409.4 30101.1 30446.0 30560.8 22140.0 22495.6 22603.4 24721.0 25014.4 17:23:18 INFO - PID 2538 | 17:23:18 INFO - PID 2538 | [#2] jquery.html Cycles:180 Average:34615.41 Median:2190.56 stddev:89498.89 (4085.7%) stddev-sans-first:89713.05 17:23:18 INFO - PID 2538 | Values: 384.4 400.3 424.1 437.6 457.3 10225.0 14783.0 21243.0 21588.2 21668.9 21083.5 21723.8 22145.2 22560.8 22874.9 5302.7 6024.5 6027.0 6112.1 6121.4 3633.4 3692.7 6063.4 6178.7 6183.6 5808.7 6076.8 6100.6 6113.2 6128.7 5851.3 6043.8 6098.3 6101.7 6108.3 5399.7 5404.7 5406.5 5414.6 5416.5 25828.7 26980.9 27061.1 27259.5 27445.2 2145.8 2180.2 2185.3 2189.7 2191.4 15484.8 16927.7 17990.0 17992.9 18141.1 1809.6 2074.6 2141.9 2147.3 2184.0 143907.0 144125.3 145168.0 145711.0 158036.0 11789.9 12365.4 12375.4 12409.8 12448.4 16176.6 16218.3 16221.9 16224.4 16252.3 8761.2 8998.6 9024.2 9109.5 9206.2 7312.6 7634.0 8310.4 8364.9 8780.7 6949.6 7237.1 7650.6 7705.8 7724.5 2149.0 2157.9 2159.7 2167.8 2325.0 905.4 921.5 950.5 964.6 970.2 21181.8 21776.6 21782.0 21783.1 21879.7 908.9 956.8 994.4 999.7 1024.8 10866.5 11260.8 11274.9 11324.2 11336.4 523872.0 525517.0 527193.0 527520.0 527705.0 111535.9 130269.0 131078.3 132565.0 138706.0 1166.9 1178.7 1194.2 1206.0 1207.1 18398.4 18552.2 18664.4 18752.1 19009.7 53511.9 54737.0 54935.7 55240.4 56906.7 73548.6 82407.6 84062.6 85467.1 88275.6 8497.7 8591.4 9000.5 9068.0 9117.5 13865.7 13885.8 13894.3 14046.4 14419.2 11662.9 11693.3 11879.4 11969.9 12118.6 10173.3 10553.3 11141.7 11397.0 11561.2 11770.3 11833.9 11972.3 12125.3 12254.0 8780.0 8829.3 8847.2 8934.1 9012.5 11627.9 11728.1 11888.5 11895.3 11958.6 17:23:18 INFO - PID 2538 | 17:23:18 INFO - PID 2538 | [#3] mootools.html Cycles:180 Average:7007.58 Median:3574.14 stddev:4424.60 (123.8%) stddev-sans-first:4415.60 17:23:18 INFO - PID 2538 | Values: 1214.8 1419.3 1435.0 1435.5 1440.8 11005.6 11511.1 11538.4 11550.0 11552.4 10872.8 11547.9 11579.0 11600.5 11653.8 2493.6 2537.9 2541.5 2541.7 2544.0 2080.1 2366.5 2487.4 2492.0 2492.4 1937.6 2011.5 2137.7 2164.5 2166.0 2346.2 2515.7 2523.3 2526.9 2528.8 2483.2 2500.0 2531.1 2534.9 2538.2 10987.3 11223.9 11242.8 11259.0 11259.7 6405.5 6645.4 6653.4 6656.5 6658.6 4002.0 4149.1 4240.3 4242.5 4257.7 1228.5 1269.4 1310.1 1316.8 1317.4 15725.3 16049.8 16068.3 16075.6 16094.9 5612.3 5895.2 5923.9 6030.7 6044.6 13476.9 13502.0 13512.4 13530.7 13542.5 6764.9 6768.8 6768.9 6781.2 6781.8 6007.6 6047.7 6149.0 6212.1 6230.0 3997.2 4445.4 4495.7 4610.6 4666.0 1390.7 1434.5 1434.9 1455.7 1459.4 775.2 796.5 803.1 807.8 815.1 5789.5 6112.1 6886.0 7067.2 7129.6 920.0 935.0 947.2 960.4 984.8 3530.5 3617.8 3646.9 3749.1 4268.7 13509.3 14299.3 14388.8 14808.4 14911.2 14160.0 14420.5 14630.3 14758.4 14770.6 7198.0 8139.2 8226.9 8375.2 8450.2 5900.9 5934.0 6551.2 6707.8 6808.5 12878.5 13051.9 13077.0 13134.8 13263.5 13410.7 13450.4 13473.5 13606.2 13860.0 7993.2 8249.9 8255.8 8278.8 8279.6 10304.0 10390.9 10494.5 10503.7 10525.6 8490.2 8621.1 8889.7 8958.0 9124.5 8679.4 8699.4 8723.7 8777.0 8914.6 7862.2 8036.0 8040.4 8057.0 8074.8 5867.5 5874.8 6039.1 6058.4 6171.2 5925.9 6169.1 6173.2 6216.7 6255.3 17:23:18 INFO - PID 2538 | 17:23:18 INFO - PID 2538 | [#4] prototype.html Cycles:180 Average:4891.28 Median:5598.19 stddev:1553.09 (27.7%) stddev-sans-first:1520.18 17:23:18 INFO - PID 2538 | Values: 385.5 399.7 403.6 404.5 413.5 4887.0 5564.0 5692.6 5783.6 5786.8 5475.4 5595.8 5610.0 5641.1 5671.4 4353.5 4359.5 4364.5 4366.8 4369.4 3690.7 4107.6 4375.0 4379.8 4385.8 3601.5 3984.3 4190.7 4223.8 4365.1 3611.9 3616.8 4143.4 4178.8 4181.6 3583.5 3585.8 3592.4 3601.6 3606.3 5394.7 5557.8 5583.6 5592.2 5600.5 3701.3 4088.7 4397.3 4927.8 4959.9 4890.2 5626.9 5644.4 5900.7 6009.1 3866.7 3985.4 4028.9 4062.3 4076.3 5262.3 5990.7 6284.8 6348.3 6480.0 3961.6 3969.6 3972.7 3984.0 3986.9 3476.5 3790.7 4021.9 4033.8 4122.7 4652.0 4838.0 4847.2 4884.8 4896.9 6062.7 6063.6 6065.4 6066.0 6074.0 1338.9 1419.1 1425.7 1428.0 1428.0 906.1 925.8 929.6 933.4 934.7 4691.3 5789.7 5795.2 5805.0 5810.5 6270.9 6288.7 6315.7 6341.7 6366.7 4828.0 4913.7 5071.7 5386.3 5753.5 3279.5 3295.8 3296.2 3310.6 3315.0 6350.2 6469.6 6506.0 6509.6 6565.6 6449.3 6470.4 6492.8 6497.8 6498.5 5066.0 6330.6 6475.7 6527.8 6550.8 5188.1 5344.4 6003.5 6194.4 6310.2 5601.5 5821.1 6217.7 6232.4 6317.7 5681.5 6358.3 6491.2 6583.5 6586.4 3853.5 3978.5 4081.7 4085.7 4093.3 6309.1 6334.7 6349.7 6354.5 6371.9 4908.5 5655.7 5831.6 6092.3 6140.6 5285.4 6126.7 6129.7 6139.6 6199.0 5832.7 5922.5 5945.5 5990.1 6057.4 5069.6 6158.9 6175.2 6177.7 6188.4 5783.2 5929.0 5992.7 6006.4 6024.5 17:23:18 INFO - PID 2538 | 17:23:18 INFO - PID 2538 | [#5] yui.html Cycles:180 Average:22222.31 Median:18862.20 stddev:32248.30 (171.0%) stddev-sans-first:32298.32 17:23:18 INFO - PID 2538 | Values: 711.8 746.5 860.5 866.3 877.6 13195.5 18220.5 18859.3 18865.1 18894.5 16065.4 17257.8 17405.3 17413.9 17423.6 675.1 675.4 690.3 931.2 939.4 707.3 968.8 971.2 975.1 983.7 1061.6 1064.5 1065.3 1069.0 1073.0 1058.0 1058.8 1058.8 1063.9 1066.1 782.0 786.1 787.9 788.7 792.5 16175.5 16274.4 16351.2 16795.9 17022.1 16756.0 16756.0 16956.9 17059.6 17138.9 13836.7 14028.4 14155.4 14180.5 14225.6 3383.5 3406.5 3407.5 3410.6 3411.4 127012.0 127863.4 129408.0 130696.3 130826.0 9598.4 11129.4 11967.0 12035.0 12183.6 20124.6 20181.7 20260.0 20486.6 20518.5 6487.7 7287.1 7295.8 7351.0 7425.8 3484.8 3616.0 3617.3 3619.3 3627.4 4162.3 4254.8 4255.0 4256.5 4684.2 921.5 927.0 946.0 947.6 947.9 643.4 650.4 666.6 668.3 678.9 11214.7 12031.7 12106.2 12154.4 12424.3 636.5 644.9 650.7 673.8 675.6 5265.8 5659.5 5785.2 5812.9 5843.6 106031.0 109142.0 111296.4 111618.0 115943.4 89050.0 95348.0 98032.0 99924.0 104639.5 73893.0 89711.0 90453.1 91275.5 91325.0 9978.7 10745.5 11457.7 11635.2 11678.3 42102.8 42128.2 42207.4 42713.8 42738.5 45602.0 56059.0 56244.2 57053.7 57204.0 11060.5 13073.3 16126.0 16764.0 16874.5 17836.4 18532.7 18534.0 18658.4 18868.7 16875.0 16877.4 17459.2 17599.0 17739.6 16898.6 16987.3 17501.8 17745.5 17906.4 16504.5 16610.9 16917.7 16994.4 17200.3 11593.5 11827.6 12008.5 12092.3 12121.9 12217.3 12458.9 12870.6 13199.7 13465.7 17:23:18 INFO - PID 2538 | -------- Summary: end -------- 17:23:18 INFO - PID 2538 | 17:23:18 INFO - TEST-INFO | 2538: exit 0 17:23:18 INFO - TEST-OK | dromaeo_css | took 1118648ms 17:23:18 INFO - TEST-START | kraken 17:23:18 INFO - operating with platform_type : mac_ 17:23:18 INFO - Initialising browser for kraken test... 17:23:19 INFO - TEST-INFO | started process 2543 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpt2IVs5/profile http://localhost:60279/getInfo.html) 17:23:21 INFO - PID 2543 | __metrics Screen width/height:1600/1200 17:23:21 INFO - PID 2543 | colorDepth:24 17:23:21 INFO - PID 2543 | Browser inner width/height: 1024/689 17:23:21 INFO - PID 2543 | __metrics 17:23:21 INFO - PID 2543 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:23:21 INFO - PID 2543 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:23:22 INFO - TEST-INFO | 2543: exit 0 17:23:22 INFO - Browser initialized. 17:23:22 INFO - Running cycle 1/1 for kraken test... 17:23:22 INFO - TEST-INFO | started process 2544 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpt2IVs5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:34 INFO - PID 2544 | RSS: Main: 242475008 17:23:34 INFO - PID 2544 | 17:23:37 INFO - PID 2544 | Cycle 1(1): loaded http://localhost:60279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60279/tests/kraken/driver.html?testName=audio-beat-detection) 17:23:38 INFO - PID 2544 | RSS: Main: 309309440 17:23:38 INFO - PID 2544 | 17:23:40 INFO - PID 2544 | Cycle 1(1): loaded http://localhost:60279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60279/tests/kraken/driver.html?testName=audio-dft) 17:23:41 INFO - PID 2544 | RSS: Main: 291946496 17:23:41 INFO - PID 2544 | 17:23:44 INFO - PID 2544 | Cycle 1(1): loaded http://localhost:60279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60279/tests/kraken/driver.html?testName=audio-fft) 17:23:45 INFO - PID 2544 | RSS: Main: 381960192 17:23:45 INFO - PID 2544 | 17:23:47 INFO - PID 2544 | Cycle 1(1): loaded http://localhost:60279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60279/tests/kraken/driver.html?testName=audio-oscillator) 17:23:47 INFO - PID 2544 | RSS: Main: 287977472 17:23:47 INFO - PID 2544 | 17:23:50 INFO - PID 2544 | Cycle 1(1): loaded http://localhost:60279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:23:50 INFO - PID 2544 | RSS: Main: 289562624 17:23:50 INFO - PID 2544 | 17:23:53 INFO - PID 2544 | Cycle 1(1): loaded http://localhost:60279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60279/tests/kraken/driver.html?testName=imaging-darkroom) 17:23:54 INFO - PID 2544 | RSS: Main: 352432128 17:23:54 INFO - PID 2544 | 17:23:56 INFO - PID 2544 | Cycle 1(1): loaded http://localhost:60279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60279/tests/kraken/driver.html?testName=imaging-desaturate) 17:23:57 INFO - PID 2544 | RSS: Main: 372334592 17:23:57 INFO - PID 2544 | 17:24:00 INFO - PID 2544 | Cycle 1(1): loaded http://localhost:60279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60279/tests/kraken/driver.html?testName=json-parse-financial) 17:24:01 INFO - PID 2544 | RSS: Main: 380383232 17:24:01 INFO - PID 2544 | 17:24:02 INFO - PID 2544 | Cycle 1(1): loaded http://localhost:60279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:24:03 INFO - PID 2544 | RSS: Main: 332320768 17:24:03 INFO - PID 2544 | 17:24:04 INFO - PID 2544 | Cycle 1(1): loaded http://localhost:60279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60279/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:24:05 INFO - PID 2544 | RSS: Main: 334745600 17:24:05 INFO - PID 2544 | 17:24:07 INFO - PID 2544 | Cycle 1(1): loaded http://localhost:60279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:24:08 INFO - PID 2544 | RSS: Main: 335900672 17:24:08 INFO - PID 2544 | 17:24:11 INFO - PID 2544 | Cycle 1(1): loaded http://localhost:60279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:24:12 INFO - PID 2544 | RSS: Main: 346697728 17:24:12 INFO - PID 2544 | 17:24:15 INFO - PID 2544 | Cycle 1(1): loaded http://localhost:60279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:24:15 INFO - PID 2544 | RSS: Main: 344064000 17:24:15 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | Cycle 1(1): loaded http://localhost:60279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60279/tests/kraken/driver.html?testName=ai-astar) 17:24:17 INFO - PID 2544 | RSS: Main: 386605056 17:24:17 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | __start_tp_report 17:24:17 INFO - PID 2544 | _x_x_mozilla_page_load 17:24:17 INFO - PID 2544 | _x_x_mozilla_page_load_details 17:24:17 INFO - PID 2544 | |i|pagename|runs| 17:24:17 INFO - PID 2544 | |0;ai-astar;111;111;110;110;110;111;110;110;109;109 17:24:17 INFO - PID 2544 | |1;audio-beat-detection;142;108;108;148;110;107;108;103;135;108 17:24:17 INFO - PID 2544 | |2;audio-dft;187;185;186;187;188;184;186;186;186;183 17:24:17 INFO - PID 2544 | |3;audio-fft;83;60;57;89;59;57;59;57;86;58 17:24:17 INFO - PID 2544 | |4;audio-oscillator;92;70;86;69;68;68;91;77;96;122 17:24:17 INFO - PID 2544 | |5;imaging-gaussian-blur;87;86;87;86;87;86;87;87;88;87 17:24:17 INFO - PID 2544 | |6;imaging-darkroom;94;94;94;93;93;94;94;94;93;94 17:24:17 INFO - PID 2544 | |7;imaging-desaturate;85;84;84;84;83;83;84;83;84;84 17:24:17 INFO - PID 2544 | |8;json-parse-financial;49;48;48;47;49;49;48;48;50;49 17:24:17 INFO - PID 2544 | |9;json-stringify-tinderbox;54;62;58;66;63;60;58;58;56;56 17:24:17 INFO - PID 2544 | |10;stanford-crypto-aes;83;82;83;81;84;101;83;82;79;83 17:24:17 INFO - PID 2544 | |11;stanford-crypto-ccm;151;148;146;137;135;134;137;134;223;150 17:24:17 INFO - PID 2544 | |12;stanford-crypto-pbkdf2;181;207;184;182;188;191;188;188;189;230 17:24:17 INFO - PID 2544 | |13;stanford-crypto-sha256-iterative;69;68;68;67;68;66;66;65;68;68 17:24:17 INFO - PID 2544 | __end_tp_report 17:24:17 INFO - PID 2544 | __start_cc_report 17:24:17 INFO - PID 2544 | _x_x_mozilla_cycle_collect,2268 17:24:17 INFO - PID 2544 | __end_cc_report 17:24:17 INFO - PID 2544 | __startTimestamp1493425457822__endTimestamp 17:24:17 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | ------- Summary: start ------- 17:24:17 INFO - PID 2544 | Number of tests: 14 17:24:17 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.71 17:24:17 INFO - PID 2544 | Values: 111.0 111.0 110.0 110.0 110.0 111.0 110.0 110.0 109.0 109.0 17:24:17 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | [#1] audio-beat-detection Cycles:10 Average:117.70 Median:109.00 stddev:16.91 (15.5%) stddev-sans-first:15.48 17:24:17 INFO - PID 2544 | Values: 142.0 108.0 108.0 148.0 110.0 107.0 108.0 103.0 135.0 108.0 17:24:17 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | [#2] audio-dft Cycles:10 Average:185.80 Median:186.00 stddev:1.48 (0.8%) stddev-sans-first:1.50 17:24:17 INFO - PID 2544 | Values: 187.0 185.0 186.0 187.0 188.0 184.0 186.0 186.0 186.0 183.0 17:24:17 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | [#3] audio-fft Cycles:10 Average:66.50 Median:59.50 stddev:13.57 (22.8%) stddev-sans-first:13.01 17:24:17 INFO - PID 2544 | Values: 83.0 60.0 57.0 89.0 59.0 57.0 59.0 57.0 86.0 58.0 17:24:17 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | [#4] audio-oscillator Cycles:10 Average:83.90 Median:81.50 stddev:17.28 (21.2%) stddev-sans-first:18.08 17:24:17 INFO - PID 2544 | Values: 92.0 70.0 86.0 69.0 68.0 68.0 91.0 77.0 96.0 122.0 17:24:17 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:87.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 17:24:17 INFO - PID 2544 | Values: 87.0 86.0 87.0 86.0 87.0 86.0 87.0 87.0 88.0 87.0 17:24:17 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:24:17 INFO - PID 2544 | Values: 94.0 94.0 94.0 93.0 93.0 94.0 94.0 94.0 93.0 94.0 17:24:17 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | [#7] imaging-desaturate Cycles:10 Average:83.80 Median:84.00 stddev:0.63 (0.8%) stddev-sans-first:0.50 17:24:17 INFO - PID 2544 | Values: 85.0 84.0 84.0 84.0 83.0 83.0 84.0 83.0 84.0 84.0 17:24:17 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | [#8] json-parse-financial Cycles:10 Average:48.50 Median:49.00 stddev:0.85 (1.7%) stddev-sans-first:0.88 17:24:17 INFO - PID 2544 | Values: 49.0 48.0 48.0 47.0 49.0 49.0 48.0 48.0 50.0 49.0 17:24:17 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:3.67 (6.2%) stddev-sans-first:3.39 17:24:17 INFO - PID 2544 | Values: 54.0 62.0 58.0 66.0 63.0 60.0 58.0 58.0 56.0 56.0 17:24:17 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.00 stddev:6.10 (7.3%) stddev-sans-first:6.46 17:24:17 INFO - PID 2544 | Values: 83.0 82.0 83.0 81.0 84.0 101.0 83.0 82.0 79.0 83.0 17:24:17 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:147.00 stddev:26.71 (18.2%) stddev-sans-first:28.33 17:24:17 INFO - PID 2544 | Values: 151.0 148.0 146.0 137.0 135.0 134.0 137.0 134.0 223.0 150.0 17:24:17 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.80 Median:188.50 stddev:14.93 (7.9%) stddev-sans-first:15.21 17:24:17 INFO - PID 2544 | Values: 181.0 207.0 184.0 182.0 188.0 191.0 188.0 188.0 189.0 230.0 17:24:17 INFO - PID 2544 | 17:24:17 INFO - PID 2544 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:1.17 17:24:17 INFO - PID 2544 | Values: 69.0 68.0 68.0 67.0 68.0 66.0 66.0 65.0 68.0 68.0 17:24:17 INFO - PID 2544 | -------- Summary: end -------- 17:24:17 INFO - PID 2544 | 17:24:18 INFO - TEST-INFO | 2544: exit 0 17:24:18 INFO - TEST-OK | kraken | took 59924ms 17:24:18 INFO - SUITE-END | took 1178s 17:24:18 INFO - Completed test suite (00:19:38) 17:24:18 INFO - javascript benchmark 17:24:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7637.2913658726875, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3419.760616756828, 3446.948295775562, 3451.2924850405666, 3474.843632036558, 3512.8934385668513, 5824.970875145618, 5833.766649334021, 5994.940050599498, 6022.42786935241, 6027.342877701408, 4913.410390753105, 5867.7066146692605, 5879.11813228016, 5888.852778680535, 5905.409459054093, 5122.795088196477, 5130.563902068328, 5135.3067335909545, 5135.794568217267, 5143.81996630118, 5261.316028916254, 5265.3155089838265, 5271.4464981177, 5272.973635131819, 5277.076511610453, 5249.028929648009, 5253.8459231715005, 5258.50044245796, 5268.710220937847, 5269.578433725312, 5259.368875734898, 5261.789528418859, 5270.525652691257, 5274.077036518594, 5281.287026251464, 5077.822276220315, 5191.740412979374, 5212.843614691566, 5222.321098257202, 5250.396204436501, 6019.097135429677, 6019.608725432833, 6068.544859135538, 6074.939250607482, 6102.206713127265, 6226.87546249077, 6327.335629758855, 6327.683615819191, 6339.651319177444, 6341.365863413668, 4931.605471562267, 6310.463610593105, 6320.115183874262, 6416.0, 6425.389587989133, 5053.393592768891, 6141.30190404341, 6143.126346464326, 6144.2319710036245, 6165.229346331708, 6559.7376104955265, 6573.835654108686, 6602.438792702674, 6607.0, 6613.702383392759, 6186.072089186658, 6245.125682404467, 6281.59169653971, 6286.842828929313, 6327.272363678144, 5333.919991200135, 6372.872542549123, 6398.616083035033, 6406.263279722798, 6411.230652321751, 6256.874862502725, 6288.371162883675, 6306.905396419057, 6314.210723659543, 6323.20959880015, 6181.536384771161, 6259.71831267594, 6326.841828954221, 6328.272248691367, 6341.682915854281, 5111.7699703513435, 5114.232865070195, 5132.743362831843, 5135.460776618476, 5218.034663587248, 4574.794134263966, 4575.611073058761, 4596.855202044876, 4641.582257596832, 4661.254199328091, 6089.626763200599, 6151.569390142737, 6152.2924863640355, 6156.799424112255, 6164.537659675542, 6249.96875015622, 6321.715522801485, 6428.5178611604315, 6461.935380646133, 6481.319461456574, 6117.918752924011, 6126.314740042852, 6141.9558675025355, 6145.477634401126, 6148.508119350441, 5612.915806262909, 5616.66300022, 5623.775048998076, 5638.154276858504, 5661.518770904519, 5457.590680698884, 6350.618962862243, 6530.738770449128, 6639.302873198245, 6654.268030516542, 6377.96811015942, 6403.327650596807, 6407.8718425630295, 6466.191726034246, 6472.255690595453, 6678.83302917431, 6686.398224159849, 6686.465082793462, 6688.83277918056, 6698.966505167443, 6244.469220116341, 6312.337204593451, 6345.96827015862, 6363.713632886624, 6375.203099612549, 6306.9684651576445, 6386.329435409215, 6429.132067171059, 6449.871002580016, 6471.2234531856475, 6231.158793562811, 6279.026750853625, 6294.0558916162945, 6305.558610897193, 6308.558400911892, 4857.0, 6211.9068213975925, 6241.78153764616, 6263.467605253604, 6270.937290627217, 6236.438720515175, 6241.21984751906, 6250.4687101595055, 6253.437190652863, 6260.812175634738, 6281.183446151971, 6287.842803929939, 6288.056791481132, 6291.905621415774, 6303.275123360872, 6026.698665066817, 6127.785527506694, 6227.501799856092, 6242.2509298882605, 6246.6876656166105], "value": 5848.097031983232, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.4617490843866, 802.1937952357881, 814.2915663372864, 1116.8883111688826, 1132.9773404531916, 27172.04897828574, 37349.69276075338, 37363.43954840679, 37478.812605937, 37549.873503794865, 39807.60192398075, 40111.79944100275, 40239.59760402395, 40246.0, 40258.59741402585, 5712.800051998181, 8372.330213582929, 8547.316214702809, 8548.102449242833, 8556.5293908835, 6006.909896351558, 8364.539950302731, 8503.95748021259, 8522.446041007315, 8526.57367131644, 8512.829743405158, 8564.785880352978, 8577.0, 8589.527575983318, 8643.740687779346, 8510.148985101503, 8523.786905327355, 8559.27246184075, 8564.48613083217, 8584.999999999969, 7661.731839385595, 7981.92244047052, 8333.749987500385, 8416.957915210445, 8434.36742244328, 37276.254474910624, 37426.625733742585, 37475.812620936995, 37527.06182345436, 37546.24907501835, 3622.040159357772, 3650.890473285779, 3652.579953305351, 3655.342038433081, 3655.8720444784303, 30548.0, 30665.233369165726, 30673.0, 30681.0, 30686.38627227443, 3105.596272484585, 3138.5606015157896, 3169.9207519811957, 3186.283086305563, 3192.2498212919945, 208391.95804020882, 280963.5951820248, 281528.5923570389, 281597.0, 284424.0, 50039.24941125886, 50118.74940625273, 50145.0, 50167.74916125396, 50183.0, 41880.79059604683, 51424.48575514197, 51528.74235628798, 51686.96626067458, 51751.48248517542, 14057.859421405656, 14148.292585370691, 14176.007679462338, 14185.716285674229, 14191.858081419054, 10026.899731002597, 10079.0, 11493.310401375944, 11570.59502917394, 11592.362420066976, 11023.283486573508, 12359.073069519822, 12530.81203781944, 12539.184952978027, 12541.498340066477, 5096.566791822736, 5188.9740551297, 5192.92210616841, 5209.505097015777, 5215.087359712111, 856.6316483911978, 966.183574879226, 1007.4056306779036, 1026.874370053996, 1031.1750599520353, 24304.392390190387, 24316.0, 24345.51308973846, 24351.391215219763, 24355.756442435704, 965.280865755017, 1080.6595922284455, 1115.50917596259, 1118.072000239799, 1158.7334912969895, 12370.690732731753, 12379.814302785466, 12406.131570789958, 12422.0, 12423.751524969632, 291032.0, 292239.0, 292379.0, 292528.0, 293040.0, 52418.42744717665, 52556.0, 52570.73714631402, 52601.7369913148, 52713.47286527162, 1493.1936754152853, 1496.4163976049567, 1538.230884557721, 1541.175471122944, 1544.6447317117127, 20539.897300513403, 22500.77499224987, 23854.88072559626, 23884.64173037371, 24480.26559203227, 37847.43228851514, 37889.0, 37925.620743792206, 38013.049673758374, 38109.047273818374, 266981.0, 267608.0, 268011.0, 268046.0, 268659.0, 29664.851675741484, 34358.82820585881, 34360.656393436744, 34433.82783086068, 34492.482612761334, 36484.81757591195, 43438.0, 43589.56410435855, 43595.0, 43866.56133438625, 27957.301067473476, 29150.854245728635, 29277.975270865416, 30357.39285214239, 30560.08319750411, 29050.418991619626, 29998.70001299959, 30179.09462716122, 30534.08397748071, 30571.847140765043, 34900.65099348974, 35422.46866297059, 36167.09582260464, 36177.638223617425, 36277.0, 29239.97660081972, 29409.411811763217, 30101.096967091024, 30446.0, 30560.84719576388, 22140.0, 22495.550088998454, 22603.43491412728, 24721.0, 25014.37464063413], "value": 17089.973601436763, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.4483166655849, 400.25552472401347, 424.1453471255419, 437.5952244174138, 457.28206715456724, 10225.0, 14782.96519243652, 21243.0, 21588.2444114456, 21668.8916555417, 21083.47291317718, 21723.782762172374, 22145.224917127904, 22560.774392256073, 22874.88562557185, 5302.681839089667, 6024.457798798118, 6026.969865150668, 6112.052631842072, 6121.418465245794, 3633.418653015518, 3692.7230457715646, 6063.393660633946, 6178.691065446732, 6183.628982261079, 5808.709564521778, 6076.756929722806, 6100.603460775058, 6113.23584551931, 6128.693565321739, 5851.3270973838125, 6043.788467403664, 6098.32918378978, 6101.664408457533, 6108.267007959029, 5399.7030163341, 5404.675719456845, 5406.486383793534, 5414.566834653218, 5416.512513873731, 25828.74171258282, 26980.865095674395, 27061.052863149696, 27259.45481090387, 27445.176644700692, 2145.785421457842, 2180.1715348167754, 2185.3225500095023, 2189.7262842144733, 2191.3864118046813, 15484.845151548452, 16927.746083808754, 17990.010549419778, 17992.920424774555, 18141.09294535268, 1809.6109336492586, 2074.5850829834094, 2141.892905354726, 2147.302126808793, 2184.0390228299498, 143907.0, 144125.27937360245, 145168.0, 145711.0, 158035.99999999884, 11789.88210117905, 12365.38173091342, 12375.381230938418, 12409.813852792215, 12448.377581120907, 16176.595585110466, 16218.270177842025, 16221.918890405708, 16224.351025959066, 16252.268647910872, 8761.167689069529, 8998.55007249635, 9024.232940200025, 9109.544522773835, 9206.217471514996, 7312.634368281565, 7633.969414129021, 8310.376721745772, 8364.85205329073, 8780.736577902673, 6949.5830250184135, 7237.0821732241, 7650.6337211627815, 7705.807354816062, 7724.459287849909, 2148.967765483519, 2157.9352619421443, 2159.6976423300753, 2167.788855367516, 2325.0002498925287, 905.4114825363434, 921.5115988526092, 950.538988590533, 964.62379671928, 970.1850445625709, 21181.78818211829, 21776.564468710854, 21782.0, 21783.128674853146, 21879.67180492294, 908.9045650206765, 956.7753275806979, 994.4480813148772, 999.6701088640731, 1024.8257796174669, 10866.456677166268, 11260.774784504263, 11274.887251127384, 11324.207305488537, 11336.43317834105, 523872.0, 525517.0, 527193.0, 527520.0, 527705.0, 111535.88464115417, 130269.0, 131078.34460827825, 132565.0, 138706.0, 1166.9474873630538, 1178.6699724077273, 1194.1700518139983, 1205.9758804823855, 1207.0705556721275, 18398.356057537923, 18552.165152568436, 18664.44006679802, 18752.062396880374, 19009.714854277474, 53511.929761405336, 54737.0, 54935.72532137314, 55240.44759552353, 56906.7154664224, 73548.63225683838, 82407.5879620598, 84062.57968710117, 85467.14532854591, 88275.55862220647, 8497.74506764798, 8591.398602097794, 9000.459972401677, 9068.005038891433, 9117.498537580497, 13865.653358666113, 13885.791713124514, 13894.305284735521, 14046.438142474186, 14419.206943618201, 11662.88337116652, 11693.298402095901, 11879.406029698308, 11969.880301196876, 12118.575849845212, 10173.28786984904, 10553.314034587727, 11141.66300044, 11397.0, 11561.190716649753, 11770.293782373084, 11833.881661183277, 11972.281663100242, 12125.333106679218, 12254.019678425526, 8780.0, 8829.33779966518, 8847.20375166238, 8934.106589341014, 9012.54937253148, 11627.941860290644, 11728.061755059403, 11888.465019074336, 11895.345755983504, 11958.58144964922], "value": 10235.585802516898, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1214.769193853168, 1419.2903548225886, 1434.992825035875, 1435.5334516282212, 1440.791085292632, 11005.61480348188, 11511.079113670907, 11538.365389903553, 11549.960503554688, 11552.422378881043, 10872.836907446395, 11547.942260288708, 11579.0, 11600.477978490988, 11653.825192622118, 2493.5885578879465, 2537.9111731089415, 2541.466292078666, 2541.733118022609, 2543.9618405723927, 2080.0847627044127, 2366.503034362786, 2487.3781554611346, 2492.028109037477, 2492.401823562341, 1937.6339680525266, 2011.4870707969446, 2137.6579747240444, 2164.4697049222964, 2166.0469393466824, 2346.2374728213313, 2515.6603858479148, 2523.2682522068576, 2526.873656317177, 2528.8229823912334, 2483.180550418376, 2500.0124950644395, 2531.1014589820716, 2534.9112781052577, 2538.2385284414786, 10987.285826421257, 11223.943880280627, 11242.831357529643, 11259.042981346596, 11259.718507037307, 6405.51958603102, 6645.40191382773, 6653.4344580710695, 6656.534042617019, 6658.600483970978, 4001.9526435603743, 4149.128682976579, 4240.321548552217, 4242.490901091858, 4257.723247988871, 1228.4963165102265, 1269.4033804112053, 1310.0502135951454, 1316.8024796280538, 1317.3939987605713, 15725.29236184363, 16049.839501605067, 16068.276927538289, 16075.598110047225, 16094.919525402298, 5612.270404847343, 5895.240981513413, 5923.940760592339, 6030.668313242813, 6044.637321760621, 13476.865231347758, 13502.0, 13512.391942362618, 13530.729385412236, 13542.526011589547, 6764.864702706017, 6768.76309329181, 6768.898466523006, 6781.152355955505, 6781.830454238585, 6007.639541627516, 6047.667378294148, 6149.016157414792, 6212.099245609361, 6229.96885015572, 3997.2405243003736, 4445.355423463579, 4495.707778994355, 4610.561996610317, 4665.953340466552, 1390.6788550876709, 1434.5194359889344, 1434.9139051656934, 1455.7088582283586, 1459.3943513442016, 775.1589525365042, 796.4743269442256, 803.125031061463, 807.8142027333746, 815.0748899998545, 5789.478946894799, 6112.113743507255, 6886.0, 7067.151941766918, 7129.572225666373, 919.9586018629178, 934.9719508414759, 947.209080417845, 960.4477425480377, 984.7685793838442, 3530.523379343807, 3617.764845285048, 3646.872359467406, 3749.081475038633, 4268.701190916606, 13509.256990865597, 14299.285035748171, 14388.784168237486, 14808.407663693331, 14911.179885106207, 14160.008799383944, 14420.495282665266, 14630.26848657563, 14758.40966361355, 14770.63073423173, 7198.0, 8139.186081391814, 8226.876596851052, 8375.204355586087, 8450.154984501502, 5900.940990590039, 5933.970330148321, 6551.181102362205, 6707.765228216989, 6808.489363297872, 12878.484860605471, 13051.934740326238, 13077.0, 13134.802977955147, 13263.469461221443, 13410.664733381744, 13450.394732237268, 13473.528426505025, 13606.183628982293, 13860.0, 7993.240642138988, 8249.917500825155, 8255.793605159919, 8278.751637450887, 8279.62741676614, 10304.011154545407, 10390.908954559662, 10494.47527623631, 10503.684889453329, 10525.578976841147, 8490.193431623986, 8621.137886211329, 8889.73330800077, 8958.0, 9124.5437728112, 8679.392442529215, 8699.43453675509, 8723.738287851374, 8776.956115219638, 8914.598843051948, 7862.213778622092, 8035.99550056243, 8040.356771458386, 8057.0, 8074.798130046795, 5867.471927526543, 5874.794382196603, 6039.124326972476, 6058.42444967745, 6171.1668924694595, 5925.851853703692, 6169.1054797053275, 6173.1666225060835, 6216.694494156278, 6255.280642726145], "value": 5320.622505341481, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.51425204242645, 399.69223697752733, 403.58833989330884, 404.51054224388486, 413.53477337994735, 4886.951130488694, 5564.026295398305, 5692.6299790513585, 5783.624064435809, 5786.826395208151, 5475.397706252309, 5595.832125036255, 5610.0, 5641.069223578115, 5671.404502527237, 4353.455818022747, 4359.498657654379, 4364.541723119067, 4366.829677657845, 4369.388285640013, 3690.7231957603285, 4107.562353176394, 4375.0, 4379.824807007716, 4385.802638881242, 3601.4957905893198, 3984.342583473723, 4190.664746820263, 4223.767692776896, 4365.126974605076, 3611.9231441921, 3616.782993020414, 4143.440635514227, 4178.770167640779, 4181.581841815824, 3583.516225309602, 3585.8386372613295, 3592.389293820057, 3601.6398360164035, 3606.332828426723, 5394.703291318976, 5557.833265002057, 5583.637063590894, 5592.161175823659, 5600.543858596794, 3701.3152566775234, 4088.6729061674996, 4397.273690312027, 4927.77824997876, 4959.900801983977, 4890.16618767962, 5626.887462250732, 5644.407337229614, 5900.672348721546, 6009.09863520471, 3866.6520013198947, 3985.4420381146374, 4028.9194216115516, 4062.3094074007195, 4076.3274059780397, 5262.264132095996, 5990.698232064654, 6284.842878928018, 6348.301686814447, 6479.967600161969, 3961.603839616015, 3969.563348031714, 3972.682185425159, 3983.960160398417, 3986.880393588197, 3476.5306683597896, 3790.7156963227867, 4021.939670904939, 4033.798310084484, 4122.690798190148, 4652.046330502239, 4838.0004397273215, 4847.248676455155, 4884.8290309838985, 4896.853094407174, 6062.696865156725, 6063.575549711478, 6065.423784740443, 6065.96967015171, 6074.0, 1338.8795008449092, 1419.0846903747026, 1425.6507155746701, 1427.9718602606108, 1427.985720142806, 906.0939060939061, 925.8102089071724, 929.6327950459531, 933.3886304470583, 934.7336009237471, 4691.319758634979, 5789.739461724233, 5795.1886735857015, 5805.0, 5810.535157187415, 6270.905936410957, 6288.685565721696, 6315.652639104894, 6341.682915854189, 6366.745330186741, 4828.0, 4913.746994516376, 5071.721055341992, 5386.326709161355, 5753.482186603226, 3279.4588892832417, 3295.7857739246874, 3296.1924328539662, 3310.6192787829227, 3314.983425082859, 6350.174477318012, 6469.644169570719, 6505.967470162619, 6509.576877503042, 6565.606063636197, 6449.32282110381, 6470.352964703492, 6492.805215843532, 6497.805065848032, 6498.5126115541525, 5065.974670126626, 6330.588511746814, 6475.7085931133215, 6527.804165875032, 6550.803475895731, 5188.0661480933795, 5344.438833922382, 6003.45968862787, 6194.4115309045565, 6310.211223597051, 5601.495865372136, 5821.09772985188, 6217.658028808278, 6232.407921247474, 6317.715702793477, 5681.460261275172, 6358.2687990879795, 6491.221053473613, 6583.531175809072, 6586.37429444202, 3853.5183102112237, 3978.4629075074495, 4081.7346872453195, 4085.6731461483605, 4093.263212621757, 6309.085182648399, 6334.746610135543, 6349.746010159542, 6354.459870911024, 6371.948628476435, 4908.460069392436, 5655.688937108499, 5831.620944638585, 6092.329843717276, 6140.631562106288, 5285.365756109291, 6126.724297406538, 6129.662868542273, 6139.631622102688, 6199.0, 5832.679202643895, 5922.466977972003, 5945.464908158287, 5990.071538911301, 6057.42454466825, 5069.5944324454695, 6158.907616385847, 6175.197224360804, 6177.722002509808, 6188.381161883775, 5783.161441590862, 5929.0, 5992.730327135377, 6006.429389208019, 6024.487918526975], "value": 4416.176470743726, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.7757906259525, 746.5371469688794, 860.5095095795396, 866.3285953386124, 877.5612193903047, 13195.538156164535, 18220.453386398414, 18859.33992310266, 18865.05674716262, 18894.52763680907, 16065.357385704558, 17257.82742172581, 17405.3037878485, 17413.912930435363, 17423.564410889736, 675.1358261425371, 675.4495086504484, 690.3269312420375, 931.1991687149047, 939.4316438554679, 707.331571664777, 968.7771812483134, 971.1647982734843, 975.1175186456232, 983.7196399026279, 1061.601899287767, 1064.5103252503857, 1065.3341661461586, 1068.9737851662414, 1072.9624463143791, 1057.9841302380394, 1058.7617785998088, 1058.8041212375736, 1063.8829728729834, 1066.0884943373383, 782.006851298853, 786.1156199275815, 787.94484386093, 788.6727008291552, 792.5244853088159, 16175.514734557864, 16274.430394936238, 16351.182440878027, 16795.916020419943, 17022.063786491737, 16755.994640321496, 16756.0, 16956.915215423967, 17059.573510662332, 17138.914305428516, 13836.654083647889, 14028.438862445591, 14155.43378264868, 14180.50368237117, 14225.573232803032, 3383.4586466165542, 3406.471996840494, 3407.505911642798, 3410.6077801052948, 3411.385950528904, 127012.0, 127863.36068319599, 129408.0, 130696.34651826775, 130826.0, 9598.42409455435, 11129.387883666313, 11967.0, 12035.0, 12183.634490965285, 20124.59750805005, 20181.697274540893, 20260.0, 20486.59026819455, 20518.487037824172, 6487.740490380332, 7287.052683151156, 7295.817604559928, 7351.0, 7425.777226683208, 3484.756067075331, 3616.0, 3617.276544691072, 3619.2580520993133, 3627.383344831385, 4162.313218318944, 4254.808533615933, 4255.021345090585, 4256.531781504032, 4684.203685373494, 921.5346250143634, 926.9721908342625, 945.9905400945902, 947.6493697331894, 947.9099485548862, 643.4369926314475, 650.3626446082865, 666.6133642487346, 668.2715839734616, 678.8778019956455, 11214.719632009102, 12031.736667649946, 12106.152569320064, 12154.392280385946, 12424.254544727346, 636.5289685632598, 644.8839208942435, 650.6876699184418, 673.7810211681223, 675.5743881354813, 5265.842024739188, 5659.547236221092, 5785.1611516329895, 5812.88374232513, 5843.561732870052, 106031.0, 109142.0, 111296.4435177819, 111618.0, 115943.42028289974, 89050.0, 95348.0, 98032.0, 99924.0, 104639.47680261549, 73893.0, 89711.0, 90453.09546904579, 91275.54362228146, 91325.0, 9978.700638980843, 10745.516451759533, 11457.713557161138, 11635.185537012328, 11678.299302041905, 42102.789486052374, 42128.1574368517, 42207.366889497294, 42713.786431067645, 42738.504152354515, 45602.0, 56059.0, 56244.15633765415, 57053.71473142608, 57204.0, 11060.502277397376, 13073.346332683517, 16126.0, 16764.0, 16874.493765187064, 17836.3757268495, 18532.722009169604, 18534.0, 18658.44024679262, 18868.716969245197, 16875.0, 16877.40929067477, 17459.214335354685, 17599.0, 17739.556511087325, 16898.577535561708, 16987.320507179575, 17501.82498175002, 17745.46763597094, 17906.373276935246, 16504.504864854072, 16610.916945415196, 16917.74623380675, 16994.431169454554, 17200.31198752086, 11593.5362585499, 11827.645170644895, 12008.519659213884, 12092.334921579397, 12121.939390302992, 12217.266963982189, 12458.875411245772, 12870.613881583567, 13199.67000824987, 13465.663358415726], "value": 8255.153321964199, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1429.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 109.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 108.0, 148.0, 110.0, 107.0, 108.0, 103.0, 135.0, 108.0], "value": 117.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 186.0, 187.0, 188.0, 184.0, 186.0, 186.0, 186.0, 183.0], "value": 185.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 57.0, 89.0, 59.0, 57.0, 59.0, 57.0, 86.0, 58.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 86.0, 69.0, 68.0, 68.0, 91.0, 77.0, 96.0, 122.0], "value": 83.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 86.0, 87.0, 86.0, 87.0, 87.0, 88.0, 87.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 83.0, 83.0, 84.0, 83.0, 84.0, 84.0], "value": 83.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 48.0, 47.0, 49.0, 49.0, 48.0, 48.0, 50.0, 49.0], "value": 48.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 62.0, 58.0, 66.0, 63.0, 60.0, 58.0, 58.0, 56.0, 56.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 81.0, 84.0, 101.0, 83.0, 82.0, 79.0, 83.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 148.0, 146.0, 137.0, 135.0, 134.0, 137.0, 134.0, 223.0, 150.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 207.0, 184.0, 182.0, 188.0, 191.0, 188.0, 188.0, 189.0, 230.0], "value": 192.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 67.0, 68.0, 66.0, 66.0, 65.0, 68.0, 68.0], "value": 67.3, "unit": "score"}]}]} 17:24:19 INFO - Return code: 0 17:24:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:24:19 ERROR - # TBPL SUCCESS # 17:24:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:24:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:24:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:24:19 INFO - 2017-04-28 17:24:19.145 screenresolution[2548:37546] starting screenresolution argv=screenresolution get 17:24:19 INFO - 2017-04-28 17:24:19.148 screenresolution[2548:37546] Display 0: 1600x1200x32@60 17:24:19 INFO - 2017-04-28 17:24:19.154 screenresolution[2549:37549] starting screenresolution argv=screenresolution list 17:24:19 INFO - Available Modes on Display 0 17:24:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:24:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:24:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:24:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:24:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:24:19 INFO - Intel Iris: 17:24:19 INFO - Chipset Model: Intel Iris 17:24:19 INFO - Type: GPU 17:24:19 INFO - Bus: Built-In 17:24:19 INFO - VRAM (Dynamic, Max): 1536 MB 17:24:19 INFO - Vendor: Intel (0x8086) 17:24:19 INFO - Device ID: 0x0a2e 17:24:19 INFO - Revision ID: 0x0009 17:24:19 INFO - Displays: 17:24:19 INFO - Display: 17:24:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:24:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:24:19 INFO - Display Serial Number: 1600x1200 60 17:24:19 INFO - Main Display: Yes 17:24:19 INFO - Mirror: Off 17:24:19 INFO - Online: Yes 17:24:19 INFO - Rotation: Supported 17:24:19 INFO - Return code: 0 17:24:19 INFO - Running post-action listener: _resource_record_post_action 17:24:19 INFO - [mozharness: 2017-04-29 00:24:19.397269Z] Finished run-tests step (success) 17:24:19 INFO - Running post-run listener: _resource_record_post_run 17:24:19 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 1245184; Write bytes: 512432640; Read time: 10; Write time: 1818 17:24:19 INFO - TinderboxPrint: CPU usage
53.3% 17:24:19 INFO - TinderboxPrint: I/O read bytes / time
1,245,184 / 10 17:24:19 INFO - TinderboxPrint: I/O write bytes / time
512,432,640 / 1,818 17:24:19 INFO - TinderboxPrint: CPU idle
2,239.5 (46.7%) 17:24:19 INFO - TinderboxPrint: CPU system
955.1 (19.9%) 17:24:19 INFO - TinderboxPrint: CPU user
1,603.1 (33.4%) 17:24:19 INFO - TinderboxPrint: Swap in / out
209,481,728 / 0 17:24:19 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 194093568; Write bytes: 196720640; Read time: 15031; Write time: 461 17:24:19 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 1245184; Write bytes: 298869248; Read time: 10; Write time: 1307 17:24:19 INFO - Running post-run listener: _upload_blobber_files 17:24:19 INFO - Blob upload gear active. 17:24:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:24:19 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 17:24:19 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'] 17:24:19 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 17:24:20 INFO - (blobuploader) - INFO - Open directory for files ... 17:24:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:24:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:24:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:21 INFO - (blobuploader) - INFO - Done attempting. 17:24:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:24:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:24:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:22 INFO - (blobuploader) - INFO - Done attempting. 17:24:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:24:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:24:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:23 INFO - (blobuploader) - INFO - Done attempting. 17:24:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:24:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:24:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:24:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:24:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:24:25 INFO - (blobuploader) - INFO - Done attempting. 17:24:25 INFO - (blobuploader) - INFO - Iteration through files over. 17:24:25 INFO - Return code: 0 17:24:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:24:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:24:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/733670654552682754c6358ba8635e777c5fb3207a0e7f08847b9b5a52798c79e8cd403c73fc6bad5feed519ad1248ebda11f582f818422f1cf3370657cdc737", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ae61859e83aacd9c83d44caf3055b0668c494b5a52730d74f178e4abe7dcf7e42aec9b0dfc27de8918b704e2079680a25c850f18e42f371c7c55c44841f6435", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d90e8d43167db5c001582c328a18f2bdef7eeae24c1c5d40bd7d02e6392c42bbbfa34664ece0a7dfd6f802e6dd3f0d5d5a2a417c435373f2920bf7397b2ea0b1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77652f7139ce58dff33bcd0cd152c870ad50fa56f91bdaca84de4a848d9de8d85b904450e75fb99eb86b3504051befdcbb61144f7d574baf8cc71f30d5ca5089"} 17:24:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:24:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:24:25 INFO - Contents: 17:24:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/733670654552682754c6358ba8635e777c5fb3207a0e7f08847b9b5a52798c79e8cd403c73fc6bad5feed519ad1248ebda11f582f818422f1cf3370657cdc737", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ae61859e83aacd9c83d44caf3055b0668c494b5a52730d74f178e4abe7dcf7e42aec9b0dfc27de8918b704e2079680a25c850f18e42f371c7c55c44841f6435", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d90e8d43167db5c001582c328a18f2bdef7eeae24c1c5d40bd7d02e6392c42bbbfa34664ece0a7dfd6f802e6dd3f0d5d5a2a417c435373f2920bf7397b2ea0b1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77652f7139ce58dff33bcd0cd152c870ad50fa56f91bdaca84de4a848d9de8d85b904450e75fb99eb86b3504051befdcbb61144f7d574baf8cc71f30d5ca5089"} 17:24:25 INFO - Running post-run listener: copy_logs_to_upload_dir 17:24:25 INFO - Copying logs to upload dir... 17:24:25 INFO - mkdir: /builds/slave/test/build/upload/logs 17:24:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.901429 ========= master_lag: 1.21 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-28 17:24:26.690172) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:24:26.696164) ========= 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.CfTRj15bmy/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.LIQMI172vb/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/733670654552682754c6358ba8635e777c5fb3207a0e7f08847b9b5a52798c79e8cd403c73fc6bad5feed519ad1248ebda11f582f818422f1cf3370657cdc737", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ae61859e83aacd9c83d44caf3055b0668c494b5a52730d74f178e4abe7dcf7e42aec9b0dfc27de8918b704e2079680a25c850f18e42f371c7c55c44841f6435", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d90e8d43167db5c001582c328a18f2bdef7eeae24c1c5d40bd7d02e6392c42bbbfa34664ece0a7dfd6f802e6dd3f0d5d5a2a417c435373f2920bf7397b2ea0b1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77652f7139ce58dff33bcd0cd152c870ad50fa56f91bdaca84de4a848d9de8d85b904450e75fb99eb86b3504051befdcbb61144f7d574baf8cc71f30d5ca5089"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1493391200/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/733670654552682754c6358ba8635e777c5fb3207a0e7f08847b9b5a52798c79e8cd403c73fc6bad5feed519ad1248ebda11f582f818422f1cf3370657cdc737", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ae61859e83aacd9c83d44caf3055b0668c494b5a52730d74f178e4abe7dcf7e42aec9b0dfc27de8918b704e2079680a25c850f18e42f371c7c55c44841f6435", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d90e8d43167db5c001582c328a18f2bdef7eeae24c1c5d40bd7d02e6392c42bbbfa34664ece0a7dfd6f802e6dd3f0d5d5a2a417c435373f2920bf7397b2ea0b1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77652f7139ce58dff33bcd0cd152c870ad50fa56f91bdaca84de4a848d9de8d85b904450e75fb99eb86b3504051befdcbb61144f7d574baf8cc71f30d5ca5089"}' ========= master_lag: 0.47 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 17:24:27.181326) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:24:27.181648) ========= 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.CfTRj15bmy/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.LIQMI172vb/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.005376 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 17:24:27.281847) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:24:27.282157) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 17:24:27.282565) ========= ========= Total master_lag: 1.85 =========