builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0114 starttime: 1487674302.14 results: success (0) buildid: 20170221025132 builduid: a0cf14561f3e4eb386157195eacd8259 revision: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-21 02:51:42.143434) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-21 02:51:42.143903) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-21 02:51:42.144210) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-21 02:51:42.170324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 02:51:42.171006) ========= 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.rbYB18OF7y/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.Fy0rq3Tmnd/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-21 02:51:42-- 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% 143M=0s 2017-02-21 02:51:42 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145941 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 02:51:42.345842) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 02:51:42.346185) ========= 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.rbYB18OF7y/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.Fy0rq3Tmnd/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.020108 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 02:51:42.398330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-21 02:51:42.399133) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd --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 fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rbYB18OF7y/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.Fy0rq3Tmnd/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-21 02:51:42,518 truncating revision to first 12 chars 2017-02-21 02:51:42,518 Setting DEBUG logging. 2017-02-21 02:51:42,518 attempt 1/10 2017-02-21 02:51:42,518 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fc9f6f7e8e86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-21 02:51:43,614 unpacking tar archive at: mozilla-central-fc9f6f7e8e86/testing/mozharness/ program finished with exit code 0 elapsedTime=1.344873 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-21 02:51:43.774256) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-21 02:51:43.775046) ========= script_repo_revision: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-21 02:51:43.775989) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-21 02:51:43.776691) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-21 02:51:43.802962) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2017-02-21 02:51:43.803667) ========= /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.rbYB18OF7y/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.Fy0rq3Tmnd/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:51:44 INFO - MultiFileLogger online at 20170221 02:51:44 in /builds/slave/test 02:51:44 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 02:51:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:51:44 INFO - {'append_to_log': False, 02:51:44 INFO - 'base_work_dir': '/builds/slave/test', 02:51:44 INFO - 'blob_upload_branch': 'Firefox', 02:51:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:51:44 INFO - 'branch': 'Firefox', 02:51:44 INFO - 'buildbot_json_path': 'buildprops.json', 02:51:44 INFO - 'config_files': ('talos/mac_config.py',), 02:51:44 INFO - 'default_actions': ('clobber', 02:51:44 INFO - 'read-buildbot-config', 02:51:44 INFO - 'download-and-extract', 02:51:44 INFO - 'populate-webroot', 02:51:44 INFO - 'create-virtualenv', 02:51:44 INFO - 'install', 02:51:44 INFO - 'run-tests'), 02:51:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:51:44 INFO - 'download_minidump_stackwalk': True, 02:51:44 INFO - 'download_symbols': 'ondemand', 02:51:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:51:44 INFO - 'tooltool.py': '/tools/tooltool.py', 02:51:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:51:44 INFO - '/tools/misc-python/virtualenv.py')}, 02:51:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:51:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:51:44 INFO - 'installer_path': 'installer.exe', 02:51:44 INFO - 'log_level': 'info', 02:51:44 INFO - 'log_name': 'talos', 02:51:44 INFO - 'log_to_console': True, 02:51:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:51:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:51:44 INFO - 'opt_config_files': (), 02:51:44 INFO - 'pip_index': False, 02:51:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:51:44 INFO - 'cmd': ('bash', 02:51:44 INFO - '-c', 02:51:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:51:44 INFO - 'enabled': True, 02:51:44 INFO - 'halt_on_failure': False, 02:51:44 INFO - 'name': 'check_screen_resolution'},), 02:51:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:51:44 INFO - 'cmd': ('bash', 02:51:44 INFO - '-c', 02:51:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:51:44 INFO - 'enabled': True, 02:51:44 INFO - 'halt_on_failure': False, 02:51:44 INFO - 'name': 'check_screen_resolution'},), 02:51:44 INFO - 'run_cmd_checks_enabled': True, 02:51:44 INFO - 'sps_profile': False, 02:51:44 INFO - 'sps_profile_interval': 0, 02:51:44 INFO - 'suite': 'dromaeojs', 02:51:44 INFO - 'system_bits': '32', 02:51:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:51:44 INFO - 'title': 't-yosemite-r7-0114', 02:51:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:51:44 INFO - 'use_talos_json': True, 02:51:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:51:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:51:44 INFO - 'work_dir': 'build'} 02:51:44 INFO - [mozharness: 2017-02-21 10:51:44.056309Z] Running clobber step. 02:51:44 INFO - Running pre-action listener: _resource_record_pre_action 02:51:44 INFO - Running main action method: clobber 02:51:44 INFO - rmtree: /builds/slave/test/build 02:51:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:51:46 INFO - Running post-action listener: _resource_record_post_action 02:51:46 INFO - [mozharness: 2017-02-21 10:51:46.329359Z] Finished clobber step (success) 02:51:46 INFO - [mozharness: 2017-02-21 10:51:46.329491Z] Running read-buildbot-config step. 02:51:46 INFO - Running pre-action listener: _resource_record_pre_action 02:51:46 INFO - Running main action method: read_buildbot_config 02:51:46 INFO - Using buildbot properties: 02:51:46 INFO - { 02:51:46 INFO - "project": "", 02:51:46 INFO - "product": "firefox", 02:51:46 INFO - "script_repo_revision": "production", 02:51:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 02:51:46 INFO - "repository": "", 02:51:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 02:51:46 INFO - "buildid": "20170221025132", 02:51:46 INFO - "stage_platform": "macosx64", 02:51:46 INFO - "basedir": "/builds/slave/test", 02:51:46 INFO - "buildnumber": 1, 02:51:46 INFO - "platform": "yosemite_r7", 02:51:46 INFO - "mozci_request": { 02:51:46 INFO - "priority": -1, 02:51:46 INFO - "type": "trigger_all_talos_jobs", 02:51:46 INFO - "times": 1 02:51:46 INFO - }, 02:51:46 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 02:51:46 INFO - "slavebuilddir": "test", 02:51:46 INFO - "branch": "mozilla-central", 02:51:46 INFO - "revision": "fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd", 02:51:46 INFO - "slavename": "t-yosemite-r7-0114", 02:51:46 INFO - "builduid": "a0cf14561f3e4eb386157195eacd8259", 02:51:46 INFO - "repo_path": "mozilla-central" 02:51:46 INFO - } 02:51:46 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg. 02:51:46 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.test_packages.json. 02:51:46 INFO - Running post-action listener: _resource_record_post_action 02:51:46 INFO - [mozharness: 2017-02-21 10:51:46.333329Z] Finished read-buildbot-config step (success) 02:51:46 INFO - [mozharness: 2017-02-21 10:51:46.333468Z] Running download-and-extract step. 02:51:46 INFO - Running pre-action listener: _resource_record_pre_action 02:51:46 INFO - Running main action method: download_and_extract 02:51:46 INFO - mkdir: /builds/slave/test/build/tests 02:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:51:46 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.test_packages.json 02:51:46 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 02:51:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 02:51:46 INFO - Downloaded 1199 bytes. 02:51:46 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 02:51:46 INFO - Using the following test package requirements: 02:51:46 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 02:51:46 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 02:51:46 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 02:51:46 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 02:51:46 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 02:51:46 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 02:51:46 INFO - u'jsshell-mac.zip'], 02:51:46 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 02:51:46 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 02:51:46 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 02:51:46 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 02:51:46 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 02:51:46 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 02:51:46 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 02:51:46 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 02:51:46 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 02:51:46 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 02:51:46 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 02:51:46 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:51:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip 02:51:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:51:46 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip into memory 02:51:49 INFO - Expected file size: 51504348 02:51:49 INFO - Obtained file size: 51504348 02:52:05 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:52:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip 02:52:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:52:05 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.common.tests.zip into memory 02:52:06 INFO - Expected file size: 51504348 02:52:06 INFO - Obtained file size: 51504348 02:52:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.talos.tests.zip 02:52:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:52:21 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 02:52:24 INFO - Expected file size: 14403647 02:52:24 INFO - Obtained file size: 14403647 02:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:25 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg 02:52:25 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 02:52:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 02:52:30 INFO - Downloaded 70417704 bytes. 02:52:30 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg 02:52:30 INFO - mkdir: /builds/slave/test/properties 02:52:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:52:30 INFO - Writing to file /builds/slave/test/properties/build_url 02:52:30 INFO - Contents: 02:52:30 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg 02:52:31 INFO - Running post-action listener: _resource_record_post_action 02:52:31 INFO - Running post-action listener: set_extra_try_arguments 02:52:31 INFO - [mozharness: 2017-02-21 10:52:31.042826Z] Finished download-and-extract step (success) 02:52:31 INFO - [mozharness: 2017-02-21 10:52:31.042955Z] Running populate-webroot step. 02:52:31 INFO - Running pre-action listener: _resource_record_pre_action 02:52:31 INFO - Running main action method: populate_webroot 02:52:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:52:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:52:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:52:31 INFO - '--tppagecycles', 02:52:31 INFO - '7'], 02:52:31 INFO - 'tests': ['tsvgm']}}, 02:52:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:52:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:52:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:52:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:52:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:52:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:52:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:52:31 INFO - 'talos_options': ['--disable-e10s'], 02:52:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:52:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:52:31 INFO - 'talos_options': ['--disable-e10s'], 02:52:31 INFO - 'tests': ['damp', 'tps']}, 02:52:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:52:31 INFO - 'tests': ['damp', 'tps']}, 02:52:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:52:31 INFO - 'tests': ['dromaeo_dom']}, 02:52:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:52:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:52:31 INFO - 'tests': ['basic_compositor_video']}, 02:52:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:52:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:52:31 INFO - 'tests': ['a11yr', 02:52:31 INFO - 'ts_paint', 02:52:31 INFO - 'tpaint', 02:52:31 INFO - 'sessionrestore', 02:52:31 INFO - 'sessionrestore_no_auto_restore', 02:52:31 INFO - 'tabpaint']}, 02:52:31 INFO - 'other-e10s': {'tests': ['a11yr', 02:52:31 INFO - 'ts_paint', 02:52:31 INFO - 'tpaint', 02:52:31 INFO - 'sessionrestore', 02:52:31 INFO - 'sessionrestore_no_auto_restore', 02:52:31 INFO - 'tabpaint']}, 02:52:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:52:31 INFO - 'ts_paint', 02:52:31 INFO - 'tpaint', 02:52:31 INFO - 'sessionrestore', 02:52:31 INFO - 'sessionrestore_no_auto_restore', 02:52:31 INFO - 'tabpaint']}, 02:52:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:52:31 INFO - 'ts_paint', 02:52:31 INFO - 'tpaint', 02:52:31 INFO - 'sessionrestore', 02:52:31 INFO - 'sessionrestore_no_auto_restore', 02:52:31 INFO - 'tabpaint']}, 02:52:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:52:31 INFO - 'tests': ['a11yr', 02:52:31 INFO - 'ts_paint', 02:52:31 INFO - 'tpaint', 02:52:31 INFO - 'sessionrestore', 02:52:31 INFO - 'sessionrestore_no_auto_restore', 02:52:31 INFO - 'tabpaint']}, 02:52:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:52:31 INFO - 'tests': ['a11yr', 02:52:31 INFO - 'ts_paint', 02:52:31 INFO - 'tpaint', 02:52:31 INFO - 'sessionrestore', 02:52:31 INFO - 'sessionrestore_no_auto_restore', 02:52:31 INFO - 'tabpaint']}, 02:52:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:52:31 INFO - 'tests': ['tsvgx', 02:52:31 INFO - 'tsvgr_opacity', 02:52:31 INFO - 'tart', 02:52:31 INFO - 'tscrollx', 02:52:31 INFO - 'cart', 02:52:31 INFO - 'tsvg_static']}, 02:52:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:52:31 INFO - 'tsvgr_opacity', 02:52:31 INFO - 'tart', 02:52:31 INFO - 'tscrollx', 02:52:31 INFO - 'cart', 02:52:31 INFO - 'tsvg_static']}, 02:52:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:52:31 INFO - 'talos_options': ['--disable-e10s'], 02:52:31 INFO - 'tests': ['tp5o']}, 02:52:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:52:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:52:31 INFO - 'talos_options': ['--disable-e10s', 02:52:31 INFO - '--xperf_path', 02:52:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:31 INFO - 'tests': ['tp5n']}, 02:52:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:52:31 INFO - 'talos_options': ['--xperf_path', 02:52:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:31 INFO - 'tests': ['tp5n']}}, 02:52:31 INFO - 'talos.zip': {'path': '', 02:52:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:52:31 INFO - Running post-action listener: _resource_record_post_action 02:52:31 INFO - [mozharness: 2017-02-21 10:52:31.061400Z] Finished populate-webroot step (success) 02:52:31 INFO - [mozharness: 2017-02-21 10:52:31.061512Z] Running create-virtualenv step. 02:52:31 INFO - Running pre-action listener: _resource_record_pre_action 02:52:31 INFO - Running main action method: create_virtualenv 02:52:31 INFO - Creating virtualenv /builds/slave/test/build/venv 02:52:31 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 02:52:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:52:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:52:31 INFO - Using real prefix '/tools/python27' 02:52:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:52:31 INFO - Installing distribute.............................................................................................................................................................................................done. 02:52:34 INFO - Installing pip.................done. 02:52:34 INFO - Return code: 0 02:52:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:52:35 INFO - Reading from file tmpfile_stdout 02:52:35 INFO - Output received: 02:52:35 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) 02:52:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:52:35 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')]} 02:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:35 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')]} 02:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:35 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 0x10e0bbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0be768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c1945cc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de99d30>, '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 0x10ddc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de8ebe8>, '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.rbYB18OF7y/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.Fy0rq3Tmnd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:52:35 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 02:52:35 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 02:52:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbYB18OF7y/Render', 02:52:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:35 INFO - 'HOME': '/Users/cltbld', 02:52:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:35 INFO - 'LOGNAME': 'cltbld', 02:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:35 INFO - 'MOZ_NO_REMOTE': '1', 02:52:35 INFO - 'NO_EM_RESTART': '1', 02:52:35 INFO - 'PAGER': '/bin/cat', 02:52:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:35 INFO - 'PWD': '/builds/slave/test', 02:52:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:35 INFO - 'SHELL': '/bin/bash', 02:52:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0rq3Tmnd/Listeners', 02:52:35 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:52:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:35 INFO - 'USER': 'cltbld', 02:52:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:35 INFO - 'XPC_FLAGS': '0x0', 02:52:35 INFO - 'XPC_SERVICE_NAME': '0', 02:52:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:36 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 02:52:36 INFO - Cleaning up... 02:52:36 INFO - Return code: 0 02:52:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e0bbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0be768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c1945cc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de99d30>, '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 0x10ddc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de8ebe8>, '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.rbYB18OF7y/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.Fy0rq3Tmnd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:52:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:52:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbYB18OF7y/Render', 02:52:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:36 INFO - 'HOME': '/Users/cltbld', 02:52:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:36 INFO - 'LOGNAME': 'cltbld', 02:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:36 INFO - 'MOZ_NO_REMOTE': '1', 02:52:36 INFO - 'NO_EM_RESTART': '1', 02:52:36 INFO - 'PAGER': '/bin/cat', 02:52:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:36 INFO - 'PWD': '/builds/slave/test', 02:52:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:36 INFO - 'SHELL': '/bin/bash', 02:52:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0rq3Tmnd/Listeners', 02:52:36 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:52:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:36 INFO - 'USER': 'cltbld', 02:52:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:36 INFO - 'XPC_FLAGS': '0x0', 02:52:36 INFO - 'XPC_SERVICE_NAME': '0', 02:52:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:36 INFO - Downloading/unpacking psutil>=3.1.1 02:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:52:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:40 INFO - Installing collected packages: psutil 02:52:40 INFO - Running setup.py install for psutil 02:52:40 INFO - building 'psutil._psutil_osx' extension 02:52:40 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 02:52:40 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 02:52:40 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 02:52:40 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 02:52:40 INFO - building 'psutil._psutil_posix' extension 02:52:40 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 02:52:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:52:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:52:40 INFO - ^ 02:52:40 INFO - 1 warning generated. 02:52:40 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 02:52:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:41 INFO - Successfully installed psutil 02:52:41 INFO - Cleaning up... 02:52:41 INFO - Return code: 0 02:52:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:52:41 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')]} 02:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:41 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')]} 02:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:41 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 0x10e0bbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0be768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c1945cc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de99d30>, '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 0x10ddc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de8ebe8>, '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.rbYB18OF7y/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.Fy0rq3Tmnd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:52:41 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 02:52:41 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 02:52:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbYB18OF7y/Render', 02:52:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:41 INFO - 'HOME': '/Users/cltbld', 02:52:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:41 INFO - 'LOGNAME': 'cltbld', 02:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:41 INFO - 'MOZ_NO_REMOTE': '1', 02:52:41 INFO - 'NO_EM_RESTART': '1', 02:52:41 INFO - 'PAGER': '/bin/cat', 02:52:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:41 INFO - 'PWD': '/builds/slave/test', 02:52:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:41 INFO - 'SHELL': '/bin/bash', 02:52:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0rq3Tmnd/Listeners', 02:52:41 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:52:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:41 INFO - 'USER': 'cltbld', 02:52:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:41 INFO - 'XPC_FLAGS': '0x0', 02:52:41 INFO - 'XPC_SERVICE_NAME': '0', 02:52:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:52:44 INFO - Installing collected packages: mozsystemmonitor 02:52:44 INFO - Running setup.py install for mozsystemmonitor 02:52:44 INFO - Successfully installed mozsystemmonitor 02:52:44 INFO - Cleaning up... 02:52:44 INFO - Return code: 0 02:52:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:52: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')]} 02:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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')]} 02:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:44 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 0x10e0bbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0be768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c1945cc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de99d30>, '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 0x10ddc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de8ebe8>, '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.rbYB18OF7y/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.Fy0rq3Tmnd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:52:44 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 02:52:44 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 02:52:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbYB18OF7y/Render', 02:52:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:44 INFO - 'HOME': '/Users/cltbld', 02:52:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:44 INFO - 'LOGNAME': 'cltbld', 02:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:44 INFO - 'MOZ_NO_REMOTE': '1', 02:52:44 INFO - 'NO_EM_RESTART': '1', 02:52:44 INFO - 'PAGER': '/bin/cat', 02:52:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:44 INFO - 'PWD': '/builds/slave/test', 02:52:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:44 INFO - 'SHELL': '/bin/bash', 02:52:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0rq3Tmnd/Listeners', 02:52:44 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:52:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:44 INFO - 'USER': 'cltbld', 02:52:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:44 INFO - 'XPC_FLAGS': '0x0', 02:52:44 INFO - 'XPC_SERVICE_NAME': '0', 02:52:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:44 INFO - Downloading/unpacking jsonschema==2.5.1 02:52:44 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 02:52:44 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 02:52:44 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 02:52:44 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 02:52:44 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 02:52:44 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 02:52:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:52:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:48 INFO - Downloading functools32-3.2.3-2.tar.gz 02:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:52:48 INFO - warning: no files found matching '*.txt' 02:52:48 INFO - no previously-included directories found matching 'build' 02:52:48 INFO - no previously-included directories found matching 'dist' 02:52:48 INFO - no previously-included directories found matching '.git*' 02:52:48 INFO - Installing collected packages: jsonschema, functools32 02:52:48 INFO - Running setup.py install for functools32 02:52:48 INFO - warning: no files found matching '*.txt' 02:52:48 INFO - no previously-included directories found matching 'build' 02:52:48 INFO - no previously-included directories found matching 'dist' 02:52:48 INFO - no previously-included directories found matching '.git*' 02:52:48 INFO - Successfully installed jsonschema functools32 02:52:48 INFO - Cleaning up... 02:52:48 INFO - Return code: 0 02:52:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:48 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 0x10e0bbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0be768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c1945cc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de99d30>, '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 0x10ddc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de8ebe8>, '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.rbYB18OF7y/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.Fy0rq3Tmnd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:52:48 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 02:52:48 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 02:52:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbYB18OF7y/Render', 02:52:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:48 INFO - 'HOME': '/Users/cltbld', 02:52:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:48 INFO - 'LOGNAME': 'cltbld', 02:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:48 INFO - 'MOZ_NO_REMOTE': '1', 02:52:48 INFO - 'NO_EM_RESTART': '1', 02:52:48 INFO - 'PAGER': '/bin/cat', 02:52:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:48 INFO - 'PWD': '/builds/slave/test', 02:52:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:48 INFO - 'SHELL': '/bin/bash', 02:52:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0rq3Tmnd/Listeners', 02:52:48 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:52:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:48 INFO - 'USER': 'cltbld', 02:52:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:48 INFO - 'XPC_FLAGS': '0x0', 02:52:48 INFO - 'XPC_SERVICE_NAME': '0', 02:52:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:52:48 INFO - Cleaning up... 02:52:48 INFO - Return code: 0 02:52:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:48 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 0x10e0bbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0be768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c1945cc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de99d30>, '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 0x10ddc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de8ebe8>, '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.rbYB18OF7y/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.Fy0rq3Tmnd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:52:48 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 02:52:48 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 02:52:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbYB18OF7y/Render', 02:52:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:48 INFO - 'HOME': '/Users/cltbld', 02:52:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:48 INFO - 'LOGNAME': 'cltbld', 02:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:48 INFO - 'MOZ_NO_REMOTE': '1', 02:52:48 INFO - 'NO_EM_RESTART': '1', 02:52:48 INFO - 'PAGER': '/bin/cat', 02:52:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:48 INFO - 'PWD': '/builds/slave/test', 02:52:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:48 INFO - 'SHELL': '/bin/bash', 02:52:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0rq3Tmnd/Listeners', 02:52:48 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:52:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:48 INFO - 'USER': 'cltbld', 02:52:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:48 INFO - 'XPC_FLAGS': '0x0', 02:52:48 INFO - 'XPC_SERVICE_NAME': '0', 02:52:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:48 INFO - Downloading/unpacking blobuploader==1.2.4 02:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:51 INFO - Downloading blobuploader-1.2.4.tar.gz 02:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:52:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:52:51 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 02:52:51 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 02:52:51 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 02:52:51 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 02:52:51 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 02:52:51 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 02:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:52:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:52 INFO - Downloading docopt-0.6.1.tar.gz 02:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:52:53 INFO - Installing collected packages: blobuploader, requests, docopt 02:52:53 INFO - Running setup.py install for blobuploader 02:52:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:52:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:52:53 INFO - Running setup.py install for requests 02:52:53 INFO - Running setup.py install for docopt 02:52:53 INFO - Successfully installed blobuploader requests docopt 02:52:53 INFO - Cleaning up... 02:52:53 INFO - Return code: 0 02:52:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:53 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 0x10e0bbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0be768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c1945cc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de99d30>, '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 0x10ddc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de8ebe8>, '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.rbYB18OF7y/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.Fy0rq3Tmnd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:52:53 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 02:52:53 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 02:52:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbYB18OF7y/Render', 02:52:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:53 INFO - 'HOME': '/Users/cltbld', 02:52:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:53 INFO - 'LOGNAME': 'cltbld', 02:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:53 INFO - 'MOZ_NO_REMOTE': '1', 02:52:53 INFO - 'NO_EM_RESTART': '1', 02:52:53 INFO - 'PAGER': '/bin/cat', 02:52:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:53 INFO - 'PWD': '/builds/slave/test', 02:52:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:53 INFO - 'SHELL': '/bin/bash', 02:52:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0rq3Tmnd/Listeners', 02:52:53 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:52:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:53 INFO - 'USER': 'cltbld', 02:52:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:53 INFO - 'XPC_FLAGS': '0x0', 02:52:53 INFO - 'XPC_SERVICE_NAME': '0', 02:52:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:54 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-IGPjQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:54 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-mCh9Np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:54 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-ag9Xdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:54 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-cWZurz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:54 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-28_t2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:54 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-K3qkkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:54 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-kBIg7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:54 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-J12SWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-n8oG7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-Qlsl1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-KNUfEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-r2owPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-iW5LY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-U5PuCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-Ifl0e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-S2fZ6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-MZubxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:52:55 INFO - Running setup.py install for manifestparser 02:52:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:52:56 INFO - Running setup.py install for mozcrash 02:52:56 INFO - Running setup.py install for mozdebug 02:52:56 INFO - Running setup.py install for mozdevice 02:52:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:52:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:52:56 INFO - Running setup.py install for mozfile 02:52:56 INFO - Running setup.py install for mozhttpd 02:52:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:52:56 INFO - Running setup.py install for mozinfo 02:52:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:52:57 INFO - Running setup.py install for mozInstall 02:52:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:52:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:52:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:52:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:52:57 INFO - Running setup.py install for mozleak 02:52:57 INFO - Running setup.py install for mozlog 02:52:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:52:57 INFO - Running setup.py install for moznetwork 02:52:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:52:57 INFO - Running setup.py install for mozprocess 02:52:57 INFO - Running setup.py install for mozprofile 02:52:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:52:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:52:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:52:57 INFO - Running setup.py install for mozrunner 02:52:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:52:58 INFO - Running setup.py install for mozscreenshot 02:52:58 INFO - Running setup.py install for moztest 02:52:58 INFO - Running setup.py install for mozversion 02:52:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:52:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:52:58 INFO - Cleaning up... 02:52:58 INFO - Return code: 0 02:52:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52: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')]} 02:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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')]} 02:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:58 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 0x10e0bbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0be768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c1945cc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de99d30>, '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 0x10ddc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de8ebe8>, '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.rbYB18OF7y/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.Fy0rq3Tmnd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:52:58 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 02:52:58 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 02:52:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbYB18OF7y/Render', 02:52:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:58 INFO - 'HOME': '/Users/cltbld', 02:52:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:58 INFO - 'LOGNAME': 'cltbld', 02:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:58 INFO - 'MOZ_NO_REMOTE': '1', 02:52:58 INFO - 'NO_EM_RESTART': '1', 02:52:58 INFO - 'PAGER': '/bin/cat', 02:52:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:58 INFO - 'PWD': '/builds/slave/test', 02:52:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:58 INFO - 'SHELL': '/bin/bash', 02:52:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0rq3Tmnd/Listeners', 02:52:58 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:52:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:58 INFO - 'USER': 'cltbld', 02:52:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:58 INFO - 'XPC_FLAGS': '0x0', 02:52:58 INFO - 'XPC_SERVICE_NAME': '0', 02:52:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:58 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-pkiWzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:58 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)) 02:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:58 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-72P8iF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:59 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)) 02:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-NkXPEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:59 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)) 02:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-Wfjnh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-bw6JhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:59 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)) 02:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-x4FGuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:59 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)) 02:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-Ji5hqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:59 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)) 02:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-45Q15d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:59 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)) 02:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-GMM354-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:59 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)) 02:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-bVx__f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:59 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)) 02:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:59 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-wogRUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:00 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)) 02:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-4sWK98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-MO_P63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:00 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)) 02:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-h7qDYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:00 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)) 02:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-DXaj9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:00 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)) 02:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-JBqzHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:00 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)) 02:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-pOm8wV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:00 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)) 02:53:00 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)) 02:53:00 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)) 02:53:00 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)) 02:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:53:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:53:00 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 02:53:00 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 02:53:00 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 02:53:00 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 02:53:00 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 02:53:00 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 02:53:03 INFO - Downloading blessings-1.6.tar.gz 02:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:53:03 INFO - Installing collected packages: blessings 02:53:03 INFO - Running setup.py install for blessings 02:53:03 INFO - Successfully installed blessings 02:53:03 INFO - Cleaning up... 02:53:03 INFO - Return code: 0 02:53:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:53:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:03 INFO - Reading from file tmpfile_stdout 02:53:03 INFO - Current package versions: 02:53:03 INFO - blessings == 1.6 02:53:03 INFO - blobuploader == 1.2.4 02:53:03 INFO - docopt == 0.6.1 02:53:03 INFO - functools32 == 3.2.3-2 02:53:03 INFO - jsonschema == 2.5.1 02:53:03 INFO - manifestparser == 1.1 02:53:03 INFO - mozInstall == 1.12 02:53:03 INFO - mozcrash == 1.0 02:53:03 INFO - mozdebug == 0.1 02:53:03 INFO - mozdevice == 0.49 02:53:03 INFO - mozfile == 1.2 02:53:03 INFO - mozhttpd == 0.7 02:53:03 INFO - mozinfo == 0.9 02:53:03 INFO - mozleak == 0.1 02:53:03 INFO - mozlog == 3.4 02:53:03 INFO - moznetwork == 0.27 02:53:03 INFO - mozprocess == 0.24 02:53:03 INFO - mozprofile == 0.28 02:53:03 INFO - mozrunner == 6.13 02:53:03 INFO - mozscreenshot == 0.1 02:53:03 INFO - mozsystemmonitor == 0.3 02:53:03 INFO - moztest == 0.8 02:53:03 INFO - mozversion == 1.4 02:53:03 INFO - psutil == 3.1.1 02:53:03 INFO - requests == 1.2.3 02:53:03 INFO - wsgiref == 0.1.2 02:53:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53: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')]} 02:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53: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')]} 02:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:03 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 0x10e0bbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0be768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c1945cc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de99d30>, '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 0x10ddc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de8ebe8>, '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.rbYB18OF7y/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.Fy0rq3Tmnd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:53:03 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 02:53:03 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 02:53:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbYB18OF7y/Render', 02:53:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:03 INFO - 'HOME': '/Users/cltbld', 02:53:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:03 INFO - 'LOGNAME': 'cltbld', 02:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:03 INFO - 'MOZ_NO_REMOTE': '1', 02:53:03 INFO - 'NO_EM_RESTART': '1', 02:53:03 INFO - 'PAGER': '/bin/cat', 02:53:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:03 INFO - 'PWD': '/builds/slave/test', 02:53:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:03 INFO - 'SHELL': '/bin/bash', 02:53:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0rq3Tmnd/Listeners', 02:53:03 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:53:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:03 INFO - 'USER': 'cltbld', 02:53:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:03 INFO - 'XPC_FLAGS': '0x0', 02:53:03 INFO - 'XPC_SERVICE_NAME': '0', 02:53:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:04 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)) 02:53:04 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)) 02:53:04 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)) 02:53:04 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)) 02:53:04 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)) 02:53:04 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)) 02:53:04 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)) 02:53:04 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)) 02:53:04 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)) 02:53:04 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)) 02:53:04 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)) 02:53:04 INFO - Cleaning up... 02:53:04 INFO - Return code: 0 02:53:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:04 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 0x10e0bbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0be768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c1945cc90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de99d30>, '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 0x10ddc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de8ebe8>, '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.rbYB18OF7y/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.Fy0rq3Tmnd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 02:53:04 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 02:53:04 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 02:53:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbYB18OF7y/Render', 02:53:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:04 INFO - 'HOME': '/Users/cltbld', 02:53:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:04 INFO - 'LOGNAME': 'cltbld', 02:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:04 INFO - 'MOZ_NO_REMOTE': '1', 02:53:04 INFO - 'NO_EM_RESTART': '1', 02:53:04 INFO - 'PAGER': '/bin/cat', 02:53:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:04 INFO - 'PWD': '/builds/slave/test', 02:53:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:04 INFO - 'SHELL': '/bin/bash', 02:53:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0rq3Tmnd/Listeners', 02:53:04 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:53:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:04 INFO - 'USER': 'cltbld', 02:53:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:04 INFO - 'XPC_FLAGS': '0x0', 02:53:04 INFO - 'XPC_SERVICE_NAME': '0', 02:53:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:53:04 INFO - Cleaning up... 02:53:04 INFO - Return code: 0 02:53:04 INFO - Running post-action listener: _resource_record_post_action 02:53:04 INFO - Running post-action listener: _start_resource_monitoring 02:53:04 INFO - Starting resource monitoring. 02:53:04 INFO - [mozharness: 2017-02-21 10:53:04.491792Z] Finished create-virtualenv step (success) 02:53:04 INFO - [mozharness: 2017-02-21 10:53:04.492800Z] Running install step. 02:53:04 INFO - Running pre-action listener: _resource_record_pre_action 02:53:04 INFO - Running main action method: install 02:53:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:04 INFO - Reading from file tmpfile_stdout 02:53:04 INFO - Detecting whether we're running mozinstall >=1.0... 02:53:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:53:04 INFO - Reading from file tmpfile_stdout 02:53:04 INFO - Output received: 02:53:04 INFO - Usage: mozinstall [options] installer 02:53:04 INFO - Options: 02:53:04 INFO - -h, --help show this help message and exit 02:53:04 INFO - -d DEST, --destination=DEST 02:53:04 INFO - Directory to install application into. [default: 02:53:04 INFO - "/builds/slave/test"] 02:53:04 INFO - --app=APP Application being installed. [default: firefox] 02:53:04 INFO - mkdir: /builds/slave/test/build/application 02:53:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:53:26 INFO - Reading from file tmpfile_stdout 02:53:26 INFO - Output received: 02:53:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:53:26 INFO - Running post-action listener: _resource_record_post_action 02:53:26 INFO - [mozharness: 2017-02-21 10:53:26.996556Z] Finished install step (success) 02:53:26 INFO - [mozharness: 2017-02-21 10:53:26.996676Z] Running run-tests step. 02:53:26 INFO - Running pre-action listener: _resource_record_pre_action 02:53:26 INFO - Running main action method: run_tests 02:53:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:53:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:53:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:53:27 INFO - 2017-02-21 02:53:27.011 screenresolution[1927:64887] starting screenresolution argv=screenresolution get 02:53:27 INFO - 2017-02-21 02:53:27.013 screenresolution[1927:64887] Display 0: 1600x1200x32@60 02:53:27 INFO - 2017-02-21 02:53:27.019 screenresolution[1928:64889] starting screenresolution argv=screenresolution list 02:53:27 INFO - Available Modes on Display 0 02:53:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:53:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:53:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:53:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:53:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:53:27 INFO - Intel Iris: 02:53:27 INFO - Chipset Model: Intel Iris 02:53:27 INFO - Type: GPU 02:53:27 INFO - Bus: Built-In 02:53:27 INFO - VRAM (Dynamic, Max): 1536 MB 02:53:27 INFO - Vendor: Intel (0x8086) 02:53:27 INFO - Device ID: 0x0a2e 02:53:27 INFO - Revision ID: 0x0009 02:53:27 INFO - Displays: 02:53:27 INFO - Display: 02:53:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:53:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:53:27 INFO - Display Serial Number: 1600x1200 60 02:53:27 INFO - Main Display: Yes 02:53:27 INFO - Mirror: Off 02:53:27 INFO - Online: Yes 02:53:27 INFO - Rotation: Supported 02:53:27 INFO - Return code: 0 02:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:53:27 INFO - Python 2.7.3 02:53:27 INFO - Return code: 0 02:53:27 INFO - grabbing minidump binary from tooltool 02:53:27 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')]} 02:53:27 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 0x10de99d30>, '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 0x10ddc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de8ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:53:27 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 02:53:27 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 02:53:27 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 02:53:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:53:27 INFO - Return code: 0 02:53:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:53:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:53:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:53:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:53:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:53:27 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/1487085285/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--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 02:53:27 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/1487085285/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0114 --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 02:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbYB18OF7y/Render', 02:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:27 INFO - 'HOME': '/Users/cltbld', 02:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:27 INFO - 'LOGNAME': 'cltbld', 02:53:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:53:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:27 INFO - 'MOZ_NO_REMOTE': '1', 02:53:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:53:27 INFO - 'NO_EM_RESTART': '1', 02:53:27 INFO - 'PAGER': '/bin/cat', 02:53:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:27 INFO - 'PWD': '/builds/slave/test', 02:53:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:27 INFO - 'SHELL': '/bin/bash', 02:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0rq3Tmnd/Listeners', 02:53:27 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:27 INFO - 'USER': 'cltbld', 02:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:27 INFO - 'XPC_FLAGS': '0x0', 02:53:27 INFO - 'XPC_SERVICE_NAME': '0', 02:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:27 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/1487085285/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--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 02:53:27 INFO - mozversion application_buildid: 20170214071445 02:53:27 INFO - mozversion application_changeset: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd 02:53:27 INFO - mozversion application_display_name: Nightly 02:53:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:53:27 INFO - mozversion application_name: Firefox 02:53:27 INFO - mozversion application_remotingname: firefox 02:53:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:53:27 INFO - mozversion application_vendor: Mozilla 02:53:27 INFO - mozversion application_version: 54.0a1 02:53:27 INFO - mozversion platform_buildid: 20170214071445 02:53:27 INFO - mozversion platform_changeset: fc9f6f7e8e86f00af60ff1ecc72eaf854a6b1ddd 02:53:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:53:27 INFO - mozversion platform_version: 54.0a1 02:53:27 INFO - using testdate: 1487674407 02:53:27 INFO - actual date: 1487674407 02:53:27 INFO - starting webserver on 'localhost:51121' 02:53:27 INFO - SUITE-START | Running 2 tests 02:53:27 INFO - TEST-START | dromaeo_css 02:53:27 INFO - operating with platform_type : mac_ 02:53:27 INFO - Initialising browser for dromaeo_css test... 02:53:27 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpjIjEQe/profile http://localhost:51121/getInfo.html) 02:53:30 INFO - PROCESS | 1938 | __metrics Screen width/height:1600/1200 02:53:30 INFO - PROCESS | 1938 | colorDepth:24 02:53:30 INFO - PROCESS | 1938 | Browser inner width/height: 1024/689 02:53:30 INFO - PROCESS | 1938 | __metrics 02:53:30 INFO - PROCESS | 1938 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:53:30 INFO - PROCESS | 1938 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:53:30 INFO - TEST-INFO | 1938: exit 0 02:53:30 INFO - Browser initialized. 02:53:30 INFO - Running cycle 1/1 for dromaeo_css test... 02:53:30 INFO - TEST-INFO | started process 1940 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpjIjEQe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:53:42 INFO - PROCESS | 1940 | RSS: Main: 229105664 02:53:42 INFO - PROCESS | 1940 | 02:56:47 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:51121/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51121/tests/dromaeo/cssquery-ext.html) 02:56:49 INFO - PROCESS | 1940 | RSS: Main: 428834816 02:56:49 INFO - PROCESS | 1940 | 02:58:32 INFO - PROCESS | 1940 | ************************* 02:58:32 INFO - PROCESS | 1940 | A coding exception was thrown and uncaught in a Task. 02:58:32 INFO - PROCESS | 1940 | 02:58:32 ERROR - PROCESS | 1940 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:58:32 INFO - PROCESS | 1940 | Full stack: 02:58:32 INFO - PROCESS | 1940 | ************************* 02:59:52 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:51121/tests/dromaeo/cssquery-ext.html (next: http://localhost:51121/tests/dromaeo/cssquery-jquery.html) 02:59:53 INFO - PROCESS | 1940 | RSS: Main: 379371520 02:59:53 INFO - PROCESS | 1940 | 03:02:55 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:51121/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51121/tests/dromaeo/cssquery-mootools.html) 03:02:56 INFO - PROCESS | 1940 | RSS: Main: 348372992 03:02:56 INFO - PROCESS | 1940 | 03:05:58 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:51121/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51121/tests/dromaeo/cssquery-prototype.html) 03:05:59 INFO - PROCESS | 1940 | RSS: Main: 341327872 03:05:59 INFO - PROCESS | 1940 | 03:09:03 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:51121/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51121/tests/dromaeo/cssquery-yui.html) 03:09:03 INFO - PROCESS | 1940 | RSS: Main: 341635072 03:09:03 INFO - PROCESS | 1940 | 03:12:07 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:51121/tests/dromaeo/cssquery-yui.html (next: http://localhost:51121/tests/dromaeo/cssquery-dojo.html) 03:12:07 INFO - PROCESS | 1940 | RSS: Main: 550240256 03:12:07 INFO - PROCESS | 1940 | 03:12:07 INFO - PROCESS | 1940 | __start_tp_report 03:12:07 INFO - PROCESS | 1940 | _x_x_mozilla_page_load 03:12:07 INFO - PROCESS | 1940 | _x_x_mozilla_page_load_details 03:12:07 INFO - PROCESS | 1940 | |i|pagename|runs| 03:12:07 INFO - PROCESS | 1940 | |0;dojo.html;3214.7428205743536;3226.2257058306013;3258.5112233165023;3278.9999050289666;3284.998075586945;5373.623846330758;5461.590380721442;5502.724863756811;5536.861578460535;5574.414686457924;4659.603933665634;5492.450754924505;5542.889142217154;5589.189567512708;5623.915641265385;4970.204767237252;5023.970086132353;5054.620903432239;5054.823081192159;5097.388313402397;4297.957020429787;5131.692098474104;5174.353205849269;5192.454792246816;5202.375714914197;4930.408350997904;4971.030649023442;4981.626378021627;4987.177115775893;5147.485251474879;4611.501262089801;4803.207470767319;5013.24801279811;5092.490750924915;5165.793368265265;5037;5052.772625231836;5060.620453465968;5087.033463641897;5090.567301779353;5324.041672498949;5383.865403364908;5505.697186654733;5517.97917385281;5547.972260138674;6053.667048312341;6068.089786532011;6109.602875813058;6134.222293197073;6137.202163718733;6100.267967843887;6126.742307922372;6129.492384267765;6138.048602466625;6149.600275982047;5781.219535362757;5783.2192653992015;5789.334226563957;5800.303963524362;5809;6008.369121242206;6102.156009074812;6107.16610597354;6126.050462178369;6141.570090093651;5770.19217309577;5877.147813567009;5889.381614930457;5994.430529099728;6074.42292982166;6047.697615119315;6050.213472248667;6053.303870054912;6060.969695151584;6061.605995610359;5911;6019.608725432833;6021.909671354845;6033.18551995475;6038.396160384014;6032.517398608188;6043.667598282137;6047.969760151171;6049.213602231682;6049.879002419927;4142.2958097123565;4834.226523756182;4837.080954618611;4837.830675926326;4845.927311090337;4347.6304514116655;4389.253826849379;4400.427944367276;4403;4418.469783625921;5577.860553486114;5584.106542953108;5591.720413979285;5612.522935550524;5635.887282254414;5978.730957106941;6021;6033.487153591994;6080.027195648675;6104.572679912363;5578.219049333096;5650.26546548946;5666.603337766317;5679.460451257207;5706.4864162225595;5358.196270559447;5360.356757189163;5368.32895888014;5370.3287089113865;5381.461853814665;6077.848053798691;6133.417325354084;6135.9079613806725;6148.200733904564;6160.507159427146;6047.697615119315;6077.544184186292;6118.877622447437;6127.111568822585;6145.893739127;6143.6928153593035;6147.815565533041;6150.50795936333;6175.2589689237575;6189.381061893775;6042.1843051187525;6052.03167493199;6068.848278792889;6114.2357205349335;6137.938620613915;5007.7245751484015;5636.436356364331;6089.33017368098;6096.75612975476;6109.404666050238;6030.427109424598;6033.42682445167;6042.788502402394;6050.122732203894;6064.06007068905;5969.91045134332;5987.401259873977;6002.129691194839;6006.909896351471;6018;5628.634138780966;5686.516646085129;5741.966446039753;5742.799002034909;5777.046787280052;5978.432048955342;6001.729922153426;6002.219711437485;6014.548908831767;6030.849228769141;5594.13290939905;5634.830955071355;5644.52021578154;5695.9747245494555;5790.768369265183 03:12:07 INFO - PROCESS | 1940 | |1;ext.html;449.29236452587185;472.6526003387512;491.24593748595913;495.9082569724601;511.0724035874887;27597.099145837383;27995.860020699893;40353.99115022122;41001.82468068091;41211.969700757494;40099.39850902239;41858;41925.790371048104;42007;42053.57946420535;9093.454392736458;9284.396514226553;9332.953335233315;9352.111549402796;9355.6725514607;7335.156457007459;7529.811754706121;7542.962285188594;7570.848583028336;7579.696812127509;11174;11458.197926145172;11465.369404682739;11563.248388854698;11586.246893951908;9870.407775533418;11282.153838462065;11336.206465547373;11398.088152947745;11410.942945285262;7300.269973002711;10930.234883558154;11012.669619911416;11013.504392302366;11014.889851101547;27436.588451173247;27872;27892;27930;32265.51601725976;3508.578970523528;3666.7433279670436;3690.6678398943955;3808.390657494815;3824.7131465140224;27054.5941810871;27598.724012759816;29464;29745.25636859074;30522.38955220883;2619.620155077522;3041.4981528047847;3082.506798912186;3084.7686423518326;3087.212760746018;390098;393231;394408;394535;398668;45989;57115;57596;57604.42395575991;57605.423945760005;49003.75498122558;59292.40707592955;60361.39638603558;60403.40923292312;63075.36924630787;12498.187617804995;14172.574822755334;14502.85497145036;14519.637009074646;14872.405103795943;9440.763980900396;11310.547578096948;11318.037966772916;11318.151138664633;11343.376114313627;15801.074597026116;15845.286962086733;15871;15948.920255398649;15978;6860.5197636165985;6881.518293719391;6909.965450172717;6921.826954326081;6928.584284942919;639.9808005759835;817.2562967699365;835.7868743470498;841.6423020216383;855.538009474889;28480.71519284822;28604.71395286062;28626.427471450454;29136.562951555745;29347;993.3791380387258;1006.6174853555602;1030.407515678473;1044.300318786415;1170.9519979618194;13833.930830345986;14294.070885392417;14576.198309093103;14676.55970320892;15049.54851354461;539184.6081539213;542989;544689;544787;545833;45449;55622;55643;55766.72116639391;55767.721161393936;1336.191604079518;1389.0415613226842;1391.1374947532797;1392.1229625335973;1393.8048673185763;25087.34137357094;27909.860450697615;27964.461954592694;28897.56653650155;29076.7092329074;43310.56689433065;44406.3339049921;46421.76789116033;46701.76649116869;46890.531094689984;426867.8656606697;500153;508485;519550.8157214479;622723;34380.656193437746;34588;34938.77714279988;35118.82440587781;35374.64625353713;42316.093591454905;42635.573644264405;42751.78624106859;42808.357874631285;43293.78353108215;32788;34618;34664.48003279902;34808.65191348155;35838.64161358353;28457.573136402556;32970.340593188484;34808.47787283142;35236;35465.645343547265;34100.317993639495;34689.47965780465;34766.48221185725;34868;34869.651303486644;28859.134225973256;30766.230844229074;31094.533581995835;31202.687973119977;31369.372612547166;19635;23071.6539251908;23309.41726456852;23594.646080308466;23803.4074836696 03:12:07 INFO - PROCESS | 1940 | |2;jquery.html;357.20165430263376;373.87848949091546;383.9980800095999;399.2235102725199;414.5419311660615;13351.599452016431;13729.31353432328;19545.706814397796;20507.43761996158;21487;19135.425937221906;19390;20875.478113047182;21641;21855.344339669795;5640.294963129609;6000.939990600104;6002.3997600239845;6004.759809607611;6009.609375390585;3831.63599458051;4055.1078762672314;6231.127642130105;6512.544121911468;6543.770968016121;6579.34206579343;6583.07836902834;6599.967000164993;6600.735970561172;7541.358984486298;7643.624147653421;7732.420068494857;7906.723264685766;7916.129225785159;7918.841623167505;7561;7699.769006929801;7707.113681926594;7717.835687368152;7721.420893432959;27341.726582734314;27973.881044758185;27999.160025199275;28065.719342806515;28353.71646283552;2562.7821635161035;2684.355754618877;2710.9322266943486;2767.1283545683045;2902.521084021134;15906.284217210254;16097.678046439005;16119;16366.854320197592;16626;1837.9356722514647;1874.3158747057362;1877.8591605629633;1913.5981443896799;1916.9137388817396;144842.55157448503;145304.03311271503;146809;148101.8164364242;148669;14819.925900370428;15071.623209419633;20685;20868.582628347653;20998.895005524875;34788;36504.90485285446;36557.26885462276;36826.18715537634;36839.81580092083;8427;10064.521288026905;10196.286259961731;10208.642697505551;10341.689749307532;8244.175582441709;8247.670093196204;8247.711330103417;8419.915800842036;8437.240648341678;8391.4686069523;9803.215742740564;9812.607495700235;10011.649592264235;10129;4097.8770636880945;4189.790510474525;4206.8737937861915;4208.72643278192;4217.34631132175;869.3957699398984;933.570557543524;951.4766878216954;969.3214749675255;1012.3976234140674;16127.435539756287;17219.794614376875;17796.733049004277;19027.809721902882;20068.996550172433;942;947.8151760406793;950.1638558068855;971.121135372489;980.6861804222581;7743.5353878767455;7887.605619718991;9995.80008399828;10165.4917254137;10254.692359229235;513403;519973;521934;628175;634913;129233;142469.28765356107;144012;144978;149762.99999999782;1016.6136867990116;1030.2427715628858;1076.7308172956762;1078.369154044877;1079.7408621930838;18624.906875465535;18924.810751892306;19036.904815475835;19170.712439313702;19252.614947701248;46204;47382.76308618435;56421.71789141028;56744.71627641835;59462.40537594742;59015.70492147512;78393.21606783858;83156;83249;84120;8127.024757029194;8137.267645911897;8325.167483251626;8372.120927302789;8391.07698153215;9956.800863982824;11029.393383363991;12720.936395317964;13049.804252936023;13087.41106650184;10260.846087308846;10700.678979630624;11083.612073577386;11201.21591488588;11239.381833999209;8458.577071146541;10126.253286284122;10758.40828754426;11122.221444499131;11145.387003714874;10737.516811743333;11199.60801371948;11424.71438214018;11478.982356175271;11504.654860354203;7605.46761726696;7941.364690824836;8083.919160808552;8202.630881610223;8342.373237218926;9412.388194767318;10308.948455257676;10771.569137234423;10935.726606834893;11084.667459976214 03:12:07 INFO - PROCESS | 1940 | |3;mootools.html;1279.8144269080983;1289.5422125145578;1450.187894778924;1461.2401551193373;1467.0390893964457;8099.838003239939;8302.70940517082;8543.145685431453;8545.529995850226;8550.999999999993;6876.2092359378685;8342;8359.03871054829;8371.958140209306;8374.58127093646;1820.1798201798201;2269.829762767799;2271.091563374655;2271.9886400567975;2276.112316196685;2177.7060096886953;2258.977410225901;2273.227102785053;2276.46503071778;2287.336672365012;1886.3586380630584;1957.4421289932372;1968.6259610673999;2194.3197608741343;2252.6733623624564;1925.86518943674;2259.6949411829437;2274.0449011415244;2274.294968559752;2282.2468585366787;2185.8032777049984;2246.9662955055687;2280.3273034454874;2286.9771302287095;2287.0737351372723;8398.79003024923;8464.06895241523;8485.61814718333;8487.872681909776;8519.190676885686;4989.501049895018;5153.2270159476;5159.174532074888;5159.251908473288;5170.715610641413;3219.96780032199;3393.5079413485155;3393.7794043387103;3441.6214216436174;3456.7753096048928;1109.7835921995213;1174.4421399835096;1208.0456439412853;1224;1231.7905955987503;10543.261971661987;10748.97884700952;10849.783004339948;10853.837192442199;10863.18526110545;4358.869233922987;4511.390962220124;4594.609458196091;4605.424321959755;4619;9405.43567385959;9454.57454414553;9464.526773661428;9465.242780577537;9470.384425012353;5152.871178220575;5163.870903227375;5166;5166.121759300928;5171.198464238049;4548.385967894292;4635.837745678952;4644.907101857944;4670.579647831712;4739.857804265877;3661.6338366163172;3687.815609219528;3712.795796231233;3752.418375151856;3760.6427389397963;1171.9589814356627;1175.1127898436625;1177.7526719388852;1193.516625766566;1202.1584890576457;848.762346542969;848.7962888906618;850.961706723199;859.6647307550061;906.410832958569;4437.112577484516;5090.0583392072585;5175.870603234874;5488.670679759227;5507.5593952484505;560.6047736345866;566.832784328624;575.6920047774421;891.5185799668236;952.5713428956997;3615.891523254307;3727.347714150013;3885.2812229737588;3895.1820117775583;3895.824687889052;9833.606655733834;10007.899921000842;10021.699349019542;10024.298299119138;10035.19718422539;7043.753468628676;9819.116279534876;9943.254255930835;9956.054174853378;9958.551865166084;7360.595167265852;7638.1286584787085;7652.311291983637;7659.234076592407;7667.654955527015;5280.234366016829;5470.452954704498;5470.753816078206;5526.253955715927;5593.664380137042;8809.295256379603;8863.157999989991;8919.241864441596;9161.587728552098;9236.353455258337;6552.6723663817575;8577.699780507652;9016.368854180408;9319.068093190626;9414.435133891715;6923.584584924719;7067.82330441743;7068.081149450539;7071.71713131469;7072.823179420556;6503.252126005381;7518.624068796647;7590.0891892973195;7621.695132194872;7704.383649308154;6834.214065382345;6937.791866244021;6975.860482790417;6983.615901125487;7009.579425234502;6721.361470660279;6734.629595372302;6819.795406137824;6903.75836845708;6905.585664860125;4861.829835955725;6302.180716506825;6313.810585682437;6318.9052164216655;6327.367263273636;4676.1996631296515;4841.806327746992;4855.708657480563;4885.682430641997;4943.678660887174;4739.47865734762;4820.1805693031565;4872.683275587217;4885.560299573055;5034.672746271481 03:12:07 INFO - PROCESS | 1940 | |4;prototype.html;270.7373847368052;345.69751467465966;350.68088039883713;365.8920618417566;370.13388670511;4226.408302837602;4281.550437204095;4745.549172828584;4946.3817022872145;5040.815408379032;4931;4937.2840938063955;4941.553930804248;4951.876203094925;4982.950170498294;3641.763285386448;3894.2211557688574;3979.388347719164;4159.2721273777115;4176.749395036292;3152.7389044382317;3870.0446505661384;4136.937945930814;4139.275626765319;4159.667226621863;3442.3287458945515;3708.8516459341727;4030.9721021139567;4062.4515690381863;4163.125743593834;3421.880234191804;3496.8426420811124;3580.838862251205;3772.5095737553943;3847.575657664667;3542.9273874783285;3584.4981702561663;3604.297162053401;3614.5120408744747;3627.437747149196;4006.6193711597643;5044.520770526794;5081.3485617174565;5091.61812864033;5121.7439128043825;4232.343986682069;4410.4927933287445;4585.358049873021;4746.905061898778;4759.833405830814;4595.471520775121;4875.902481950377;5168.61235407346;5340;5428.67427954324;4003.619656132663;4004.799760011988;4032.858849940267;4049.4128351388886;4063.4108054331955;5051.469595692436;5079.5428411443145;5112.849608838019;5562.527185189264;5757.596968212269;3346.7489938254243;4091.9974606221667;4109.506859176918;4123.97938010308;4157.542670306264;4205.558416366299;4205.705600607928;4218.810153543098;4227.4423973496205;4246.851360202378;4461.486929003207;4510.526394728507;4736.289556566542;4821.325014497973;4868.882036314215;4895.216765317603;5546.389897111315;5559.804642001989;5567.749451274703;5580.330360356783;1131.5191043806349;1162.9127815413879;1264.4689230523202;1277.7763891319169;1376.511338474847;914.6204325204966;949.2026697574071;956.8374425073569;964.7843716916595;965.034965034965;3958.663513601376;4187.790610469464;4827.468978412372;4912.852614421573;4968.851009407185;4568.565986231302;5007.874803129951;5251.763670634754;5352.4308332000855;5434.429384914527;4123.505179378494;4761.119192949246;4793.113274044313;4810.95189048105;4821.9035619287415;2354.4231663242617;2781.694013658496;2812.3001918158798;2819.591159281934;2826.643211258566;5213.713245771443;5267.0256002639635;5506.862328441821;5517.944820551743;5521.282233309725;4774;4843.4430040545785;4950.271691154795;5148.3564554430695;5463.3717122530625;4740.762961851962;5331.1470164773455;5514.889702205934;5531.695756733418;5547.389787123413;4803.855884323476;5113.417724049331;5294.258803767399;5318.521333080042;5438.918416223681;4422.977885110554;5144.6655967362;5197.246399272009;5268.394134674561;5270.183121616155;4517.92175599228;4930.408350997904;5045.678987665715;5481.424450432647;5512.834614961557;3302.5376447297876;3464.34177506273;3595.532580764484;3614.3855544556964;3878.7781848717564;4821.855344339676;5055.898882022412;5271.683698978073;5290.391604965478;5392.137258038695;5099.643024988215;5114.488551144856;5123.641345105807;5165.870853228699;5231.42454330031;4785.349054576166;5089.607884294376;5103.907397966816;5117.974410127926;5155.304033955368;4321.719088259253;4618.953810461852;4989.326440930428;5027.622928280467;5037.596992240685;4404.027281584981;5087.287779710769;5089.389273287229;5093.694378337312;5137.743112844418;4431.889202769957;4719.952800471951;4887.828925987574;4982.768093501881;5029.974850125726 03:12:07 INFO - PROCESS | 1940 | |5;yui.html;635.7361694896618;703.834598869266;744.6983971491544;809.7854068671801;821.7247222180571;16281.674366512678;16484.928479648814;16813.66372672546;16977.405790797326;17026.31894724211;15220.923895380507;15282.770758438632;15314.923425382858;15322.233888305567;15384.15387153706;905.1039470923771;926.4719110107242;928.0811996123823;928.4568527411473;931.5481991234246;886.6010295367079;912.8493798523269;914.6661468563992;915.8305713443034;932.3147486597345;966.1980556138388;966.7244835221964;967.6081187119192;969.1519920069939;971.218169373654;953.6852838563327;960.5533426956429;960.7309953213112;962.0427674463918;965.7778710896533;711.4095300900241;713.2617740638466;713.9750108746169;715.7959981405274;716.2050124361954;14616.561503154922;15074;15333.769993449996;15339.769903451346;15379.000364976353;13923.164610123324;14170.716585668331;14192.574222773334;14207.857921420757;14355.641108972255;11302.830457543143;11382.373969431677;11456.713582160513;11717.350634876344;11851.881481185164;3649.7627654202392;3705.573859006222;3737.2712321097397;3832.9233415331814;3850.6919446444217;94329;96560.03439965581;96948.51525742326;98513.52229716488;98526.0147398524;10626.628068017582;11071.944640276746;11080.889191108146;11183.44082795857;11335.263207891625;20169.495762606053;22590.322290331318;23051.423714407272;23108.422289442562;23122.76877231206;7564.281393267631;7618.390528757686;7701.653425595861;7761.5731134787;7898.763037108896;4111.876643700693;4207.26372884744;4212.894677633022;4224.281872081753;4377.78111094444;3580.5166302548823;3678.8528458861347;3686.963130368662;3690.022144131807;3692.5753538342897;654.8297442664846;655.2153348269853;659.6174218952996;666.2804171494774;674.7233634210048;624.631467434216;646.9676516174172;663.3697986912356;678.6131904814208;687.52560733095;8660.393772435995;8907.287417006624;9709.514524273758;9825.803483930282;10082.29423940317;634.8730253949228;656.967151642416;677.2516369411827;694.8922916947881;699.912510936133;4629.560191781843;4688.320193571913;4688.601468875184;4692.436907571113;4713.811447542129;75505.24494755092;76662;92290;93134.9611054453;94716.57925131128;48494.787630309525;55640;56236.43763562312;73522;73874.15314617178;47472;51547.22679159816;56719.43280567224;58001.81961788072;58243.417565824646;8304.70933517324;9947.552360143956;10143.543540540546;10348.172146228133;10369.84445233307;41733.37399938943;41819.58180418279;43120.56879431291;43422.56577434185;43562.34656480092;51604.22593661173;52441.7377913108;52968.41094767163;53799.46200537944;54710.7264463691;12775.48898044105;12953.546625868426;12976.480940762642;13152.342382881008;13621.38703758353;13660.348054637378;13765.38055787472;13819.309034548434;13857.168569885838;13996.790048149081;12697.365131743562;12719.427625756678;12847.35763211817;12912.289824059766;13518.459261629425;12774.61676149717;12894.548690796153;12975.91760188124;13174.275414852274;13245.27151006704;12578.283936335962;12655.557055503014;12697.4286157125;12731.55439559648;12792.051695961423;10299.742506437398;10364.637237696947;10581.4709264538;10819.621313253998;11349.943250283695;8773.971815788482;9508;10270;10281.228907832092;10364.689059328231 03:12:07 INFO - PROCESS | 1940 | __end_tp_report 03:12:07 INFO - PROCESS | 1940 | __start_cc_report 03:12:07 INFO - PROCESS | 1940 | _x_x_mozilla_cycle_collect,2141 03:12:07 INFO - PROCESS | 1940 | __end_cc_report 03:12:07 INFO - PROCESS | 1940 | __startTimestamp1487675527535__endTimestamp 03:12:07 INFO - PROCESS | 1940 | 03:12:07 INFO - PROCESS | 1940 | ------- Summary: start ------- 03:12:07 INFO - PROCESS | 1940 | Number of tests: 6 03:12:07 INFO - PROCESS | 1940 | 03:12:07 INFO - PROCESS | 1940 | [#0] dojo.html Cycles:165 Average:5582.76 Median:5781.22 stddev:644.30 (11.1%) stddev-sans-first:618.92 03:12:07 INFO - PROCESS | 1940 | Values: 3214.7 3226.2 3258.5 3279.0 3285.0 5373.6 5461.6 5502.7 5536.9 5574.4 4659.6 5492.5 5542.9 5589.2 5623.9 4970.2 5024.0 5054.6 5054.8 5097.4 4298.0 5131.7 5174.4 5192.5 5202.4 4930.4 4971.0 4981.6 4987.2 5147.5 4611.5 4803.2 5013.2 5092.5 5165.8 5037.0 5052.8 5060.6 5087.0 5090.6 5324.0 5383.9 5505.7 5518.0 5548.0 6053.7 6068.1 6109.6 6134.2 6137.2 6100.3 6126.7 6129.5 6138.0 6149.6 5781.2 5783.2 5789.3 5800.3 5809.0 6008.4 6102.2 6107.2 6126.1 6141.6 5770.2 5877.1 5889.4 5994.4 6074.4 6047.7 6050.2 6053.3 6061.0 6061.6 5911.0 6019.6 6021.9 6033.2 6038.4 6032.5 6043.7 6048.0 6049.2 6049.9 4142.3 4834.2 4837.1 4837.8 4845.9 4347.6 4389.3 4400.4 4403.0 4418.5 5577.9 5584.1 5591.7 5612.5 5635.9 5978.7 6021.0 6033.5 6080.0 6104.6 5578.2 5650.3 5666.6 5679.5 5706.5 5358.2 5360.4 5368.3 5370.3 5381.5 6077.8 6133.4 6135.9 6148.2 6160.5 6047.7 6077.5 6118.9 6127.1 6145.9 6143.7 6147.8 6150.5 6175.3 6189.4 6042.2 6052.0 6068.8 6114.2 6137.9 5007.7 5636.4 6089.3 6096.8 6109.4 6030.4 6033.4 6042.8 6050.1 6064.1 5969.9 5987.4 6002.1 6006.9 6018.0 5628.6 5686.5 5742.0 5742.8 5777.0 5978.4 6001.7 6002.2 6014.5 6030.8 5594.1 5634.8 5644.5 5696.0 5790.8 03:12:07 INFO - PROCESS | 1940 | 03:12:07 INFO - PROCESS | 1940 | [#1] ext.html Cycles:180 Average:61480.82 Median:34868.83 stddev:130705.28 (374.8%) stddev-sans-first:130991.62 03:12:07 INFO - PROCESS | 1940 | Values: 449.3 472.7 491.2 495.9 511.1 27597.1 27995.9 40354.0 41001.8 41212.0 40099.4 41858.0 41925.8 42007.0 42053.6 9093.5 9284.4 9333.0 9352.1 9355.7 7335.2 7529.8 7543.0 7570.8 7579.7 11174.0 11458.2 11465.4 11563.2 11586.2 9870.4 11282.2 11336.2 11398.1 11410.9 7300.3 10930.2 11012.7 11013.5 11014.9 27436.6 27872.0 27892.0 27930.0 32265.5 3508.6 3666.7 3690.7 3808.4 3824.7 27054.6 27598.7 29464.0 29745.3 30522.4 2619.6 3041.5 3082.5 3084.8 3087.2 390098.0 393231.0 394408.0 394535.0 398668.0 45989.0 57115.0 57596.0 57604.4 57605.4 49003.8 59292.4 60361.4 60403.4 63075.4 12498.2 14172.6 14502.9 14519.6 14872.4 9440.8 11310.5 11318.0 11318.2 11343.4 15801.1 15845.3 15871.0 15948.9 15978.0 6860.5 6881.5 6910.0 6921.8 6928.6 640.0 817.3 835.8 841.6 855.5 28480.7 28604.7 28626.4 29136.6 29347.0 993.4 1006.6 1030.4 1044.3 1171.0 13833.9 14294.1 14576.2 14676.6 15049.5 539184.6 542989.0 544689.0 544787.0 545833.0 45449.0 55622.0 55643.0 55766.7 55767.7 1336.2 1389.0 1391.1 1392.1 1393.8 25087.3 27909.9 27964.5 28897.6 29076.7 43310.6 44406.3 46421.8 46701.8 46890.5 426867.9 500153.0 508485.0 519550.8 622723.0 34380.7 34588.0 34938.8 35118.8 35374.6 42316.1 42635.6 42751.8 42808.4 43293.8 32788.0 34618.0 34664.5 34808.7 35838.6 28457.6 32970.3 34808.5 35236.0 35465.6 34100.3 34689.5 34766.5 34868.0 34869.7 28859.1 30766.2 31094.5 31202.7 31369.4 19635.0 23071.7 23309.4 23594.6 23803.4 03:12:07 INFO - PROCESS | 1940 | 03:12:07 INFO - PROCESS | 1940 | [#2] jquery.html Cycles:180 Average:36436.86 Median:18845.26 stddev:95904.22 (508.9%) stddev-sans-first:96135.00 03:12:07 INFO - PROCESS | 1940 | Values: 357.2 373.9 384.0 399.2 414.5 13351.6 13729.3 19545.7 20507.4 21487.0 19135.4 19390.0 20875.5 21641.0 21855.3 5640.3 6000.9 6002.4 6004.8 6009.6 3831.6 4055.1 6231.1 6512.5 6543.8 6579.3 6583.1 6600.0 6600.7 7541.4 7643.6 7732.4 7906.7 7916.1 7918.8 7561.0 7699.8 7707.1 7717.8 7721.4 27341.7 27973.9 27999.2 28065.7 28353.7 2562.8 2684.4 2710.9 2767.1 2902.5 15906.3 16097.7 16119.0 16366.9 16626.0 1837.9 1874.3 1877.9 1913.6 1916.9 144842.6 145304.0 146809.0 148101.8 148669.0 14819.9 15071.6 20685.0 20868.6 20998.9 34788.0 36504.9 36557.3 36826.2 36839.8 8427.0 10064.5 10196.3 10208.6 10341.7 8244.2 8247.7 8247.7 8419.9 8437.2 8391.5 9803.2 9812.6 10011.6 10129.0 4097.9 4189.8 4206.9 4208.7 4217.3 869.4 933.6 951.5 969.3 1012.4 16127.4 17219.8 17796.7 19027.8 20069.0 942.0 947.8 950.2 971.1 980.7 7743.5 7887.6 9995.8 10165.5 10254.7 513403.0 519973.0 521934.0 628175.0 634913.0 129233.0 142469.3 144012.0 144978.0 149763.0 1016.6 1030.2 1076.7 1078.4 1079.7 18624.9 18924.8 19036.9 19170.7 19252.6 46204.0 47382.8 56421.7 56744.7 59462.4 59015.7 78393.2 83156.0 83249.0 84120.0 8127.0 8137.3 8325.2 8372.1 8391.1 9956.8 11029.4 12720.9 13049.8 13087.4 10260.8 10700.7 11083.6 11201.2 11239.4 8458.6 10126.3 10758.4 11122.2 11145.4 10737.5 11199.6 11424.7 11479.0 11504.7 7605.5 7941.4 8083.9 8202.6 8342.4 9412.4 10308.9 10771.6 10935.7 11084.7 03:12:07 INFO - PROCESS | 1940 | 03:12:07 INFO - PROCESS | 1940 | [#3] mootools.html Cycles:180 Average:5301.81 Median:5159.21 stddev:2930.48 (56.8%) stddev-sans-first:2923.11 03:12:07 INFO - PROCESS | 1940 | Values: 1279.8 1289.5 1450.2 1461.2 1467.0 8099.8 8302.7 8543.1 8545.5 8551.0 6876.2 8342.0 8359.0 8372.0 8374.6 1820.2 2269.8 2271.1 2272.0 2276.1 2177.7 2259.0 2273.2 2276.5 2287.3 1886.4 1957.4 1968.6 2194.3 2252.7 1925.9 2259.7 2274.0 2274.3 2282.2 2185.8 2247.0 2280.3 2287.0 2287.1 8398.8 8464.1 8485.6 8487.9 8519.2 4989.5 5153.2 5159.2 5159.3 5170.7 3220.0 3393.5 3393.8 3441.6 3456.8 1109.8 1174.4 1208.0 1224.0 1231.8 10543.3 10749.0 10849.8 10853.8 10863.2 4358.9 4511.4 4594.6 4605.4 4619.0 9405.4 9454.6 9464.5 9465.2 9470.4 5152.9 5163.9 5166.0 5166.1 5171.2 4548.4 4635.8 4644.9 4670.6 4739.9 3661.6 3687.8 3712.8 3752.4 3760.6 1172.0 1175.1 1177.8 1193.5 1202.2 848.8 848.8 851.0 859.7 906.4 4437.1 5090.1 5175.9 5488.7 5507.6 560.6 566.8 575.7 891.5 952.6 3615.9 3727.3 3885.3 3895.2 3895.8 9833.6 10007.9 10021.7 10024.3 10035.2 7043.8 9819.1 9943.3 9956.1 9958.6 7360.6 7638.1 7652.3 7659.2 7667.7 5280.2 5470.5 5470.8 5526.3 5593.7 8809.3 8863.2 8919.2 9161.6 9236.4 6552.7 8577.7 9016.4 9319.1 9414.4 6923.6 7067.8 7068.1 7071.7 7072.8 6503.3 7518.6 7590.1 7621.7 7704.4 6834.2 6937.8 6975.9 6983.6 7009.6 6721.4 6734.6 6819.8 6903.8 6905.6 4861.8 6302.2 6313.8 6318.9 6327.4 4676.2 4841.8 4855.7 4885.7 4943.7 4739.5 4820.2 4872.7 4885.6 5034.7 03:12:07 INFO - PROCESS | 1940 | 03:12:07 INFO - PROCESS | 1940 | [#4] prototype.html Cycles:180 Average:4303.87 Median:4816.14 stddev:1247.54 (25.9%) stddev-sans-first:1213.76 03:12:07 INFO - PROCESS | 1940 | Values: 270.7 345.7 350.7 365.9 370.1 4226.4 4281.6 4745.5 4946.4 5040.8 4931.0 4937.3 4941.6 4951.9 4983.0 3641.8 3894.2 3979.4 4159.3 4176.7 3152.7 3870.0 4136.9 4139.3 4159.7 3442.3 3708.9 4031.0 4062.5 4163.1 3421.9 3496.8 3580.8 3772.5 3847.6 3542.9 3584.5 3604.3 3614.5 3627.4 4006.6 5044.5 5081.3 5091.6 5121.7 4232.3 4410.5 4585.4 4746.9 4759.8 4595.5 4875.9 5168.6 5340.0 5428.7 4003.6 4004.8 4032.9 4049.4 4063.4 5051.5 5079.5 5112.8 5562.5 5757.6 3346.7 4092.0 4109.5 4124.0 4157.5 4205.6 4205.7 4218.8 4227.4 4246.9 4461.5 4510.5 4736.3 4821.3 4868.9 4895.2 5546.4 5559.8 5567.7 5580.3 1131.5 1162.9 1264.5 1277.8 1376.5 914.6 949.2 956.8 964.8 965.0 3958.7 4187.8 4827.5 4912.9 4968.9 4568.6 5007.9 5251.8 5352.4 5434.4 4123.5 4761.1 4793.1 4811.0 4821.9 2354.4 2781.7 2812.3 2819.6 2826.6 5213.7 5267.0 5506.9 5517.9 5521.3 4774.0 4843.4 4950.3 5148.4 5463.4 4740.8 5331.1 5514.9 5531.7 5547.4 4803.9 5113.4 5294.3 5318.5 5438.9 4423.0 5144.7 5197.2 5268.4 5270.2 4517.9 4930.4 5045.7 5481.4 5512.8 3302.5 3464.3 3595.5 3614.4 3878.8 4821.9 5055.9 5271.7 5290.4 5392.1 5099.6 5114.5 5123.6 5165.9 5231.4 4785.3 5089.6 5103.9 5118.0 5155.3 4321.7 4619.0 4989.3 5027.6 5037.6 4404.0 5087.3 5089.4 5093.7 5137.7 4431.9 4720.0 4887.8 4982.8 5030.0 03:12:07 INFO - PROCESS | 1940 | 03:12:07 INFO - PROCESS | 1940 | [#5] yui.html Cycles:180 Average:17727.02 Median:23970.06 stddev:23786.57 (99.2%) stddev-sans-first:23818.67 03:12:07 INFO - PROCESS | 1940 | Values: 635.7 703.8 744.7 809.8 821.7 16281.7 16484.9 16813.7 16977.4 17026.3 15220.9 15282.8 15314.9 15322.2 15384.2 905.1 926.5 928.1 928.5 931.5 886.6 912.8 914.7 915.8 932.3 966.2 966.7 967.6 969.2 971.2 953.7 960.6 960.7 962.0 965.8 711.4 713.3 714.0 715.8 716.2 14616.6 15074.0 15333.8 15339.8 15379.0 13923.2 14170.7 14192.6 14207.9 14355.6 11302.8 11382.4 11456.7 11717.4 11851.9 3649.8 3705.6 3737.3 3832.9 3850.7 94329.0 96560.0 96948.5 98513.5 98526.0 10626.6 11071.9 11080.9 11183.4 11335.3 20169.5 22590.3 23051.4 23108.4 23122.8 7564.3 7618.4 7701.7 7761.6 7898.8 4111.9 4207.3 4212.9 4224.3 4377.8 3580.5 3678.9 3687.0 3690.0 3692.6 654.8 655.2 659.6 666.3 674.7 624.6 647.0 663.4 678.6 687.5 8660.4 8907.3 9709.5 9825.8 10082.3 634.9 657.0 677.3 694.9 699.9 4629.6 4688.3 4688.6 4692.4 4713.8 75505.2 76662.0 92290.0 93135.0 94716.6 48494.8 55640.0 56236.4 73522.0 73874.2 47472.0 51547.2 56719.4 58001.8 58243.4 8304.7 9947.6 10143.5 10348.2 10369.8 41733.4 41819.6 43120.6 43422.6 43562.3 51604.2 52441.7 52968.4 53799.5 54710.7 12775.5 12953.5 12976.5 13152.3 13621.4 13660.3 13765.4 13819.3 13857.2 13996.8 12697.4 12719.4 12847.4 12912.3 13518.5 12774.6 12894.5 12975.9 13174.3 13245.3 12578.3 12655.6 12697.4 12731.6 12792.1 10299.7 10364.6 10581.5 10819.6 11349.9 8774.0 9508.0 10270.0 10281.2 10364.7 03:12:07 INFO - PROCESS | 1940 | -------- Summary: end -------- 03:12:07 INFO - PROCESS | 1940 | 03:12:08 INFO - TEST-INFO | 1940: exit 0 03:12:08 INFO - TEST-OK | dromaeo_css | took 1120607ms 03:12:08 INFO - TEST-START | kraken 03:12:08 INFO - operating with platform_type : mac_ 03:12:08 INFO - Initialising browser for kraken test... 03:12:08 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpCn_7vc/profile http://localhost:51121/getInfo.html) 03:12:10 INFO - PROCESS | 1942 | __metrics Screen width/height:1600/1200 03:12:10 INFO - PROCESS | 1942 | colorDepth:24 03:12:10 INFO - PROCESS | 1942 | Browser inner width/height: 1024/689 03:12:10 INFO - PROCESS | 1942 | __metrics 03:12:10 INFO - PROCESS | 1942 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:12:10 INFO - PROCESS | 1942 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:12:11 INFO - TEST-INFO | 1942: exit 0 03:12:11 INFO - Browser initialized. 03:12:11 INFO - Running cycle 1/1 for kraken test... 03:12:11 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpCn_7vc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:23 INFO - PROCESS | 1943 | RSS: Main: 229306368 03:12:23 INFO - PROCESS | 1943 | 03:12:26 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51121/tests/kraken/driver.html?testName=audio-beat-detection) 03:12:27 INFO - PROCESS | 1943 | RSS: Main: 289873920 03:12:27 INFO - PROCESS | 1943 | 03:12:30 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51121/tests/kraken/driver.html?testName=audio-dft) 03:12:30 INFO - PROCESS | 1943 | RSS: Main: 292896768 03:12:30 INFO - PROCESS | 1943 | 03:12:34 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51121/tests/kraken/driver.html?testName=audio-fft) 03:12:35 INFO - PROCESS | 1943 | RSS: Main: 385359872 03:12:35 INFO - PROCESS | 1943 | 03:12:37 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51121/tests/kraken/driver.html?testName=audio-oscillator) 03:12:37 INFO - PROCESS | 1943 | RSS: Main: 286023680 03:12:37 INFO - PROCESS | 1943 | 03:12:39 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51121/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:12:40 INFO - PROCESS | 1943 | RSS: Main: 287604736 03:12:40 INFO - PROCESS | 1943 | 03:12:43 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51121/tests/kraken/driver.html?testName=imaging-darkroom) 03:12:44 INFO - PROCESS | 1943 | RSS: Main: 330625024 03:12:44 INFO - PROCESS | 1943 | 03:12:47 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51121/tests/kraken/driver.html?testName=imaging-desaturate) 03:12:47 INFO - PROCESS | 1943 | RSS: Main: 331399168 03:12:47 INFO - PROCESS | 1943 | 03:12:50 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51121/tests/kraken/driver.html?testName=json-parse-financial) 03:12:51 INFO - PROCESS | 1943 | RSS: Main: 330551296 03:12:51 INFO - PROCESS | 1943 | 03:12:52 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51121/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:12:53 INFO - PROCESS | 1943 | RSS: Main: 305524736 03:12:53 INFO - PROCESS | 1943 | 03:12:55 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51121/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:12:56 INFO - PROCESS | 1943 | RSS: Main: 309305344 03:12:56 INFO - PROCESS | 1943 | 03:12:58 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51121/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:12:59 INFO - PROCESS | 1943 | RSS: Main: 311418880 03:12:59 INFO - PROCESS | 1943 | 03:13:02 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51121/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:13:02 INFO - PROCESS | 1943 | RSS: Main: 330784768 03:13:02 INFO - PROCESS | 1943 | 03:13:05 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51121/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:13:06 INFO - PROCESS | 1943 | RSS: Main: 324616192 03:13:06 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:51121/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51121/tests/kraken/driver.html?testName=ai-astar) 03:13:08 INFO - PROCESS | 1943 | RSS: Main: 369475584 03:13:08 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | __start_tp_report 03:13:08 INFO - PROCESS | 1943 | _x_x_mozilla_page_load 03:13:08 INFO - PROCESS | 1943 | _x_x_mozilla_page_load_details 03:13:08 INFO - PROCESS | 1943 | |i|pagename|runs| 03:13:08 INFO - PROCESS | 1943 | |0;ai-astar;111;115;114;113;115;121;165;163;114;114 03:13:08 INFO - PROCESS | 1943 | |1;audio-beat-detection;135;112;108;152;142;141;110;113;159;141 03:13:08 INFO - PROCESS | 1943 | |2;audio-dft;188;184;184;188;186;185;194;257;240;184 03:13:08 INFO - PROCESS | 1943 | |3;audio-fft;81;61;61;91;61;76;83;79;78;61 03:13:08 INFO - PROCESS | 1943 | |4;audio-oscillator;103;70;87;70;70;70;98;97;99;107 03:13:08 INFO - PROCESS | 1943 | |5;imaging-gaussian-blur;87;88;88;87;87;87;88;85;88;123 03:13:08 INFO - PROCESS | 1943 | |6;imaging-darkroom;102;132;96;96;100;94;95;95;95;95 03:13:08 INFO - PROCESS | 1943 | |7;imaging-desaturate;88;85;85;85;85;85;84;87;86;85 03:13:08 INFO - PROCESS | 1943 | |8;json-parse-financial;62;61;60;59;60;58;59;60;59;59 03:13:08 INFO - PROCESS | 1943 | |9;json-stringify-tinderbox;64;80;78;72;73;69;69;71;71;70 03:13:08 INFO - PROCESS | 1943 | |10;stanford-crypto-aes;94;83;96;107;114;107;95;93;96;95 03:13:08 INFO - PROCESS | 1943 | |11;stanford-crypto-ccm;153;148;155;155;146;147;161;155;220;158 03:13:08 INFO - PROCESS | 1943 | |12;stanford-crypto-pbkdf2;181;181;182;183;183;182;182;183;184;181 03:13:08 INFO - PROCESS | 1943 | |13;stanford-crypto-sha256-iterative;70;70;70;70;70;69;69;70;68;68 03:13:08 INFO - PROCESS | 1943 | __end_tp_report 03:13:08 INFO - PROCESS | 1943 | __start_cc_report 03:13:08 INFO - PROCESS | 1943 | _x_x_mozilla_cycle_collect,2118 03:13:08 INFO - PROCESS | 1943 | __end_cc_report 03:13:08 INFO - PROCESS | 1943 | __startTimestamp1487675588534__endTimestamp 03:13:08 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | ------- Summary: start ------- 03:13:08 INFO - PROCESS | 1943 | Number of tests: 14 03:13:08 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | [#0] ai-astar Cycles:10 Average:124.50 Median:115.00 stddev:20.98 (18.2%) stddev-sans-first:21.67 03:13:08 INFO - PROCESS | 1943 | Values: 111.0 115.0 114.0 113.0 115.0 121.0 165.0 163.0 114.0 114.0 03:13:08 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:141.00 stddev:18.90 (13.4%) stddev-sans-first:20.00 03:13:08 INFO - PROCESS | 1943 | Values: 135.0 112.0 108.0 152.0 142.0 141.0 110.0 113.0 159.0 141.0 03:13:08 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | [#2] audio-dft Cycles:10 Average:199.00 Median:188.00 stddev:26.57 (14.1%) stddev-sans-first:27.88 03:13:08 INFO - PROCESS | 1943 | Values: 188.0 184.0 184.0 188.0 186.0 185.0 194.0 257.0 240.0 184.0 03:13:08 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | [#3] audio-fft Cycles:10 Average:73.20 Median:78.50 stddev:11.22 (14.3%) stddev-sans-first:11.54 03:13:08 INFO - PROCESS | 1943 | Values: 81.0 61.0 61.0 91.0 61.0 76.0 83.0 79.0 78.0 61.0 03:13:08 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | [#4] audio-oscillator Cycles:10 Average:87.10 Median:78.50 stddev:15.55 (19.8%) stddev-sans-first:15.39 03:13:08 INFO - PROCESS | 1943 | Values: 103.0 70.0 87.0 70.0 70.0 70.0 98.0 97.0 99.0 107.0 03:13:08 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:87.50 stddev:11.35 (13.0%) stddev-sans-first:11.96 03:13:08 INFO - PROCESS | 1943 | Values: 87.0 88.0 88.0 87.0 87.0 87.0 88.0 85.0 88.0 123.0 03:13:08 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | [#6] imaging-darkroom Cycles:10 Average:100.00 Median:95.00 stddev:11.53 (12.1%) stddev-sans-first:12.20 03:13:08 INFO - PROCESS | 1943 | Values: 102.0 132.0 96.0 96.0 100.0 94.0 95.0 95.0 95.0 95.0 03:13:08 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.00 stddev:1.18 (1.4%) stddev-sans-first:0.83 03:13:08 INFO - PROCESS | 1943 | Values: 88.0 85.0 85.0 85.0 85.0 85.0 84.0 87.0 86.0 85.0 03:13:08 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:60.00 stddev:1.16 (1.9%) stddev-sans-first:0.88 03:13:08 INFO - PROCESS | 1943 | Values: 62.0 61.0 60.0 59.0 60.0 58.0 59.0 60.0 59.0 59.0 03:13:08 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:71.50 stddev:4.57 (6.4%) stddev-sans-first:3.91 03:13:08 INFO - PROCESS | 1943 | Values: 64.0 80.0 78.0 72.0 73.0 69.0 69.0 71.0 71.0 70.0 03:13:08 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | [#10] stanford-crypto-aes Cycles:10 Average:98.00 Median:94.50 stddev:8.88 (9.4%) stddev-sans-first:9.30 03:13:08 INFO - PROCESS | 1943 | Values: 94.0 83.0 96.0 107.0 114.0 107.0 95.0 93.0 96.0 95.0 03:13:08 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | [#11] stanford-crypto-ccm Cycles:10 Average:159.80 Median:155.00 stddev:21.70 (14.0%) stddev-sans-first:22.88 03:13:08 INFO - PROCESS | 1943 | Values: 153.0 148.0 155.0 155.0 146.0 147.0 161.0 155.0 220.0 158.0 03:13:08 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.20 Median:182.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 03:13:08 INFO - PROCESS | 1943 | Values: 181.0 181.0 182.0 183.0 183.0 182.0 182.0 183.0 184.0 181.0 03:13:08 INFO - PROCESS | 1943 | 03:13:08 INFO - PROCESS | 1943 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:0.84 (1.2%) stddev-sans-first:0.87 03:13:08 INFO - PROCESS | 1943 | Values: 70.0 70.0 70.0 70.0 70.0 69.0 69.0 70.0 68.0 68.0 03:13:08 INFO - PROCESS | 1943 | -------- Summary: end -------- 03:13:08 INFO - PROCESS | 1943 | 03:13:09 INFO - TEST-INFO | 1943: exit 0 03:13:09 INFO - TEST-OK | kraken | took 61440ms 03:13:09 INFO - SUITE-END | took 1182s 03:13:09 INFO - Completed test suite (00:19:42) 03:13:09 INFO - javascript benchmark 03:13:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7163.085816075494, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3214.7428205743536, 3226.2257058306013, 3258.5112233165023, 3278.9999050289666, 3284.998075586945, 5373.623846330758, 5461.590380721442, 5502.724863756811, 5536.861578460535, 5574.414686457924, 4659.603933665634, 5492.450754924505, 5542.889142217154, 5589.189567512708, 5623.915641265385, 4970.204767237252, 5023.970086132353, 5054.620903432239, 5054.823081192159, 5097.388313402397, 4297.957020429787, 5131.692098474104, 5174.353205849269, 5192.454792246816, 5202.375714914197, 4930.408350997904, 4971.030649023442, 4981.626378021627, 4987.177115775893, 5147.485251474879, 4611.501262089801, 4803.207470767319, 5013.24801279811, 5092.490750924915, 5165.793368265265, 5037.0, 5052.772625231836, 5060.620453465968, 5087.033463641897, 5090.567301779353, 5324.041672498949, 5383.865403364908, 5505.697186654733, 5517.97917385281, 5547.972260138674, 6053.667048312341, 6068.089786532011, 6109.602875813058, 6134.222293197073, 6137.202163718733, 6100.267967843887, 6126.742307922372, 6129.492384267765, 6138.048602466625, 6149.600275982047, 5781.219535362757, 5783.2192653992015, 5789.334226563957, 5800.303963524362, 5809.0, 6008.369121242206, 6102.156009074812, 6107.16610597354, 6126.050462178369, 6141.570090093651, 5770.19217309577, 5877.147813567009, 5889.381614930457, 5994.430529099728, 6074.42292982166, 6047.697615119315, 6050.213472248667, 6053.303870054912, 6060.969695151584, 6061.605995610359, 5911.0, 6019.608725432833, 6021.909671354845, 6033.18551995475, 6038.396160384014, 6032.517398608188, 6043.667598282137, 6047.969760151171, 6049.213602231682, 6049.879002419927, 4142.2958097123565, 4834.226523756182, 4837.080954618611, 4837.830675926326, 4845.927311090337, 4347.6304514116655, 4389.253826849379, 4400.427944367276, 4403.0, 4418.469783625921, 5577.860553486114, 5584.106542953108, 5591.720413979285, 5612.522935550524, 5635.887282254414, 5978.730957106941, 6021.0, 6033.487153591994, 6080.027195648675, 6104.572679912363, 5578.219049333096, 5650.26546548946, 5666.603337766317, 5679.460451257207, 5706.4864162225595, 5358.196270559447, 5360.356757189163, 5368.32895888014, 5370.3287089113865, 5381.461853814665, 6077.848053798691, 6133.417325354084, 6135.9079613806725, 6148.200733904564, 6160.507159427146, 6047.697615119315, 6077.544184186292, 6118.877622447437, 6127.111568822585, 6145.893739127, 6143.6928153593035, 6147.815565533041, 6150.50795936333, 6175.2589689237575, 6189.381061893775, 6042.1843051187525, 6052.03167493199, 6068.848278792889, 6114.2357205349335, 6137.938620613915, 5007.7245751484015, 5636.436356364331, 6089.33017368098, 6096.75612975476, 6109.404666050238, 6030.427109424598, 6033.42682445167, 6042.788502402394, 6050.122732203894, 6064.06007068905, 5969.91045134332, 5987.401259873977, 6002.129691194839, 6006.909896351471, 6018.0, 5628.634138780966, 5686.516646085129, 5741.966446039753, 5742.799002034909, 5777.046787280052, 5978.432048955342, 6001.729922153426, 6002.219711437485, 6014.548908831767, 6030.849228769141, 5594.13290939905, 5634.830955071355, 5644.52021578154, 5695.9747245494555, 5790.768369265183], "value": 5540.86720606223, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.29236452587185, 472.6526003387512, 491.24593748595913, 495.9082569724601, 511.0724035874887, 27597.099145837383, 27995.860020699893, 40353.99115022122, 41001.82468068091, 41211.969700757494, 40099.39850902239, 41858.0, 41925.790371048104, 42007.0, 42053.57946420535, 9093.454392736458, 9284.396514226553, 9332.953335233315, 9352.111549402796, 9355.6725514607, 7335.156457007459, 7529.811754706121, 7542.962285188594, 7570.848583028336, 7579.696812127509, 11174.0, 11458.197926145172, 11465.369404682739, 11563.248388854698, 11586.246893951908, 9870.407775533418, 11282.153838462065, 11336.206465547373, 11398.088152947745, 11410.942945285262, 7300.269973002711, 10930.234883558154, 11012.669619911416, 11013.504392302366, 11014.889851101547, 27436.588451173247, 27872.0, 27892.0, 27930.0, 32265.51601725976, 3508.578970523528, 3666.7433279670436, 3690.6678398943955, 3808.390657494815, 3824.7131465140224, 27054.5941810871, 27598.724012759816, 29464.0, 29745.25636859074, 30522.38955220883, 2619.620155077522, 3041.4981528047847, 3082.506798912186, 3084.7686423518326, 3087.212760746018, 390098.0, 393231.0, 394408.0, 394535.0, 398668.0, 45989.0, 57115.0, 57596.0, 57604.42395575991, 57605.423945760005, 49003.75498122558, 59292.40707592955, 60361.39638603558, 60403.40923292312, 63075.36924630787, 12498.187617804995, 14172.574822755334, 14502.85497145036, 14519.637009074646, 14872.405103795943, 9440.763980900396, 11310.547578096948, 11318.037966772916, 11318.151138664633, 11343.376114313627, 15801.074597026116, 15845.286962086733, 15871.0, 15948.920255398649, 15978.0, 6860.5197636165985, 6881.518293719391, 6909.965450172717, 6921.826954326081, 6928.584284942919, 639.9808005759835, 817.2562967699365, 835.7868743470498, 841.6423020216383, 855.538009474889, 28480.71519284822, 28604.71395286062, 28626.427471450454, 29136.562951555745, 29347.0, 993.3791380387258, 1006.6174853555602, 1030.407515678473, 1044.300318786415, 1170.9519979618194, 13833.930830345986, 14294.070885392417, 14576.198309093103, 14676.55970320892, 15049.54851354461, 539184.6081539213, 542989.0, 544689.0, 544787.0, 545833.0, 45449.0, 55622.0, 55643.0, 55766.72116639391, 55767.721161393936, 1336.191604079518, 1389.0415613226842, 1391.1374947532797, 1392.1229625335973, 1393.8048673185763, 25087.34137357094, 27909.860450697615, 27964.461954592694, 28897.56653650155, 29076.7092329074, 43310.56689433065, 44406.3339049921, 46421.76789116033, 46701.76649116869, 46890.531094689984, 426867.8656606697, 500153.0, 508485.0, 519550.8157214479, 622723.0, 34380.656193437746, 34588.0, 34938.77714279988, 35118.82440587781, 35374.64625353713, 42316.093591454905, 42635.573644264405, 42751.78624106859, 42808.357874631285, 43293.78353108215, 32788.0, 34618.0, 34664.48003279902, 34808.65191348155, 35838.64161358353, 28457.573136402556, 32970.340593188484, 34808.47787283142, 35236.0, 35465.645343547265, 34100.317993639495, 34689.47965780465, 34766.48221185725, 34868.0, 34869.651303486644, 28859.134225973256, 30766.230844229074, 31094.533581995835, 31202.687973119977, 31369.372612547166, 19635.0, 23071.6539251908, 23309.41726456852, 23594.646080308466, 23803.4074836696], "value": 18584.61850874133, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.20165430263376, 373.87848949091546, 383.9980800095999, 399.2235102725199, 414.5419311660615, 13351.599452016431, 13729.31353432328, 19545.706814397796, 20507.43761996158, 21487.0, 19135.425937221906, 19390.0, 20875.478113047182, 21641.0, 21855.344339669795, 5640.294963129609, 6000.939990600104, 6002.3997600239845, 6004.759809607611, 6009.609375390585, 3831.63599458051, 4055.1078762672314, 6231.127642130105, 6512.544121911468, 6543.770968016121, 6579.34206579343, 6583.07836902834, 6599.967000164993, 6600.735970561172, 7541.358984486298, 7643.624147653421, 7732.420068494857, 7906.723264685766, 7916.129225785159, 7918.841623167505, 7561.0, 7699.769006929801, 7707.113681926594, 7717.835687368152, 7721.420893432959, 27341.726582734314, 27973.881044758185, 27999.160025199275, 28065.719342806515, 28353.71646283552, 2562.7821635161035, 2684.355754618877, 2710.9322266943486, 2767.1283545683045, 2902.521084021134, 15906.284217210254, 16097.678046439005, 16119.0, 16366.854320197592, 16626.0, 1837.9356722514647, 1874.3158747057362, 1877.8591605629633, 1913.5981443896799, 1916.9137388817396, 144842.55157448503, 145304.03311271503, 146809.0, 148101.8164364242, 148669.0, 14819.925900370428, 15071.623209419633, 20685.0, 20868.582628347653, 20998.895005524875, 34788.0, 36504.90485285446, 36557.26885462276, 36826.18715537634, 36839.81580092083, 8427.0, 10064.521288026905, 10196.286259961731, 10208.642697505551, 10341.689749307532, 8244.175582441709, 8247.670093196204, 8247.711330103417, 8419.915800842036, 8437.240648341678, 8391.4686069523, 9803.215742740564, 9812.607495700235, 10011.649592264235, 10129.0, 4097.8770636880945, 4189.790510474525, 4206.8737937861915, 4208.72643278192, 4217.34631132175, 869.3957699398984, 933.570557543524, 951.4766878216954, 969.3214749675255, 1012.3976234140674, 16127.435539756287, 17219.794614376875, 17796.733049004277, 19027.809721902882, 20068.996550172433, 942.0, 947.8151760406793, 950.1638558068855, 971.121135372489, 980.6861804222581, 7743.5353878767455, 7887.605619718991, 9995.80008399828, 10165.4917254137, 10254.692359229235, 513403.0, 519973.0, 521934.0, 628175.0, 634913.0, 129233.0, 142469.28765356107, 144012.0, 144978.0, 149762.99999999782, 1016.6136867990116, 1030.2427715628858, 1076.7308172956762, 1078.369154044877, 1079.7408621930838, 18624.906875465535, 18924.810751892306, 19036.904815475835, 19170.712439313702, 19252.614947701248, 46204.0, 47382.76308618435, 56421.71789141028, 56744.71627641835, 59462.40537594742, 59015.70492147512, 78393.21606783858, 83156.0, 83249.0, 84120.0, 8127.024757029194, 8137.267645911897, 8325.167483251626, 8372.120927302789, 8391.07698153215, 9956.800863982824, 11029.393383363991, 12720.936395317964, 13049.804252936023, 13087.41106650184, 10260.846087308846, 10700.678979630624, 11083.612073577386, 11201.21591488588, 11239.381833999209, 8458.577071146541, 10126.253286284122, 10758.40828754426, 11122.221444499131, 11145.387003714874, 10737.516811743333, 11199.60801371948, 11424.71438214018, 11478.982356175271, 11504.654860354203, 7605.46761726696, 7941.364690824836, 8083.919160808552, 8202.630881610223, 8342.373237218926, 9412.388194767318, 10308.948455257676, 10771.569137234423, 10935.726606834893, 11084.667459976214], "value": 10779.919749117367, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.8144269080983, 1289.5422125145578, 1450.187894778924, 1461.2401551193373, 1467.0390893964457, 8099.838003239939, 8302.70940517082, 8543.145685431453, 8545.529995850226, 8550.999999999993, 6876.2092359378685, 8342.0, 8359.03871054829, 8371.958140209306, 8374.58127093646, 1820.1798201798201, 2269.829762767799, 2271.091563374655, 2271.9886400567975, 2276.112316196685, 2177.7060096886953, 2258.977410225901, 2273.227102785053, 2276.46503071778, 2287.336672365012, 1886.3586380630584, 1957.4421289932372, 1968.6259610673999, 2194.3197608741343, 2252.6733623624564, 1925.86518943674, 2259.6949411829437, 2274.0449011415244, 2274.294968559752, 2282.2468585366787, 2185.8032777049984, 2246.9662955055687, 2280.3273034454874, 2286.9771302287095, 2287.0737351372723, 8398.79003024923, 8464.06895241523, 8485.61814718333, 8487.872681909776, 8519.190676885686, 4989.501049895018, 5153.2270159476, 5159.174532074888, 5159.251908473288, 5170.715610641413, 3219.96780032199, 3393.5079413485155, 3393.7794043387103, 3441.6214216436174, 3456.7753096048928, 1109.7835921995213, 1174.4421399835096, 1208.0456439412853, 1224.0, 1231.7905955987503, 10543.261971661987, 10748.97884700952, 10849.783004339948, 10853.837192442199, 10863.18526110545, 4358.869233922987, 4511.390962220124, 4594.609458196091, 4605.424321959755, 4619.0, 9405.43567385959, 9454.57454414553, 9464.526773661428, 9465.242780577537, 9470.384425012353, 5152.871178220575, 5163.870903227375, 5166.0, 5166.121759300928, 5171.198464238049, 4548.385967894292, 4635.837745678952, 4644.907101857944, 4670.579647831712, 4739.857804265877, 3661.6338366163172, 3687.815609219528, 3712.795796231233, 3752.418375151856, 3760.6427389397963, 1171.9589814356627, 1175.1127898436625, 1177.7526719388852, 1193.516625766566, 1202.1584890576457, 848.762346542969, 848.7962888906618, 850.961706723199, 859.6647307550061, 906.410832958569, 4437.112577484516, 5090.0583392072585, 5175.870603234874, 5488.670679759227, 5507.5593952484505, 560.6047736345866, 566.832784328624, 575.6920047774421, 891.5185799668236, 952.5713428956997, 3615.891523254307, 3727.347714150013, 3885.2812229737588, 3895.1820117775583, 3895.824687889052, 9833.606655733834, 10007.899921000842, 10021.699349019542, 10024.298299119138, 10035.19718422539, 7043.753468628676, 9819.116279534876, 9943.254255930835, 9956.054174853378, 9958.551865166084, 7360.595167265852, 7638.1286584787085, 7652.311291983637, 7659.234076592407, 7667.654955527015, 5280.234366016829, 5470.452954704498, 5470.753816078206, 5526.253955715927, 5593.664380137042, 8809.295256379603, 8863.157999989991, 8919.241864441596, 9161.587728552098, 9236.353455258337, 6552.6723663817575, 8577.699780507652, 9016.368854180408, 9319.068093190626, 9414.435133891715, 6923.584584924719, 7067.82330441743, 7068.081149450539, 7071.71713131469, 7072.823179420556, 6503.252126005381, 7518.624068796647, 7590.0891892973195, 7621.695132194872, 7704.383649308154, 6834.214065382345, 6937.791866244021, 6975.860482790417, 6983.615901125487, 7009.579425234502, 6721.361470660279, 6734.629595372302, 6819.795406137824, 6903.75836845708, 6905.585664860125, 4861.829835955725, 6302.180716506825, 6313.810585682437, 6318.9052164216655, 6327.367263273636, 4676.1996631296515, 4841.806327746992, 4855.708657480563, 4885.682430641997, 4943.678660887174, 4739.47865734762, 4820.1805693031565, 4872.683275587217, 4885.560299573055, 5034.672746271481], "value": 4272.503214090345, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.7373847368052, 345.69751467465966, 350.68088039883713, 365.8920618417566, 370.13388670511, 4226.408302837602, 4281.550437204095, 4745.549172828584, 4946.3817022872145, 5040.815408379032, 4931.0, 4937.2840938063955, 4941.553930804248, 4951.876203094925, 4982.950170498294, 3641.763285386448, 3894.2211557688574, 3979.388347719164, 4159.2721273777115, 4176.749395036292, 3152.7389044382317, 3870.0446505661384, 4136.937945930814, 4139.275626765319, 4159.667226621863, 3442.3287458945515, 3708.8516459341727, 4030.9721021139567, 4062.4515690381863, 4163.125743593834, 3421.880234191804, 3496.8426420811124, 3580.838862251205, 3772.5095737553943, 3847.575657664667, 3542.9273874783285, 3584.4981702561663, 3604.297162053401, 3614.5120408744747, 3627.437747149196, 4006.6193711597643, 5044.520770526794, 5081.3485617174565, 5091.61812864033, 5121.7439128043825, 4232.343986682069, 4410.4927933287445, 4585.358049873021, 4746.905061898778, 4759.833405830814, 4595.471520775121, 4875.902481950377, 5168.61235407346, 5340.0, 5428.67427954324, 4003.619656132663, 4004.799760011988, 4032.858849940267, 4049.4128351388886, 4063.4108054331955, 5051.469595692436, 5079.5428411443145, 5112.849608838019, 5562.527185189264, 5757.596968212269, 3346.7489938254243, 4091.9974606221667, 4109.506859176918, 4123.97938010308, 4157.542670306264, 4205.558416366299, 4205.705600607928, 4218.810153543098, 4227.4423973496205, 4246.851360202378, 4461.486929003207, 4510.526394728507, 4736.289556566542, 4821.325014497973, 4868.882036314215, 4895.216765317603, 5546.389897111315, 5559.804642001989, 5567.749451274703, 5580.330360356783, 1131.5191043806349, 1162.9127815413879, 1264.4689230523202, 1277.7763891319169, 1376.511338474847, 914.6204325204966, 949.2026697574071, 956.8374425073569, 964.7843716916595, 965.034965034965, 3958.663513601376, 4187.790610469464, 4827.468978412372, 4912.852614421573, 4968.851009407185, 4568.565986231302, 5007.874803129951, 5251.763670634754, 5352.4308332000855, 5434.429384914527, 4123.505179378494, 4761.119192949246, 4793.113274044313, 4810.95189048105, 4821.9035619287415, 2354.4231663242617, 2781.694013658496, 2812.3001918158798, 2819.591159281934, 2826.643211258566, 5213.713245771443, 5267.0256002639635, 5506.862328441821, 5517.944820551743, 5521.282233309725, 4774.0, 4843.4430040545785, 4950.271691154795, 5148.3564554430695, 5463.3717122530625, 4740.762961851962, 5331.1470164773455, 5514.889702205934, 5531.695756733418, 5547.389787123413, 4803.855884323476, 5113.417724049331, 5294.258803767399, 5318.521333080042, 5438.918416223681, 4422.977885110554, 5144.6655967362, 5197.246399272009, 5268.394134674561, 5270.183121616155, 4517.92175599228, 4930.408350997904, 5045.678987665715, 5481.424450432647, 5512.834614961557, 3302.5376447297876, 3464.34177506273, 3595.532580764484, 3614.3855544556964, 3878.7781848717564, 4821.855344339676, 5055.898882022412, 5271.683698978073, 5290.391604965478, 5392.137258038695, 5099.643024988215, 5114.488551144856, 5123.641345105807, 5165.870853228699, 5231.42454330031, 4785.349054576166, 5089.607884294376, 5103.907397966816, 5117.974410127926, 5155.304033955368, 4321.719088259253, 4618.953810461852, 4989.326440930428, 5027.622928280467, 5037.596992240685, 4404.027281584981, 5087.287779710769, 5089.389273287229, 5093.694378337312, 5137.743112844418, 4431.889202769957, 4719.952800471951, 4887.828925987574, 4982.768093501881, 5029.974850125726], "value": 3923.5208423465338, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.7361694896618, 703.834598869266, 744.6983971491544, 809.7854068671801, 821.7247222180571, 16281.674366512678, 16484.928479648814, 16813.66372672546, 16977.405790797326, 17026.31894724211, 15220.923895380507, 15282.770758438632, 15314.923425382858, 15322.233888305567, 15384.15387153706, 905.1039470923771, 926.4719110107242, 928.0811996123823, 928.4568527411473, 931.5481991234246, 886.6010295367079, 912.8493798523269, 914.6661468563992, 915.8305713443034, 932.3147486597345, 966.1980556138388, 966.7244835221964, 967.6081187119192, 969.1519920069939, 971.218169373654, 953.6852838563327, 960.5533426956429, 960.7309953213112, 962.0427674463918, 965.7778710896533, 711.4095300900241, 713.2617740638466, 713.9750108746169, 715.7959981405274, 716.2050124361954, 14616.561503154922, 15074.0, 15333.769993449996, 15339.769903451346, 15379.000364976353, 13923.164610123324, 14170.716585668331, 14192.574222773334, 14207.857921420757, 14355.641108972255, 11302.830457543143, 11382.373969431677, 11456.713582160513, 11717.350634876344, 11851.881481185164, 3649.7627654202392, 3705.573859006222, 3737.2712321097397, 3832.9233415331814, 3850.6919446444217, 94329.0, 96560.03439965581, 96948.51525742326, 98513.52229716488, 98526.0147398524, 10626.628068017582, 11071.944640276746, 11080.889191108146, 11183.44082795857, 11335.263207891625, 20169.495762606053, 22590.322290331318, 23051.423714407272, 23108.422289442562, 23122.76877231206, 7564.281393267631, 7618.390528757686, 7701.653425595861, 7761.5731134787, 7898.763037108896, 4111.876643700693, 4207.26372884744, 4212.894677633022, 4224.281872081753, 4377.78111094444, 3580.5166302548823, 3678.8528458861347, 3686.963130368662, 3690.022144131807, 3692.5753538342897, 654.8297442664846, 655.2153348269853, 659.6174218952996, 666.2804171494774, 674.7233634210048, 624.631467434216, 646.9676516174172, 663.3697986912356, 678.6131904814208, 687.52560733095, 8660.393772435995, 8907.287417006624, 9709.514524273758, 9825.803483930282, 10082.29423940317, 634.8730253949228, 656.967151642416, 677.2516369411827, 694.8922916947881, 699.912510936133, 4629.560191781843, 4688.320193571913, 4688.601468875184, 4692.436907571113, 4713.811447542129, 75505.24494755092, 76662.0, 92290.0, 93134.9611054453, 94716.57925131128, 48494.787630309525, 55640.0, 56236.43763562312, 73522.0, 73874.15314617178, 47472.0, 51547.22679159816, 56719.43280567224, 58001.81961788072, 58243.417565824646, 8304.70933517324, 9947.552360143956, 10143.543540540546, 10348.172146228133, 10369.84445233307, 41733.37399938943, 41819.58180418279, 43120.56879431291, 43422.56577434185, 43562.34656480092, 51604.22593661173, 52441.7377913108, 52968.41094767163, 53799.46200537944, 54710.7264463691, 12775.48898044105, 12953.546625868426, 12976.480940762642, 13152.342382881008, 13621.38703758353, 13660.348054637378, 13765.38055787472, 13819.309034548434, 13857.168569885838, 13996.790048149081, 12697.365131743562, 12719.427625756678, 12847.35763211817, 12912.289824059766, 13518.459261629425, 12774.61676149717, 12894.548690796153, 12975.91760188124, 13174.275414852274, 13245.27151006704, 12578.283936335962, 12655.557055503014, 12697.4286157125, 12731.55439559648, 12792.051695961423, 10299.742506437398, 10364.637237696947, 10581.4709264538, 10819.621313253998, 11349.943250283695, 8773.971815788482, 9508.0, 10270.0, 10281.228907832092, 10364.689059328231], "value": 7258.472346367315, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 114.0, 113.0, 115.0, 121.0, 165.0, 163.0, 114.0, 114.0], "value": 124.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 112.0, 108.0, 152.0, 142.0, 141.0, 110.0, 113.0, 159.0, 141.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 184.0, 184.0, 188.0, 186.0, 185.0, 194.0, 257.0, 240.0, 184.0], "value": 199.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 61.0, 91.0, 61.0, 76.0, 83.0, 79.0, 78.0, 61.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 70.0, 87.0, 70.0, 70.0, 70.0, 98.0, 97.0, 99.0, 107.0], "value": 87.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 88.0, 87.0, 87.0, 87.0, 88.0, 85.0, 88.0, 123.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 132.0, 96.0, 96.0, 100.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 100.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 87.0, 86.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 59.0, 60.0, 58.0, 59.0, 60.0, 59.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 80.0, 78.0, 72.0, 73.0, 69.0, 69.0, 71.0, 71.0, 70.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 83.0, 96.0, 107.0, 114.0, 107.0, 95.0, 93.0, 96.0, 95.0], "value": 98.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 148.0, 155.0, 155.0, 146.0, 147.0, 161.0, 155.0, 220.0, 158.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 181.0, 182.0, 183.0, 183.0, 182.0, 182.0, 183.0, 184.0, 181.0], "value": 182.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 70.0, 70.0, 69.0, 69.0, 70.0, 68.0, 68.0], "value": 69.4, "unit": "score"}]}]} 03:13:09 INFO - Return code: 0 03:13:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:13:09 ERROR - # TBPL SUCCESS # 03:13:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:13:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:13:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:13:09 INFO - 2017-02-21 03:13:09.872 screenresolution[1948:67278] starting screenresolution argv=screenresolution get 03:13:09 INFO - 2017-02-21 03:13:09.874 screenresolution[1948:67278] Display 0: 1600x1200x32@60 03:13:09 INFO - 2017-02-21 03:13:09.880 screenresolution[1949:67280] starting screenresolution argv=screenresolution list 03:13:09 INFO - Available Modes on Display 0 03:13:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:13:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:13:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:13:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:13:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:13:10 INFO - Intel Iris: 03:13:10 INFO - Chipset Model: Intel Iris 03:13:10 INFO - Type: GPU 03:13:10 INFO - Bus: Built-In 03:13:10 INFO - VRAM (Dynamic, Max): 1536 MB 03:13:10 INFO - Vendor: Intel (0x8086) 03:13:10 INFO - Device ID: 0x0a2e 03:13:10 INFO - Revision ID: 0x0009 03:13:10 INFO - Displays: 03:13:10 INFO - Display: 03:13:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:13:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:13:10 INFO - Display Serial Number: 1600x1200 60 03:13:10 INFO - Main Display: Yes 03:13:10 INFO - Mirror: Off 03:13:10 INFO - Online: Yes 03:13:10 INFO - Rotation: Supported 03:13:10 INFO - Return code: 0 03:13:10 INFO - Running post-action listener: _resource_record_post_action 03:13:10 INFO - [mozharness: 2017-02-21 11:13:10.130575Z] Finished run-tests step (success) 03:13:10 INFO - Running post-run listener: _resource_record_post_run 03:13:10 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 2457600; Write bytes: 555437056; Read time: 11; Write time: 1872 03:13:10 INFO - TinderboxPrint: CPU usage
54.1% 03:13:10 INFO - TinderboxPrint: I/O read bytes / time
2,457,600 / 11 03:13:10 INFO - TinderboxPrint: I/O write bytes / time
555,437,056 / 1,872 03:13:10 INFO - TinderboxPrint: CPU idle
2,212.9 (45.9%) 03:13:10 INFO - TinderboxPrint: CPU system
974.8 (20.2%) 03:13:10 INFO - TinderboxPrint: CPU user
1,634.1 (33.9%) 03:13:10 INFO - TinderboxPrint: Swap in / out
254,689,280 / 0 03:13:10 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 244599296; Write bytes: 238876160; Read time: 17889; Write time: 494 03:13:10 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 2457600; Write bytes: 299275776; Read time: 11; Write time: 1319 03:13:10 INFO - Running post-run listener: _upload_blobber_files 03:13:10 INFO - Blob upload gear active. 03:13:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:13:10 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 03:13:10 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'] 03:13:10 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 03:13:11 INFO - (blobuploader) - INFO - Open directory for files ... 03:13:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:13:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:13:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:11 INFO - (blobuploader) - INFO - Done attempting. 03:13:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:13:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:13:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:12 INFO - (blobuploader) - INFO - Done attempting. 03:13:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:13:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:13:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:13 INFO - (blobuploader) - INFO - Done attempting. 03:13:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:13:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:13:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:15 INFO - (blobuploader) - INFO - Done attempting. 03:13:15 INFO - (blobuploader) - INFO - Iteration through files over. 03:13:15 INFO - Return code: 0 03:13:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:13:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:13:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/363fb0ca8f6cd9f6b48afc61091c60b0635adaafd4aaac3c783da3637e6d06ba6b7e3f8dfb70e62629eef5fc3062a7d58a485355c1f271c4f53d2b1b4adb4643", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4cb1b93c5547705547c63d1985e1b2c3ce6f10513bd57dc0b7faeec4f4d9504bfa0d3255b874477dc6e2651eeea868452ac529079bd26eb88f10709bfe4a99a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17b9578d17427fd22489b651b71292ad360eab23aa2842ec2807a26df20d4094d5ee15ad61e10315262b590659495ff266b4d5c15858a56bbbd1f8da3e5775b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3bc3ab23145a1bd52bd7c6669ac67b3afdab3e48ddc4142268d28ae5ff1554652250697219d8b0da473cf2eca97af25d3e4dea5bd9b341ab63d7cdd9fb03d7"} 03:13:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:13:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:13:15 INFO - Contents: 03:13:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/363fb0ca8f6cd9f6b48afc61091c60b0635adaafd4aaac3c783da3637e6d06ba6b7e3f8dfb70e62629eef5fc3062a7d58a485355c1f271c4f53d2b1b4adb4643", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4cb1b93c5547705547c63d1985e1b2c3ce6f10513bd57dc0b7faeec4f4d9504bfa0d3255b874477dc6e2651eeea868452ac529079bd26eb88f10709bfe4a99a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17b9578d17427fd22489b651b71292ad360eab23aa2842ec2807a26df20d4094d5ee15ad61e10315262b590659495ff266b4d5c15858a56bbbd1f8da3e5775b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3bc3ab23145a1bd52bd7c6669ac67b3afdab3e48ddc4142268d28ae5ff1554652250697219d8b0da473cf2eca97af25d3e4dea5bd9b341ab63d7cdd9fb03d7"} 03:13:15 INFO - Running post-run listener: copy_logs_to_upload_dir 03:13:15 INFO - Copying logs to upload dir... 03:13:15 INFO - mkdir: /builds/slave/test/build/upload/logs 03:13:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1292.103913 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2017-02-21 03:13:15.964062) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-21 03:13:15.970000) ========= 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.rbYB18OF7y/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.Fy0rq3Tmnd/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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/363fb0ca8f6cd9f6b48afc61091c60b0635adaafd4aaac3c783da3637e6d06ba6b7e3f8dfb70e62629eef5fc3062a7d58a485355c1f271c4f53d2b1b4adb4643", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4cb1b93c5547705547c63d1985e1b2c3ce6f10513bd57dc0b7faeec4f4d9504bfa0d3255b874477dc6e2651eeea868452ac529079bd26eb88f10709bfe4a99a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17b9578d17427fd22489b651b71292ad360eab23aa2842ec2807a26df20d4094d5ee15ad61e10315262b590659495ff266b4d5c15858a56bbbd1f8da3e5775b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3bc3ab23145a1bd52bd7c6669ac67b3afdab3e48ddc4142268d28ae5ff1554652250697219d8b0da473cf2eca97af25d3e4dea5bd9b341ab63d7cdd9fb03d7"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011468 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1487085285/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/363fb0ca8f6cd9f6b48afc61091c60b0635adaafd4aaac3c783da3637e6d06ba6b7e3f8dfb70e62629eef5fc3062a7d58a485355c1f271c4f53d2b1b4adb4643", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4cb1b93c5547705547c63d1985e1b2c3ce6f10513bd57dc0b7faeec4f4d9504bfa0d3255b874477dc6e2651eeea868452ac529079bd26eb88f10709bfe4a99a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17b9578d17427fd22489b651b71292ad360eab23aa2842ec2807a26df20d4094d5ee15ad61e10315262b590659495ff266b4d5c15858a56bbbd1f8da3e5775b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3bc3ab23145a1bd52bd7c6669ac67b3afdab3e48ddc4142268d28ae5ff1554652250697219d8b0da473cf2eca97af25d3e4dea5bd9b341ab63d7cdd9fb03d7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-21 03:13:16.005803) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 03:13:16.006114) ========= 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.rbYB18OF7y/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.Fy0rq3Tmnd/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.005283 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 03:13:16.054536) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-21 03:13:16.054843) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-21 03:13:16.055153) ========= ========= Total master_lag: 0.22 =========