builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0378 starttime: 1492517565.27 results: success (0) buildid: 20170418030220 builduid: 56e9293c91ec40e8837adfe7d092657e revision: bb38d935d699e0529f9e0bb35578d381026415c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:45.274722) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:45.275220) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:45.275516) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:45.373631) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:45.373882) ========= 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.h5XtUHtnzu/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.GZJat8tUn0/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-18 05:12:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.3M=0.001s 2017-04-18 05:12:45 (18.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.169136 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:45.568549) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:45.569092) ========= 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.h5XtUHtnzu/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.GZJat8tUn0/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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.026086 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:45.618415) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-18 05:12:45.618767) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bb38d935d699e0529f9e0bb35578d381026415c4 --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 bb38d935d699e0529f9e0bb35578d381026415c4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.h5XtUHtnzu/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.GZJat8tUn0/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-18 05:12:45,728 truncating revision to first 12 chars 2017-04-18 05:12:45,728 Setting DEBUG logging. 2017-04-18 05:12:45,729 attempt 1/10 2017-04-18 05:12:45,729 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bb38d935d699?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-18 05:12:46,916 unpacking tar archive at: mozilla-central-bb38d935d699/testing/mozharness/ program finished with exit code 0 elapsedTime=1.473160 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-18 05:12:47.116349) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:47.116833) ========= script_repo_revision: bb38d935d699e0529f9e0bb35578d381026415c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:47.117450) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:47.117935) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 05:12:47.139168) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-04-18 05:12:47.139689) ========= /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.h5XtUHtnzu/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.GZJat8tUn0/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:12:47 INFO - MultiFileLogger online at 20170418 05:12:47 in /builds/slave/test 05:12:47 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 05:12:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:12:47 INFO - {'append_to_log': False, 05:12:47 INFO - 'base_work_dir': '/builds/slave/test', 05:12:47 INFO - 'blob_upload_branch': 'Firefox', 05:12:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:12:47 INFO - 'branch': 'Firefox', 05:12:47 INFO - 'buildbot_json_path': 'buildprops.json', 05:12:47 INFO - 'config_files': ('talos/mac_config.py',), 05:12:47 INFO - 'default_actions': ('clobber', 05:12:47 INFO - 'read-buildbot-config', 05:12:47 INFO - 'download-and-extract', 05:12:47 INFO - 'populate-webroot', 05:12:47 INFO - 'create-virtualenv', 05:12:47 INFO - 'install', 05:12:47 INFO - 'run-tests'), 05:12:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:12:47 INFO - 'download_minidump_stackwalk': True, 05:12:47 INFO - 'download_symbols': 'ondemand', 05:12:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:12:47 INFO - 'tooltool.py': '/tools/tooltool.py', 05:12:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:12:47 INFO - '/tools/misc-python/virtualenv.py')}, 05:12:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:12:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:12:47 INFO - 'gecko_profile': False, 05:12:47 INFO - 'gecko_profile_interval': 0, 05:12:47 INFO - 'installer_path': 'installer.exe', 05:12:47 INFO - 'log_level': 'info', 05:12:47 INFO - 'log_name': 'talos', 05:12:47 INFO - 'log_to_console': True, 05:12:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:12:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:12:47 INFO - 'opt_config_files': (), 05:12:47 INFO - 'pip_index': False, 05:12:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:12:47 INFO - 'cmd': ('bash', 05:12:47 INFO - '-c', 05:12:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:12:47 INFO - 'enabled': True, 05:12:47 INFO - 'halt_on_failure': False, 05:12:47 INFO - 'name': 'check_screen_resolution'},), 05:12:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:12:47 INFO - 'cmd': ('bash', 05:12:47 INFO - '-c', 05:12:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:12:47 INFO - 'enabled': True, 05:12:47 INFO - 'halt_on_failure': False, 05:12:47 INFO - 'name': 'check_screen_resolution'},), 05:12:47 INFO - 'run_cmd_checks_enabled': True, 05:12:47 INFO - 'suite': 'dromaeojs', 05:12:47 INFO - 'system_bits': '32', 05:12:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:12:47 INFO - 'title': 't-yosemite-r7-0378', 05:12:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:12:47 INFO - 'use_talos_json': True, 05:12:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:12:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:12:47 INFO - 'work_dir': 'build'} 05:12:47 INFO - [mozharness: 2017-04-18 12:12:47.352611Z] Running clobber step. 05:12:47 INFO - Running pre-action listener: _resource_record_pre_action 05:12:47 INFO - Running main action method: clobber 05:12:47 INFO - rmtree: /builds/slave/test/build 05:12:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:12:49 INFO - Running post-action listener: _resource_record_post_action 05:12:49 INFO - [mozharness: 2017-04-18 12:12:49.933544Z] Finished clobber step (success) 05:12:49 INFO - [mozharness: 2017-04-18 12:12:49.933760Z] Running read-buildbot-config step. 05:12:49 INFO - Running pre-action listener: _resource_record_pre_action 05:12:49 INFO - Running main action method: read_buildbot_config 05:12:49 INFO - Using buildbot properties: 05:12:49 INFO - { 05:12:49 INFO - "project": "", 05:12:49 INFO - "product": "firefox", 05:12:49 INFO - "script_repo_revision": "production", 05:12:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:12:49 INFO - "repository": "", 05:12:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:12:49 INFO - "buildid": "20170418030220", 05:12:49 INFO - "stage_platform": "macosx64", 05:12:49 INFO - "basedir": "/builds/slave/test", 05:12:49 INFO - "nightly_build": "True", 05:12:49 INFO - "buildnumber": 18, 05:12:49 INFO - "slavename": "t-yosemite-r7-0378", 05:12:49 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:12:49 INFO - "platform": "yosemite_r7", 05:12:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:12:49 INFO - "branch": "mozilla-central", 05:12:49 INFO - "repo_path": "mozilla-central", 05:12:49 INFO - "revision": "bb38d935d699e0529f9e0bb35578d381026415c4", 05:12:49 INFO - "pgo_build": "False", 05:12:49 INFO - "builduid": "56e9293c91ec40e8837adfe7d092657e", 05:12:49 INFO - "slavebuilddir": "test" 05:12:49 INFO - } 05:12:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 05:12:49 INFO - Running post-action listener: _resource_record_post_action 05:12:49 INFO - [mozharness: 2017-04-18 12:12:49.939855Z] Finished read-buildbot-config step (success) 05:12:49 INFO - [mozharness: 2017-04-18 12:12:49.940097Z] Running download-and-extract step. 05:12:49 INFO - Running pre-action listener: _resource_record_pre_action 05:12:49 INFO - Running main action method: download_and_extract 05:12:49 INFO - mkdir: /builds/slave/test/build/tests 05:12:49 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')]} 05:12:49 INFO - trying https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 05:12:49 INFO - Downloading https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:12:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 05:12:51 INFO - Downloaded 1325 bytes. 05:12:51 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:12:51 INFO - Using the following test package requirements: 05:12:51 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:51 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 05:12:51 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:12:51 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:51 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 05:12:51 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:51 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 05:12:51 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:51 INFO - u'jsshell-mac.zip'], 05:12:51 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:51 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 05:12:51 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:12:51 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:51 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 05:12:51 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:51 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 05:12:51 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:51 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 05:12:51 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:12:51 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 05:12:51 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:12:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:12:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:12:51 INFO - Fetch https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:12:53 INFO - Expected file size: 52629179 05:12:53 INFO - Obtained file size: 52629179 05:13:09 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:13:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:13:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:13:09 INFO - Fetch https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:13:11 INFO - Expected file size: 52629179 05:13:11 INFO - Obtained file size: 52629179 05:13:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 05:13:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:13:26 INFO - Fetch https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 05:13:27 INFO - Expected file size: 14408802 05:13:27 INFO - Obtained file size: 14408802 05:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:13:28 INFO - trying https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:13:28 INFO - Downloading https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 05:13:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 05:13:31 INFO - Downloaded 71438005 bytes. 05:13:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:13:31 INFO - mkdir: /builds/slave/test/properties 05:13:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:13:31 INFO - Writing to file /builds/slave/test/properties/build_url 05:13:31 INFO - Contents: 05:13:31 INFO - build_url:https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:13:31 INFO - Running post-action listener: _resource_record_post_action 05:13:31 INFO - Running post-action listener: set_extra_try_arguments 05:13:31 INFO - [mozharness: 2017-04-18 12:13:31.958876Z] Finished download-and-extract step (success) 05:13:31 INFO - [mozharness: 2017-04-18 12:13:31.959002Z] Running populate-webroot step. 05:13:31 INFO - Running pre-action listener: _resource_record_pre_action 05:13:31 INFO - Running main action method: populate_webroot 05:13:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:13:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:13:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:13:31 INFO - '--tppagecycles', 05:13:31 INFO - '7'], 05:13:31 INFO - 'tests': ['tsvgm']}}, 05:13:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:13:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:13:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:13:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:13:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:13:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:13:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:13:31 INFO - 'talos_options': ['--disable-e10s'], 05:13:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:13:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:13:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:13:31 INFO - 'talos_options': ['--disable-e10s'], 05:13:31 INFO - 'tests': ['damp', 'tps']}, 05:13:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:13:31 INFO - 'tests': ['damp', 'tps']}, 05:13:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:13:31 INFO - 'tests': ['dromaeo_dom']}, 05:13:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:13:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:13:31 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:13:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:13:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:13:31 INFO - 'tests': ['a11yr', 05:13:31 INFO - 'ts_paint', 05:13:31 INFO - 'tpaint', 05:13:31 INFO - 'sessionrestore', 05:13:31 INFO - 'sessionrestore_no_auto_restore', 05:13:31 INFO - 'tabpaint']}, 05:13:31 INFO - 'other-e10s': {'tests': ['a11yr', 05:13:31 INFO - 'ts_paint', 05:13:31 INFO - 'tpaint', 05:13:31 INFO - 'sessionrestore', 05:13:31 INFO - 'sessionrestore_no_auto_restore', 05:13:31 INFO - 'tabpaint']}, 05:13:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:13:31 INFO - 'ts_paint', 05:13:31 INFO - 'tpaint', 05:13:31 INFO - 'sessionrestore', 05:13:31 INFO - 'sessionrestore_no_auto_restore', 05:13:31 INFO - 'tabpaint']}, 05:13:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:13:31 INFO - 'ts_paint', 05:13:31 INFO - 'tpaint', 05:13:31 INFO - 'sessionrestore', 05:13:31 INFO - 'sessionrestore_no_auto_restore', 05:13:31 INFO - 'tabpaint']}, 05:13:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:13:31 INFO - 'tests': ['a11yr', 05:13:31 INFO - 'ts_paint', 05:13:31 INFO - 'tpaint', 05:13:31 INFO - 'sessionrestore', 05:13:31 INFO - 'sessionrestore_no_auto_restore', 05:13:31 INFO - 'tabpaint']}, 05:13:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:13:31 INFO - 'tests': ['a11yr', 05:13:31 INFO - 'ts_paint', 05:13:31 INFO - 'tpaint', 05:13:31 INFO - 'sessionrestore', 05:13:31 INFO - 'sessionrestore_no_auto_restore', 05:13:31 INFO - 'tabpaint']}, 05:13:31 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:13:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:13:31 INFO - 'bloom_basic_ref']}, 05:13:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:13:31 INFO - 'tests': ['tsvgx', 05:13:31 INFO - 'tsvgr_opacity', 05:13:31 INFO - 'tart', 05:13:31 INFO - 'tscrollx', 05:13:31 INFO - 'cart', 05:13:31 INFO - 'tsvg_static']}, 05:13:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:13:31 INFO - 'tsvgr_opacity', 05:13:31 INFO - 'tart', 05:13:31 INFO - 'tscrollx', 05:13:31 INFO - 'cart', 05:13:31 INFO - 'tsvg_static']}, 05:13:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:13:31 INFO - 'talos_options': ['--disable-e10s'], 05:13:31 INFO - 'tests': ['tp5o']}, 05:13:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:13:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:13:31 INFO - 'talos_options': ['--disable-e10s', 05:13:31 INFO - '--xperf_path', 05:13:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:31 INFO - 'tests': ['tp5n']}, 05:13:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:13:31 INFO - 'talos_options': ['--xperf_path', 05:13:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:13:31 INFO - 'tests': ['tp5n']}}, 05:13:31 INFO - 'talos.zip': {'path': '', 05:13:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:13:31 INFO - Running post-action listener: _resource_record_post_action 05:13:31 INFO - [mozharness: 2017-04-18 12:13:31.978218Z] Finished populate-webroot step (success) 05:13:31 INFO - [mozharness: 2017-04-18 12:13:31.978351Z] Running create-virtualenv step. 05:13:31 INFO - Running pre-action listener: _resource_record_pre_action 05:13:31 INFO - Running main action method: create_virtualenv 05:13:31 INFO - Creating virtualenv /builds/slave/test/build/venv 05:13: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 05:13:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:13:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:13:32 INFO - Using real prefix '/tools/python27' 05:13:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:13:32 INFO - Installing distribute.............................................................................................................................................................................................done. 05:13:35 INFO - Installing pip.................done. 05:13:35 INFO - Return code: 0 05:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:13:35 INFO - Reading from file tmpfile_stdout 05:13:35 INFO - Output received: 05:13: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) 05:13:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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 0x104950b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104953768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8994c00c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10472ed30>, '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 0x104654db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104723be8>, '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.h5XtUHtnzu/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.GZJat8tUn0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:13: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 05:13: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 05:13:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h5XtUHtnzu/Render', 05:13:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:35 INFO - 'HOME': '/Users/cltbld', 05:13:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:35 INFO - 'LOGNAME': 'cltbld', 05:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:35 INFO - 'MOZ_NO_REMOTE': '1', 05:13:35 INFO - 'NO_EM_RESTART': '1', 05:13:35 INFO - 'PAGER': '/bin/cat', 05:13:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:35 INFO - 'PWD': '/builds/slave/test', 05:13:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:35 INFO - 'SHELL': '/bin/bash', 05:13:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZJat8tUn0/Listeners', 05:13:35 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:13:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:35 INFO - 'USER': 'cltbld', 05:13:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:35 INFO - 'XPC_FLAGS': '0x0', 05:13:35 INFO - 'XPC_SERVICE_NAME': '0', 05:13:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13: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 05:13:36 INFO - Cleaning up... 05:13:36 INFO - Return code: 0 05:13:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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 0x104950b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104953768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8994c00c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10472ed30>, '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 0x104654db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104723be8>, '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.h5XtUHtnzu/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.GZJat8tUn0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:13: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 05:13: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 05:13:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h5XtUHtnzu/Render', 05:13:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:36 INFO - 'HOME': '/Users/cltbld', 05:13:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:36 INFO - 'LOGNAME': 'cltbld', 05:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:36 INFO - 'MOZ_NO_REMOTE': '1', 05:13:36 INFO - 'NO_EM_RESTART': '1', 05:13:36 INFO - 'PAGER': '/bin/cat', 05:13:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:36 INFO - 'PWD': '/builds/slave/test', 05:13:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:36 INFO - 'SHELL': '/bin/bash', 05:13:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZJat8tUn0/Listeners', 05:13:36 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:13:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:36 INFO - 'USER': 'cltbld', 05:13:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:36 INFO - 'XPC_FLAGS': '0x0', 05:13:36 INFO - 'XPC_SERVICE_NAME': '0', 05:13:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:36 INFO - Downloading/unpacking psutil>=3.1.1 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:13:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:40 INFO - Installing collected packages: psutil 05:13:40 INFO - Running setup.py install for psutil 05:13:40 INFO - building 'psutil._psutil_osx' extension 05:13: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 05:13:41 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 05:13:41 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 05:13:41 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 05:13:41 INFO - building 'psutil._psutil_posix' extension 05:13:41 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 05:13:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:13:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:13:41 INFO - ^ 05:13:41 INFO - 1 warning generated. 05:13:41 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 05:13:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:41 INFO - Successfully installed psutil 05:13:41 INFO - Cleaning up... 05:13:41 INFO - Return code: 0 05:13:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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 0x104950b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104953768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8994c00c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10472ed30>, '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 0x104654db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104723be8>, '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.h5XtUHtnzu/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.GZJat8tUn0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:13: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 05:13: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 05:13:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h5XtUHtnzu/Render', 05:13:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:41 INFO - 'HOME': '/Users/cltbld', 05:13:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:41 INFO - 'LOGNAME': 'cltbld', 05:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:41 INFO - 'MOZ_NO_REMOTE': '1', 05:13:41 INFO - 'NO_EM_RESTART': '1', 05:13:41 INFO - 'PAGER': '/bin/cat', 05:13:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:41 INFO - 'PWD': '/builds/slave/test', 05:13:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:41 INFO - 'SHELL': '/bin/bash', 05:13:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZJat8tUn0/Listeners', 05:13:41 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:13:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:41 INFO - 'USER': 'cltbld', 05:13:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:41 INFO - 'XPC_FLAGS': '0x0', 05:13:41 INFO - 'XPC_SERVICE_NAME': '0', 05:13:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:13:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:13:44 INFO - Installing collected packages: mozsystemmonitor 05:13:44 INFO - Running setup.py install for mozsystemmonitor 05:13:44 INFO - Successfully installed mozsystemmonitor 05:13:44 INFO - Cleaning up... 05:13:44 INFO - Return code: 0 05:13:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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 0x104950b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104953768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8994c00c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10472ed30>, '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 0x104654db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104723be8>, '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.h5XtUHtnzu/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.GZJat8tUn0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:13: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 05:13: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 05:13:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h5XtUHtnzu/Render', 05:13:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:44 INFO - 'HOME': '/Users/cltbld', 05:13:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:44 INFO - 'LOGNAME': 'cltbld', 05:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:44 INFO - 'MOZ_NO_REMOTE': '1', 05:13:44 INFO - 'NO_EM_RESTART': '1', 05:13:44 INFO - 'PAGER': '/bin/cat', 05:13:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:44 INFO - 'PWD': '/builds/slave/test', 05:13:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:44 INFO - 'SHELL': '/bin/bash', 05:13:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZJat8tUn0/Listeners', 05:13:44 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:13:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:44 INFO - 'USER': 'cltbld', 05:13:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:44 INFO - 'XPC_FLAGS': '0x0', 05:13:44 INFO - 'XPC_SERVICE_NAME': '0', 05:13:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:45 INFO - Downloading/unpacking jsonschema==2.5.1 05:13:45 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 05:13:45 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 05:13:45 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 05:13:45 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 05:13:45 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 05:13:45 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 05:13:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:13:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13:48 INFO - Downloading functools32-3.2.3-2.tar.gz 05:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:13:48 INFO - warning: no files found matching '*.txt' 05:13:48 INFO - no previously-included directories found matching 'build' 05:13:48 INFO - no previously-included directories found matching 'dist' 05:13:48 INFO - no previously-included directories found matching '.git*' 05:13:48 INFO - Installing collected packages: jsonschema, functools32 05:13:48 INFO - Running setup.py install for functools32 05:13:48 INFO - warning: no files found matching '*.txt' 05:13:48 INFO - no previously-included directories found matching 'build' 05:13:48 INFO - no previously-included directories found matching 'dist' 05:13:48 INFO - no previously-included directories found matching '.git*' 05:13:48 INFO - Successfully installed jsonschema functools32 05:13:48 INFO - Cleaning up... 05:13:48 INFO - Return code: 0 05:13:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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 0x104950b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104953768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8994c00c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10472ed30>, '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 0x104654db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104723be8>, '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.h5XtUHtnzu/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.GZJat8tUn0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:13: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 05:13: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 05:13:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h5XtUHtnzu/Render', 05:13:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:48 INFO - 'HOME': '/Users/cltbld', 05:13:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:48 INFO - 'LOGNAME': 'cltbld', 05:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:48 INFO - 'MOZ_NO_REMOTE': '1', 05:13:48 INFO - 'NO_EM_RESTART': '1', 05:13:48 INFO - 'PAGER': '/bin/cat', 05:13:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:48 INFO - 'PWD': '/builds/slave/test', 05:13:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:48 INFO - 'SHELL': '/bin/bash', 05:13:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZJat8tUn0/Listeners', 05:13:48 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:13:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:48 INFO - 'USER': 'cltbld', 05:13:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:48 INFO - 'XPC_FLAGS': '0x0', 05:13:48 INFO - 'XPC_SERVICE_NAME': '0', 05:13:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:13:48 INFO - Cleaning up... 05:13:48 INFO - Return code: 0 05:13:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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 0x104950b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104953768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8994c00c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10472ed30>, '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 0x104654db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104723be8>, '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.h5XtUHtnzu/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.GZJat8tUn0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:13: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 05:13: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 05:13:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h5XtUHtnzu/Render', 05:13:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:48 INFO - 'HOME': '/Users/cltbld', 05:13:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:48 INFO - 'LOGNAME': 'cltbld', 05:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:48 INFO - 'MOZ_NO_REMOTE': '1', 05:13:48 INFO - 'NO_EM_RESTART': '1', 05:13:48 INFO - 'PAGER': '/bin/cat', 05:13:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:48 INFO - 'PWD': '/builds/slave/test', 05:13:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:48 INFO - 'SHELL': '/bin/bash', 05:13:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZJat8tUn0/Listeners', 05:13:48 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:13:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:48 INFO - 'USER': 'cltbld', 05:13:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:48 INFO - 'XPC_FLAGS': '0x0', 05:13:48 INFO - 'XPC_SERVICE_NAME': '0', 05:13:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:13:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:13:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13:52 INFO - Downloading docopt-0.6.1.tar.gz 05:13:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:13:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:13:52 INFO - Running setup.py install for blobuploader 05:13:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:13:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:13:53 INFO - Running setup.py install for requests 05:13:53 INFO - Running setup.py install for docopt 05:13:53 INFO - Successfully installed blobuploader requests docopt 05:13:53 INFO - Cleaning up... 05:13:53 INFO - Return code: 0 05:13:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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 0x104950b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104953768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8994c00c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10472ed30>, '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 0x104654db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104723be8>, '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.h5XtUHtnzu/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.GZJat8tUn0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:13: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 05:13: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 05:13:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h5XtUHtnzu/Render', 05:13:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:53 INFO - 'HOME': '/Users/cltbld', 05:13:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:53 INFO - 'LOGNAME': 'cltbld', 05:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:53 INFO - 'MOZ_NO_REMOTE': '1', 05:13:53 INFO - 'NO_EM_RESTART': '1', 05:13:53 INFO - 'PAGER': '/bin/cat', 05:13:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:53 INFO - 'PWD': '/builds/slave/test', 05:13:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:53 INFO - 'SHELL': '/bin/bash', 05:13:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZJat8tUn0/Listeners', 05:13:53 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:13:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:53 INFO - 'USER': 'cltbld', 05:13:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:53 INFO - 'XPC_FLAGS': '0x0', 05:13:53 INFO - 'XPC_SERVICE_NAME': '0', 05:13:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:13:54 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-SDUVHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:13:54 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-mzEdIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:13:54 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-jXLH3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:13:54 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-h04AnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:13:54 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-SK3nt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:13:54 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-58Xyx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:13:54 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-Wfgb4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:13:54 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-HrHmtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:13:54 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-7SoxgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:13:54 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-jqnp_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:13:55 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-hShHz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:13:55 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-REMHZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:13:55 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-iSVwlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:13:55 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-tHZmrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:55 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-5Wl5XP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:13:55 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-pz9Smi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:13:55 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-BcPeC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:13:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:13:55 INFO - Running setup.py install for manifestparser 05:13:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:13:55 INFO - Running setup.py install for mozcrash 05:13:56 INFO - Running setup.py install for mozdebug 05:13:56 INFO - Running setup.py install for mozdevice 05:13:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:13:56 INFO - Running setup.py install for mozfile 05:13:56 INFO - Running setup.py install for mozhttpd 05:13:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:13:56 INFO - Running setup.py install for mozinfo 05:13:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:13:56 INFO - Running setup.py install for mozInstall 05:13:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:13:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:13:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:13:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:13:56 INFO - Running setup.py install for mozleak 05:13:57 INFO - Running setup.py install for mozlog 05:13:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:13:57 INFO - Running setup.py install for moznetwork 05:13:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:13:57 INFO - Running setup.py install for mozprocess 05:13:57 INFO - Running setup.py install for mozprofile 05:13:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:13:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:13:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:13:57 INFO - Running setup.py install for mozrunner 05:13:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:13:57 INFO - Running setup.py install for mozscreenshot 05:13:58 INFO - Running setup.py install for moztest 05:13:58 INFO - Running setup.py install for mozversion 05:13:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:13:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:13:58 INFO - Cleaning up... 05:13:58 INFO - Return code: 0 05:13:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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 0x104950b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104953768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8994c00c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10472ed30>, '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 0x104654db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104723be8>, '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.h5XtUHtnzu/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.GZJat8tUn0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:13: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 05:13: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 05:13:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h5XtUHtnzu/Render', 05:13:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:58 INFO - 'HOME': '/Users/cltbld', 05:13:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:58 INFO - 'LOGNAME': 'cltbld', 05:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:58 INFO - 'MOZ_NO_REMOTE': '1', 05:13:58 INFO - 'NO_EM_RESTART': '1', 05:13:58 INFO - 'PAGER': '/bin/cat', 05:13:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:58 INFO - 'PWD': '/builds/slave/test', 05:13:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:58 INFO - 'SHELL': '/bin/bash', 05:13:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZJat8tUn0/Listeners', 05:13:58 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:13:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:58 INFO - 'USER': 'cltbld', 05:13:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:58 INFO - 'XPC_FLAGS': '0x0', 05:13:58 INFO - 'XPC_SERVICE_NAME': '0', 05:13:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:13:58 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-JkTfiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:13: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)) 05:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:13:58 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-K0gNa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:13:58 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)) 05:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:13:58 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-sT1zYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:13:58 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)) 05:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:13:58 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-ZdOuqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:13:59 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-a7yzCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:13: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)) 05:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:13:59 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-sVHrAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:13: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)) 05:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:13:59 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-WQae2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:13: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)) 05:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:13:59 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-XCJijE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:13: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)) 05:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:13:59 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-SOSqvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:13: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)) 05:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:13:59 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-eR_PLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:13: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)) 05:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:13:59 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-q0S3Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:13:59 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)) 05:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:13:59 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-wrvfxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:13:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:13:59 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-8vCpN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14: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)) 05:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:00 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-YGt4zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14: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)) 05:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:00 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-2be5yZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14: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)) 05:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:00 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-zVhEmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14: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)) 05:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:00 INFO - Running setup.py (path:/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/pip-XXBUBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14: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)) 05:14: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)) 05:14: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)) 05:14: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)) 05:14: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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:14: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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:14:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:14:03 INFO - Downloading blessings-1.6.tar.gz 05:14:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:14:03 INFO - Installing collected packages: blessings 05:14:03 INFO - Running setup.py install for blessings 05:14:03 INFO - Successfully installed blessings 05:14:03 INFO - Cleaning up... 05:14:03 INFO - Return code: 0 05:14:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:14:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:03 INFO - Reading from file tmpfile_stdout 05:14:03 INFO - Current package versions: 05:14:03 INFO - blessings == 1.6 05:14:03 INFO - blobuploader == 1.2.4 05:14:03 INFO - docopt == 0.6.1 05:14:03 INFO - functools32 == 3.2.3-2 05:14:03 INFO - jsonschema == 2.5.1 05:14:03 INFO - manifestparser == 1.1 05:14:03 INFO - mozInstall == 1.12 05:14:03 INFO - mozcrash == 1.0 05:14:03 INFO - mozdebug == 0.1 05:14:03 INFO - mozdevice == 0.50 05:14:03 INFO - mozfile == 1.2 05:14:03 INFO - mozhttpd == 0.7 05:14:03 INFO - mozinfo == 0.9 05:14:03 INFO - mozleak == 0.1 05:14:03 INFO - mozlog == 3.4 05:14:03 INFO - moznetwork == 0.27 05:14:03 INFO - mozprocess == 0.25 05:14:03 INFO - mozprofile == 0.28 05:14:03 INFO - mozrunner == 6.13 05:14:03 INFO - mozscreenshot == 0.1 05:14:03 INFO - mozsystemmonitor == 0.3 05:14:03 INFO - moztest == 0.8 05:14:03 INFO - mozversion == 1.4 05:14:03 INFO - psutil == 3.1.1 05:14:03 INFO - requests == 1.2.3 05:14:03 INFO - wsgiref == 0.1.2 05:14:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14: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')]} 05:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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')]} 05:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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 0x104950b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104953768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8994c00c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10472ed30>, '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 0x104654db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104723be8>, '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.h5XtUHtnzu/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.GZJat8tUn0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:14: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 05:14: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 05:14:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h5XtUHtnzu/Render', 05:14:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:03 INFO - 'HOME': '/Users/cltbld', 05:14:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:03 INFO - 'LOGNAME': 'cltbld', 05:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:03 INFO - 'MOZ_NO_REMOTE': '1', 05:14:03 INFO - 'NO_EM_RESTART': '1', 05:14:03 INFO - 'PAGER': '/bin/cat', 05:14:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:03 INFO - 'PWD': '/builds/slave/test', 05:14:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:03 INFO - 'SHELL': '/bin/bash', 05:14:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZJat8tUn0/Listeners', 05:14:03 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:14:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:03 INFO - 'USER': 'cltbld', 05:14:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:03 INFO - 'XPC_FLAGS': '0x0', 05:14:03 INFO - 'XPC_SERVICE_NAME': '0', 05:14:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:03 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)) 05:14:03 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)) 05:14:03 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)) 05:14:03 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)) 05:14:03 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)) 05:14:03 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)) 05:14:03 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)) 05:14:03 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)) 05:14:03 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)) 05:14:03 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)) 05:14:03 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)) 05:14:03 INFO - Cleaning up... 05:14:04 INFO - Return code: 0 05:14:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:14: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')]} 05:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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')]} 05:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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 0x104950b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104953768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8994c00c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10472ed30>, '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 0x104654db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104723be8>, '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.h5XtUHtnzu/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.GZJat8tUn0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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 05:14: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 05:14: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 05:14:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h5XtUHtnzu/Render', 05:14:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:04 INFO - 'HOME': '/Users/cltbld', 05:14:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:04 INFO - 'LOGNAME': 'cltbld', 05:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:04 INFO - 'MOZ_NO_REMOTE': '1', 05:14:04 INFO - 'NO_EM_RESTART': '1', 05:14:04 INFO - 'PAGER': '/bin/cat', 05:14:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:04 INFO - 'PWD': '/builds/slave/test', 05:14:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:04 INFO - 'SHELL': '/bin/bash', 05:14:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZJat8tUn0/Listeners', 05:14:04 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:14:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:04 INFO - 'USER': 'cltbld', 05:14:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:04 INFO - 'XPC_FLAGS': '0x0', 05:14:04 INFO - 'XPC_SERVICE_NAME': '0', 05:14:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:14:04 INFO - Cleaning up... 05:14:04 INFO - Return code: 0 05:14:04 INFO - Running post-action listener: _resource_record_post_action 05:14:04 INFO - Running post-action listener: _start_resource_monitoring 05:14:04 INFO - Starting resource monitoring. 05:14:04 INFO - [mozharness: 2017-04-18 12:14:04.302325Z] Finished create-virtualenv step (success) 05:14:04 INFO - [mozharness: 2017-04-18 12:14:04.303291Z] Running install step. 05:14:04 INFO - Running pre-action listener: _resource_record_pre_action 05:14:04 INFO - Running main action method: install 05:14:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:04 INFO - Reading from file tmpfile_stdout 05:14:04 INFO - Detecting whether we're running mozinstall >=1.0... 05:14:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:14:04 INFO - Reading from file tmpfile_stdout 05:14:04 INFO - Output received: 05:14:04 INFO - Usage: mozinstall [options] installer 05:14:04 INFO - Options: 05:14:04 INFO - -h, --help show this help message and exit 05:14:04 INFO - -d DEST, --destination=DEST 05:14:04 INFO - Directory to install application into. [default: 05:14:04 INFO - "/builds/slave/test"] 05:14:04 INFO - --app=APP Application being installed. [default: firefox] 05:14:04 INFO - mkdir: /builds/slave/test/build/application 05:14:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:14:24 INFO - Reading from file tmpfile_stdout 05:14:24 INFO - Output received: 05:14:24 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:14:24 INFO - Running post-action listener: _resource_record_post_action 05:14:24 INFO - [mozharness: 2017-04-18 12:14:24.435133Z] Finished install step (success) 05:14:24 INFO - [mozharness: 2017-04-18 12:14:24.435280Z] Running run-tests step. 05:14:24 INFO - Running pre-action listener: _resource_record_pre_action 05:14:24 INFO - Running main action method: run_tests 05:14:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:14:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:14:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:14:24 INFO - 2017-04-18 05:14:24.449 screenresolution[1630:8100] starting screenresolution argv=screenresolution get 05:14:24 INFO - 2017-04-18 05:14:24.452 screenresolution[1630:8100] Display 0: 1600x1200x32@60 05:14:24 INFO - 2017-04-18 05:14:24.458 screenresolution[1631:8103] starting screenresolution argv=screenresolution list 05:14:24 INFO - Available Modes on Display 0 05:14:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:14:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:14:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:14:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:14:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:14:24 INFO - Intel Iris: 05:14:24 INFO - Chipset Model: Intel Iris 05:14:24 INFO - Type: GPU 05:14:24 INFO - Bus: Built-In 05:14:24 INFO - VRAM (Dynamic, Max): 1536 MB 05:14:24 INFO - Vendor: Intel (0x8086) 05:14:24 INFO - Device ID: 0x0a2e 05:14:24 INFO - Revision ID: 0x0009 05:14:24 INFO - Displays: 05:14:24 INFO - Display: 05:14:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:14:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:14:24 INFO - Display Serial Number: 1600x1200 60 05:14:24 INFO - Main Display: Yes 05:14:24 INFO - Mirror: Off 05:14:24 INFO - Online: Yes 05:14:24 INFO - Rotation: Supported 05:14:24 INFO - Return code: 0 05:14:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:14:24 INFO - Python 2.7.3 05:14:24 INFO - Return code: 0 05:14:24 INFO - grabbing minidump binary from tooltool 05:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:24 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 0x10472ed30>, '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 0x104654db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104723be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:14:24 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 05:14:24 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 05:14:24 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 05:14:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:14:24 INFO - Return code: 0 05:14:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:14:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:14:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:14:24 INFO - ENV: RUST_BACKTRACE is now 1 05:14:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:14:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:14:24 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0378', '--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 05:14:24 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0378 --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 05:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.h5XtUHtnzu/Render', 05:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:24 INFO - 'HOME': '/Users/cltbld', 05:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:24 INFO - 'LOGNAME': 'cltbld', 05:14:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:14:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:24 INFO - 'MOZ_NO_REMOTE': '1', 05:14:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:14:24 INFO - 'NO_EM_RESTART': '1', 05:14:24 INFO - 'PAGER': '/bin/cat', 05:14:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:24 INFO - 'PWD': '/builds/slave/test', 05:14:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:24 INFO - 'RUST_BACKTRACE': '1', 05:14:24 INFO - 'SHELL': '/bin/bash', 05:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GZJat8tUn0/Listeners', 05:14:24 INFO - 'TMPDIR': '/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/', 05:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:24 INFO - 'USER': 'cltbld', 05:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:24 INFO - 'XPC_FLAGS': '0x0', 05:14:24 INFO - 'XPC_SERVICE_NAME': '0', 05:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:24 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0378', '--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 05:14:25 INFO - mozversion application_buildid: 20170418030220 05:14:25 INFO - mozversion application_changeset: bb38d935d699e0529f9e0bb35578d381026415c4 05:14:25 INFO - mozversion application_display_name: Nightly 05:14:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:14:25 INFO - mozversion application_name: Firefox 05:14:25 INFO - mozversion application_remotingname: firefox 05:14:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:14:25 INFO - mozversion application_vendor: Mozilla 05:14:25 INFO - mozversion application_version: 55.0a1 05:14:25 INFO - mozversion platform_buildid: 20170418030220 05:14:25 INFO - mozversion platform_changeset: bb38d935d699e0529f9e0bb35578d381026415c4 05:14:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:14:25 INFO - mozversion platform_version: 55.0a1 05:14:25 INFO - using testdate: 1492517665 05:14:25 INFO - actual date: 1492517665 05:14:25 INFO - starting webserver on 'localhost:49235' 05:14:25 INFO - SUITE-START | Running 2 tests 05:14:25 INFO - TEST-START | dromaeo_css 05:14:25 INFO - operating with platform_type : mac_ 05:14:25 INFO - Initialising browser for dromaeo_css test... 05:14:25 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/tmpXNxt3a/profile http://localhost:49235/getInfo.html) 05:14:27 INFO - PID 1641 | __metrics Screen width/height:1600/1200 05:14:27 INFO - PID 1641 | colorDepth:24 05:14:27 INFO - PID 1641 | Browser inner width/height: 1024/689 05:14:27 INFO - PID 1641 | __metrics 05:14:28 INFO - PID 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:14:28 INFO - PID 1641 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:14:28 INFO - TEST-INFO | 1641: exit 0 05:14:28 INFO - Browser initialized. 05:14:28 INFO - Running cycle 1/1 for dromaeo_css test... 05:14:28 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/tmpXNxt3a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:14:41 INFO - PID 1646 | RSS: Main: 258338816 05:14:41 INFO - PID 1646 | 05:17:46 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 05:17:47 INFO - PID 1646 | RSS: Main: 397144064 05:17:47 INFO - PID 1646 | 05:19:30 INFO - PID 1646 | ************************* 05:19:30 INFO - PID 1646 | A coding exception was thrown and uncaught in a Task. 05:19:30 INFO - PID 1646 | 05:19:30 ERROR - PID 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:19:30 INFO - PID 1646 | Full stack: 05:19:30 INFO - PID 1646 | ************************* 05:19:30 INFO - PID 1646 | ************************* 05:19:30 INFO - PID 1646 | A coding exception was thrown and uncaught in a Task. 05:19:30 INFO - PID 1646 | 05:19:30 ERROR - PID 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:19:30 INFO - PID 1646 | Full stack: 05:19:30 INFO - PID 1646 | ************************* 05:19:30 INFO - PID 1646 | ************************* 05:19:30 INFO - PID 1646 | A coding exception was thrown and uncaught in a Task. 05:19:30 INFO - PID 1646 | 05:19:30 ERROR - PID 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:19:30 INFO - PID 1646 | Full stack: 05:19:30 INFO - PID 1646 | ************************* 05:19:30 INFO - PID 1646 | ************************* 05:19:30 INFO - PID 1646 | A coding exception was thrown and uncaught in a Task. 05:19:30 INFO - PID 1646 | 05:19:30 ERROR - PID 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:19:30 INFO - PID 1646 | Full stack: 05:19:30 INFO - PID 1646 | ************************* 05:20:50 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 05:20:51 INFO - PID 1646 | RSS: Main: 384880640 05:20:51 INFO - PID 1646 | 05:23:53 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 05:23:54 INFO - PID 1646 | RSS: Main: 350662656 05:23:54 INFO - PID 1646 | 05:26:56 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 05:26:57 INFO - PID 1646 | RSS: Main: 374673408 05:26:57 INFO - PID 1646 | 05:30:00 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 05:30:01 INFO - PID 1646 | RSS: Main: 339148800 05:30:01 INFO - PID 1646 | 05:33:03 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 05:33:03 INFO - PID 1646 | RSS: Main: 389758976 05:33:03 INFO - PID 1646 | 05:33:03 INFO - PID 1646 | __start_tp_report 05:33:03 INFO - PID 1646 | _x_x_mozilla_page_load 05:33:03 INFO - PID 1646 | _x_x_mozilla_page_load_details 05:33:03 INFO - PID 1646 | |i|pagename|runs| 05:33:03 INFO - PID 1646 | |0;dojo.html;3449.172198672318;3452.413089774738;3470.132466883279;3495.528103706002;3512.192195794967;5884.735186916589;6031.87936241276;6077.301110372308;6095.664738439384;6114.785982490614;5999.67001814899;6111.205543279379;6124.717717612933;6131.08033794931;6148.292946311176;5178.792848286064;5220.190870415092;5256.316678831747;5308.309919710432;5336.59975501837;5140.5373516383515;5246.9768395162955;5288.286081379003;5302.973485132569;5351.17056856186;5205.349331333602;5237.685738855643;5318.813841515567;5326.866828329284;5338.946610533883;5191.792328306863;5223.112070947948;5268.683878967274;5273.367195936474;5312.787488500456;5251.10731175701;5252.65857719247;5275.393329767087;5278.683279003272;5302.840914772524;5812.767489300423;5925.022371308729;5960.344362120163;6092.66490343031;6121.66330851803;6309.0536419536975;6380.011098279774;6382.6170429774365;6384.968075159594;6387.457066149383;6429;6430.839229019265;6433.9678301608665;6439.678016099177;6449.709763060673;5952.077427998667;6015.368386319461;6134.539909506805;6142.01727723571;6166.568340216187;5349.946500535023;6222.81331560054;6264.906026409608;6315.463185629181;6320.810375688737;6323.588966717149;6340.080688300263;6351.047342898602;6356.77751278703;6357.968210159012;6358.841028974312;6364.459020983269;6397.136386587844;6419;6423.839404014937;5383.407825139231;6296.590721603081;6302.432781049636;6365;6398.456131228898;6359.904601430982;6367.713452894631;6389.265234498;6391.169148010822;6413.967930160413;5199.428062913076;5204.713740744295;5219.0083884061905;5223.817166399158;5253.1857562077175;4018.015586181346;4610.4697959734385;4618.237990731559;4657.4876763555985;4699.130660827758;6122.571420000557;6155.35368786271;6170.81487555374;6188.412100850412;6196.597221180609;6500.057491663682;6512.706928188243;6526.184226971629;6531.477481801539;6536.477081833537;5941.197938278364;6148.354422785633;6148.631082135086;6149.7847575335545;6155.6614386209185;5656.773729050874;5680.289963754531;5719.342275638355;5790.478856902899;5804.187413762077;6587.176602924635;6611.570247933869;6655.367740064686;6668.466522678077;6668.766593169215;6282.120503129474;6346.492280617447;6356.237251529846;6431.067495213261;6433.228012638513;6628.5691430056895;6643.667816609053;6650.068990341259;6659;6692.096566963398;6265.4361107500545;6286.402791734778;6373.139626150596;6374.362563743589;6384.872302554016;6331.588446750947;6430.292667806444;6449.451796597342;6454.0641606967665;6463.870722585428;6257.5932564383165;6272.121902933502;6315.431611155018;6316.210473690789;6343.365663433619;6170.197874276495;6264.937350626617;6355;6367.076773867856;6385.45723613498;6230;6280.277768056732;6292.2449306081735;6296.275928268308;6303.086052522451;6219.378062193744;6312.3056463788025;6317.652529110943;6330.588511746721;6337.366263373626;6070.544709146743;6112.17485639433;6262.937370626236;6270.090836828543;6296.590721603081 05:33:03 INFO - PID 1646 | |1;ext.html;772.3666593393419;804.3364224514775;823.9299659528941;1129.4860838318566;1160.628598848369;27720.02979895704;31051;37312.62687373126;37440;37952.62047379525;40090.59909400905;40328.19343613126;40416.79791601045;40425;40438.59561404385;6169.383061693839;8480.575971201431;8648.567571621425;8650.43772154811;8653.004904435977;6171.598846075013;8450.32397408209;8624.18070283322;8629.007664118644;8644.956775216115;8640.438371505863;8671.262942649882;8680.56597170139;8684.348673849487;8684.392092553524;8576.356773242002;8600.010998735163;8631.913680863237;8644.913550864474;8645.178708022728;8422;8488.618012189467;8491.490510569385;8498.575071246474;8499.490030598185;37814.62185378166;37987.05032374185;38030.42954355687;38058.24271966004;38097.61902380968;3579.2125732338845;3610.2418492116685;3611.747177697562;3616.0959760059986;3623.0942264433893;30734.538981915288;30837.38325233483;30875;30885.38229235403;30906.845465772753;3100.333428312901;3139.4192074466296;3147.3233254850315;3158;3170.2708377073404;279651;283961;284624;284861.9999999979;285509;49185.26222106671;49269.26096108561;49273;49300.50699493031;49321.260181097314;52528.74712528716;52594.47405525972;52670.20994685083;52696.73651631794;52747;14497.637559061108;14620.195889225983;14621.488247911271;14632;14657.413703451955;10194.796104077877;10306.896931030744;11868.406579670982;11874.584389546497;11879.406029698654;10939.23425360233;11028.613998510174;11046.834297485544;11049.17131215162;11058.336499810037;4750.904981900412;5354.571634269249;5516.448355164452;5520.861978450491;5550.639208451437;1035.471909326249;1040.375774535288;1045.1273186889032;1066.5200659703164;1074.1031238915593;22742.545149096924;23299.883500582728;24513;24518.896649650807;24585.262442126765;986.3637953520083;1121.030308782897;1132.592266783957;1167.2121318110412;1182.804837201852;12483.375831208403;12525.56160534377;12537.686557836127;12552.560660376843;12592.181508201938;320431;320690;320708;320757;321153.394233032;41049.38425923613;54839.72580137153;54848;54881.90236195254;54900;1508.6605513759316;1512.4328376858457;1561.7266978278756;1564.5541020809242;1574.3781206423398;22310.88844555767;23861;24003.879980600683;24047.2345680242;24092.277231683078;32443.513347300282;38489.615103848606;38527;38527.229455410175;38553.614463855;287910;288277.5586122056;288498;288844;288976;34680;35136.82431587826;35501.82249088738;35567;35622.82188589144;38090.61909380871;38766.80616596899;38839.2232155361;46308.30537541872;46380.76809616065;28731;28856.855715721285;29651.703482964895;30637.846810765805;30873.691263087083;30424.543631845983;30943.91696290619;31060.844695776377;31520.84239578879;31536.89620863259;37032;37116.072098197765;37501;37620.29572232172;37726.679566216146;21047.57904841864;26523.734762652897;30651.927182548505;31380.843095784374;31529.842350788098;22235.444113896636;23574.29277121689;24379.885149147103;24554.75445245596;25252.62121068222 05:33:03 INFO - PID 1646 | |2;jquery.html;342.65220800887096;354.2472246476238;430.19124046792024;437.3221506664669;449.4988088281567;20874.95625218739;21664.783352166472;21743.130274789008;21944.561108777816;22894.65658015131;22750.88624556879;22864;23124.768752312473;23142.30573082806;23626.409339766473;6177.258728952532;6267.122602835618;6480.254770701359;6485.513586481009;6489.740410383579;6257.061440783873;6304.211973503312;6363.204599425072;6385.489160867142;6390.520710946675;6002.699865006754;6232.283287421937;6250.218722659668;6286.308506064329;6308.9684551577175;6264.561480696353;6277.027060805583;6330.746770129213;6376;6379.202599675041;5632.211490391349;5686.090225563931;5692.658440493542;5703.116017017369;5703.429657034305;26160.607590886153;27282.727172728217;27586.862065689544;27968.503937007874;28327.85836070827;2151.236311109549;2195.7584665686763;2199.604071267171;2200.6698995150696;2204.0522575292616;16910.661786764194;17499.212535435938;17788.288468461375;17926.641467170582;18043.819561804346;2083.0834432849497;2101.915923363079;2154.396768904709;2154.7198864147563;2164.512984578473;150692.2465387677;153363;156331;157685;159289.20355398266;10178;10203.846942295871;11723.296602203895;11998.460069296903;12429.378531073591;14387.273527176596;16693.165341732863;16725.16374181286;16763.49709508717;16832;8631.223189912938;8986.68546600866;8991.055939126429;9131.77170570741;9171.77070573241;6561.573497722633;7953.2842044216295;8509.531975741394;8563.571821408905;8721.127887211354;7172.641367931687;7915.960420197977;7949.085855126619;7955.681772729026;7966.203379661987;2125.4261349435565;2129.2973318804757;2130.254410956153;2138.518833262535;2230.364346161336;943.8820147481565;946.1644409844879;948.4072454715803;986.8174387738292;989.42118860466;19507;19805.801941980397;20194.79805201929;20213.898930505547;20224.494387640425;973.4256788494822;997.3543652972653;1000.7948370584159;1003.5634498992962;1007.8253501470426;10193;10279.897201028043;10641.840372394421;10662.360258384522;10682.359058456517;557980;562864;566142;585627;586540.8748431338;102218.48890755499;114814;115537;125932;127983.36008319899;1147.300146910384;1150.1776229995594;1175.9470823812949;1181.6927598824195;1184.135581025856;17575.121243938007;18050;20969.580608388052;22962.19632312861;23098.307050788502;59928.801423972145;60383.69808150931;60557.69721151366;60821.695891520256;61478.770424592156;70089;75597.62201188959;76971;77353;79310;8749.16882896124;8880.333974952033;8956.955215223883;9008.504532250789;9408.29437792182;14310.713785724436;14647.26763661834;14830.961832672041;15046.54860354191;15146.01550899188;12084.939575302067;12090.75818483643;12252.264864108181;12414.751704966031;12493.18794278369;11591.072714182677;11693.123015774021;11706;11722.003629691571;12034.819477707666;11908.76182476363;12250.877491224974;12305.323207223688;12414.81377779352;12648.177868438523;8940.73177804667;9061.275097992277;9151.725448236564;9187.03536128697;9194.356395052282;10032.598696052368;11812.173147879566;11855.881441185478;12051.57819476314;12254.509819607116 05:33:03 INFO - PID 1646 | |3;mootools.html;1094.3707368263251;1111.0833562311093;1114.0753174864863;1181.7990941539938;1207.9551188222188;9877.160441362485;10367.06696397324;11776.234544754596;12092.939535302334;12097.334646594456;11663.241889277191;11762.411879406038;11766.176367654247;11776.175667703264;11789.233699809507;2503.7621425964503;2552.52778236026;2554.463562651845;2561.602951542505;2561.6669832921693;2144.335256070623;2239.5744808486415;2239.9216027439043;2240.3838944290287;2240.8207343412487;2162.3945295317335;2240.092762431218;2317.351141680324;2324.7094113235844;2330.1960823515947;2131.776163502841;2516.547021536123;2526.4820711754046;2527.0397249045427;2531.6708827852444;2418.8790560471907;2459.274514018369;2459.8155138364514;2462.9261122166185;2473.6042233242597;11628.011619012394;11898.583549575724;11901.761964760743;11913.821292680617;11914.046876249879;6500.544961852672;6751.696173672197;6761.560498567577;6770.221424536192;6783.152105986752;3637.8722595995328;3825.7704537727827;4105.507339119295;4223.915521689549;4372.99421133138;1230.846144231971;1237.0660151585585;1265.51934236943;1274.171788337588;1283.0954177304977;16866.494005179866;16876;16928.746068808978;16957.49127526176;17010.31958721662;5713.685747283939;5850.297964244318;5997.13041608973;6007.3992600739575;6140.785072522441;13915.930420348035;13923.094998825043;13923.094998825043;13931.930340348435;13939.790903136462;6504.60972341661;6508.3491650835485;6517.9348206517325;6523.249826269945;6526.477881769447;5958.940410595838;5997.1304160896425;6018.067199584071;6025.879482410327;6218.720157592828;4172.3532852407925;4514.34541991416;4636.953630463652;4655.883602909955;4740.14677358072;1321.3987635625767;1334.2728213123871;1335.8463776665612;1336.62574479146;1341.8926485881107;694.9409300209438;783.925527074927;791.5923299500762;801.4990630855715;808.9676412943417;6780.525363224527;6953.513254072166;6991.580505169706;7042.61265630385;7077.504574679826;744.7058411927259;920.6179435534312;926.7766548156503;956.4171296504296;971.4025874087527;3999.1801680655394;4315.136972605492;4347.608715215582;4353.912921741611;4430.734155950653;13120;14832.92583537097;15006.724428423488;15492.612684682748;15505.767413488808;14682.926585367219;15291.158986255641;15294.770578441332;15299.46451874179;15303.540893773205;8442.535660538606;8668.566571671392;8693.391462597558;8712.912870871336;8727.301815854717;6752.527323087336;6959.269276726073;7134.464915131282;7186.425085993213;7194.640267986684;13523.391447385087;13660.590182294547;13854.30728463593;13929.512467063603;13937.30313484342;12368;12857.678558036125;13965.441382344592;14542.781858271923;14561.199134047305;7613.428992825671;9140.04029576885;9243.953780231055;9244.583993720164;9297.209737172416;10635.521401536795;10741.087007604441;10761.677149685522;10769.676909692722;10777.353358798497;8963.731088067369;9179.678711245075;9234.93798213214;9322;9396.953015235154;7019.719211231493;8937;8940.642374304955;9090.636374545209;9217.539123043687;8167;8291.502509849428;8402.663893444194;8424.157584241526;8429.367797415342;5994.864382956067;6053.757849685963;6173.59871608344;6176.505879529716;6281.59169653971;6009.909851352146;6134;6246.9062964054665;6262.624242545462;6318.652474113968 05:33:03 INFO - PID 1646 | |4;prototype.html;353.2088122605363;390.6737873875314;396.0593590223219;412.75028607692326;416.08876560332885;5116.692998420092;5581.748821303041;5782.421757824215;5819.505342045926;5836.737346819393;4458.8885277867985;4783.378160839086;5529.806456774014;5585.497305242528;5762.855928601776;4236.639885609719;4264.381664658623;4298.46269216348;4304.849330273441;4318.330658747899;3540.6459354064646;3723.5717892442444;4274.430850240038;4306.956930430702;4314.697971142022;4062.939055914164;4173.040200753813;4241.851535196269;4259.70182087254;4309.504406993205;4170.35359519275;4178.22702799983;4209.915801683965;4215.451991241134;4224.112936283384;3708.962910370889;3725.4225595032813;3742.8128593570214;3746.981265093657;3749.4000959846567;5342.786288548492;5456.072467680504;5608.355039170507;5613.578981576398;5666.603337766358;4371.104363113333;4967.211803750647;4982.377202849644;4984.3021976923255;5018.5232402921665;5151.665141765773;5794.768209271624;6031.728572214217;6032.517398608101;6046.425589568984;3953.881383558498;4129.648979836717;4148.423599032349;4153.1070819773895;4173.9582604174175;5143.3313669223135;5566.805161819317;6054.878902421927;6236.906446403307;6409.904126219667;3489.284696637234;4083.2854250506043;4090.754554726726;4101.692373071972;4116.794160291974;4014.3175660137845;4302.182585308844;4321.157374312042;4324.589164029412;4335.674824388184;4822.397200349957;4992.475790042066;5014.222795466709;5014.52362025607;5030.974845125751;6064.696765161724;6102.664353460514;6108.450239478469;6135.386461353918;6151.96924015377;1463.785058401524;1491.0978857791097;1492.4627134231669;1492.8206716693908;1528.7922541192556;930.692871352452;983.7048885334372;985.2069084387138;990.8266053440619;1005.1807776661997;5086.287919691246;5780.421957804186;5789.363170051291;5792.82621521355;5849.532037436995;6369.9681501592195;6380.393862583047;6381.489480841615;6413.621071469656;6418.8716225675225;5075.157911569533;5182.937497812939;5736.569757268222;5778.908284068088;5809.244798176294;2806.4948309304114;3140.497520396771;3240.6273278573267;3251.463508521115;3289.3914625793827;5248.711320877312;5346.845361236811;6188.721507532172;6510;6559.704813283318;6232.594881332699;6442.130312407859;6472.838179045468;6478.449331806849;6492.285848556655;6455.677216139175;6484.416402523795;6503.317151699003;6507.837304067436;6556.868862622721;5796.01467750475;6002.247471594456;6258.311585725475;6371.585846919936;6393.488520918222;6245.96877015612;6255.874882502416;6268.498520118471;6270.623762574261;6282.403171698681;5496.780128794803;5986.491148252273;6195.411435913581;6207.944649409702;6519.217693876765;3724.5344331958504;3914.7651140931634;4070.430139780374;4217.746935183899;4253.5108462527205;5999.5800293979;6174.351693072163;6271.404216599416;6315.3053164152825;6377.617342959437;6069.241344831896;6087.564974010431;6093.634381937098;6114.6636934969;6115.449609535163;6015.969300568717;6061.545384096122;6067.543789490403;6086.543509236736;6112.083187521907;5767.423257674199;5917.497012753965;5947.256592925884;5965.463108320272;6021.518278537619;4848.854534363974;5010.574101201293;6034.853377858193;6048.818535443944;6061.605995610271;5168.457311982338;5229.50319719626;5371.8987607539575;5939.732712027882;5952.732127054206 05:33:03 INFO - PID 1646 | |5;yui.html;715.5206011971978;837.4891316297058;861.5304658960865;862.2886118951862;877.5173654490029;13070.869291307084;17879.55301117473;18399.26402943884;18417.815821841778;18486.537836554075;16503.669926601462;17585.120743962816;17709.46871593851;17779.91110044451;17813.64372712545;652.4486808646686;670.6378555579981;881.7222574888922;925.2366797392144;964.763632909938;694.2294053600499;926.4256161180077;960.7598100474881;966.6085235479642;973.1679414100948;1023.6212601337515;1024.1806554756201;1025.523131743739;1026.0457774269926;1029.4235228272191;1018.9032041956002;1022.8107800056976;1023;1024.5748014573942;1025.0108645157422;765.3532764813779;765.3915137465729;765.7740966414921;766.1457474915485;767.5471471831646;16459.506214813573;16466.847320687557;16644.83355166445;17023.82976170235;17257.65484690312;16537.751933721003;16541.338346466127;16732.330706771714;16920;16961.982281063174;13797.931010344984;13822.170669759847;13849.515266965709;13881.79177312331;14042.227677477735;3007.593974813416;3350.9497357539412;3367.8147701876387;3371.325734853039;3376.037829218661;81314;109796.4510177444;109906;110266.44866775615;111107.88892111056;11907.226030308002;11946.88053119475;12091.274523528617;12132.45403956824;12139.150259481752;19394.321198757974;19645.607087858163;19944.20223191056;20031.699524507145;20084;7532.472726909064;7621.3902887769955;7626.084869815658;7627.54234745917;7713.8457230855065;3433.296174284266;3475.687188153028;3498.0205542447648;3541.6281290464644;3553.7690050147175;4189.392538082022;4273.589218628903;4317.179735850241;4324.17840610283;4326.372675961968;861.8104017116225;863.0980625246632;866.7616405488541;875.7679215008028;876.4303202918027;617.1945610977627;619.7985654662252;651.3519048546726;661.1933441201726;671.6138220523219;10713.303635263683;11366.886331136582;11607.941960290145;11650.766984660258;11696.298222106701;618.4650277509921;633.5628416392766;638.1990601794811;650.7494614573424;665.5008743442418;5224.216367544823;5247.842564723064;5320.494553017457;5328.973355133199;5447.972760136253;102675.48662256642;103637;103934;105051;106805.39791903128;80712;90707;95455.06811648543;95551.106606689;96871;75426;77528.61235693785;78019.60990195013;79016;79609.60195198987;9588.616455341707;10257.230707696803;10606.681799546026;11249.550017999189;11550.306981581132;38306;38771;38807.61192388153;40082.799586001885;41473;42988.35517467178;48743.51256487532;48837.51162488329;49303;50654.74672626613;15497.07017578949;15500.069995800288;15636;15760.211989400714;15789;17590;17752;17777;18111.094445277948;18166.273349066418;13912.791308130589;13972.580822575339;13976.09155404936;14090.36593353281;14106.576802695936;15343.46297879569;15588.532344029698;15732.606684832514;15886.285117169524;15911.602209944844;15257.237138143271;15257.6185595361;15419.537413877602;15463.5360939172;15537.378504859678;11507.827382589436;11725.472353743931;11809.05527557776;11924.463399147233;11924.821127683264;11535.538578457103;11602.83971602833;12238.204516706386;12367.876321237032;12417.19288246261 05:33:03 INFO - PID 1646 | __end_tp_report 05:33:03 INFO - PID 1646 | __start_cc_report 05:33:03 INFO - PID 1646 | _x_x_mozilla_cycle_collect,1493 05:33:03 INFO - PID 1646 | __end_cc_report 05:33:03 INFO - PID 1646 | __startTimestamp1492518783879__endTimestamp 05:33:03 INFO - PID 1646 | 05:33:03 INFO - PID 1646 | ------- Summary: start ------- 05:33:03 INFO - PID 1646 | Number of tests: 6 05:33:03 INFO - PID 1646 | 05:33:03 INFO - PID 1646 | [#0] dojo.html Cycles:165 Average:5947.98 Median:6230.00 stddev:677.32 (10.9%) stddev-sans-first:650.42 05:33:03 INFO - PID 1646 | Values: 3449.2 3452.4 3470.1 3495.5 3512.2 5884.7 6031.9 6077.3 6095.7 6114.8 5999.7 6111.2 6124.7 6131.1 6148.3 5178.8 5220.2 5256.3 5308.3 5336.6 5140.5 5247.0 5288.3 5303.0 5351.2 5205.3 5237.7 5318.8 5326.9 5338.9 5191.8 5223.1 5268.7 5273.4 5312.8 5251.1 5252.7 5275.4 5278.7 5302.8 5812.8 5925.0 5960.3 6092.7 6121.7 6309.1 6380.0 6382.6 6385.0 6387.5 6429.0 6430.8 6434.0 6439.7 6449.7 5952.1 6015.4 6134.5 6142.0 6166.6 5349.9 6222.8 6264.9 6315.5 6320.8 6323.6 6340.1 6351.0 6356.8 6358.0 6358.8 6364.5 6397.1 6419.0 6423.8 5383.4 6296.6 6302.4 6365.0 6398.5 6359.9 6367.7 6389.3 6391.2 6414.0 5199.4 5204.7 5219.0 5223.8 5253.2 4018.0 4610.5 4618.2 4657.5 4699.1 6122.6 6155.4 6170.8 6188.4 6196.6 6500.1 6512.7 6526.2 6531.5 6536.5 5941.2 6148.4 6148.6 6149.8 6155.7 5656.8 5680.3 5719.3 5790.5 5804.2 6587.2 6611.6 6655.4 6668.5 6668.8 6282.1 6346.5 6356.2 6431.1 6433.2 6628.6 6643.7 6650.1 6659.0 6692.1 6265.4 6286.4 6373.1 6374.4 6384.9 6331.6 6430.3 6449.5 6454.1 6463.9 6257.6 6272.1 6315.4 6316.2 6343.4 6170.2 6264.9 6355.0 6367.1 6385.5 6230.0 6280.3 6292.2 6296.3 6303.1 6219.4 6312.3 6317.7 6330.6 6337.4 6070.5 6112.2 6262.9 6270.1 6296.6 05:33:03 INFO - PID 1646 | 05:33:03 INFO - PID 1646 | [#1] ext.html Cycles:180 Average:44748.87 Median:320732.50 stddev:78193.43 (24.4%) stddev-sans-first:78343.07 05:33:03 INFO - PID 1646 | Values: 772.4 804.3 823.9 1129.5 1160.6 27720.0 31051.0 37312.6 37440.0 37952.6 40090.6 40328.2 40416.8 40425.0 40438.6 6169.4 8480.6 8648.6 8650.4 8653.0 6171.6 8450.3 8624.2 8629.0 8645.0 8640.4 8671.3 8680.6 8684.3 8684.4 8576.4 8600.0 8631.9 8644.9 8645.2 8422.0 8488.6 8491.5 8498.6 8499.5 37814.6 37987.1 38030.4 38058.2 38097.6 3579.2 3610.2 3611.7 3616.1 3623.1 30734.5 30837.4 30875.0 30885.4 30906.8 3100.3 3139.4 3147.3 3158.0 3170.3 279651.0 283961.0 284624.0 284862.0 285509.0 49185.3 49269.3 49273.0 49300.5 49321.3 52528.7 52594.5 52670.2 52696.7 52747.0 14497.6 14620.2 14621.5 14632.0 14657.4 10194.8 10306.9 11868.4 11874.6 11879.4 10939.2 11028.6 11046.8 11049.2 11058.3 4750.9 5354.6 5516.4 5520.9 5550.6 1035.5 1040.4 1045.1 1066.5 1074.1 22742.5 23299.9 24513.0 24518.9 24585.3 986.4 1121.0 1132.6 1167.2 1182.8 12483.4 12525.6 12537.7 12552.6 12592.2 320431.0 320690.0 320708.0 320757.0 321153.4 41049.4 54839.7 54848.0 54881.9 54900.0 1508.7 1512.4 1561.7 1564.6 1574.4 22310.9 23861.0 24003.9 24047.2 24092.3 32443.5 38489.6 38527.0 38527.2 38553.6 287910.0 288277.6 288498.0 288844.0 288976.0 34680.0 35136.8 35501.8 35567.0 35622.8 38090.6 38766.8 38839.2 46308.3 46380.8 28731.0 28856.9 29651.7 30637.8 30873.7 30424.5 30943.9 31060.8 31520.8 31536.9 37032.0 37116.1 37501.0 37620.3 37726.7 21047.6 26523.7 30651.9 31380.8 31529.8 22235.4 23574.3 24379.9 24554.8 25252.6 05:33:03 INFO - PID 1646 | 05:33:03 INFO - PID 1646 | [#2] jquery.html Cycles:180 Average:36009.28 Median:22807.44 stddev:96402.04 (422.7%) stddev-sans-first:96635.27 05:33:03 INFO - PID 1646 | Values: 342.7 354.2 430.2 437.3 449.5 20875.0 21664.8 21743.1 21944.6 22894.7 22750.9 22864.0 23124.8 23142.3 23626.4 6177.3 6267.1 6480.3 6485.5 6489.7 6257.1 6304.2 6363.2 6385.5 6390.5 6002.7 6232.3 6250.2 6286.3 6309.0 6264.6 6277.0 6330.7 6376.0 6379.2 5632.2 5686.1 5692.7 5703.1 5703.4 26160.6 27282.7 27586.9 27968.5 28327.9 2151.2 2195.8 2199.6 2200.7 2204.1 16910.7 17499.2 17788.3 17926.6 18043.8 2083.1 2101.9 2154.4 2154.7 2164.5 150692.2 153363.0 156331.0 157685.0 159289.2 10178.0 10203.8 11723.3 11998.5 12429.4 14387.3 16693.2 16725.2 16763.5 16832.0 8631.2 8986.7 8991.1 9131.8 9171.8 6561.6 7953.3 8509.5 8563.6 8721.1 7172.6 7916.0 7949.1 7955.7 7966.2 2125.4 2129.3 2130.3 2138.5 2230.4 943.9 946.2 948.4 986.8 989.4 19507.0 19805.8 20194.8 20213.9 20224.5 973.4 997.4 1000.8 1003.6 1007.8 10193.0 10279.9 10641.8 10662.4 10682.4 557980.0 562864.0 566142.0 585627.0 586540.9 102218.5 114814.0 115537.0 125932.0 127983.4 1147.3 1150.2 1175.9 1181.7 1184.1 17575.1 18050.0 20969.6 22962.2 23098.3 59928.8 60383.7 60557.7 60821.7 61478.8 70089.0 75597.6 76971.0 77353.0 79310.0 8749.2 8880.3 8957.0 9008.5 9408.3 14310.7 14647.3 14831.0 15046.5 15146.0 12084.9 12090.8 12252.3 12414.8 12493.2 11591.1 11693.1 11706.0 11722.0 12034.8 11908.8 12250.9 12305.3 12414.8 12648.2 8940.7 9061.3 9151.7 9187.0 9194.4 10032.6 11812.2 11855.9 12051.6 12254.5 05:33:03 INFO - PID 1646 | 05:33:03 INFO - PID 1646 | [#3] mootools.html Cycles:180 Average:7205.22 Median:3912.48 stddev:4632.59 (118.4%) stddev-sans-first:4622.82 05:33:03 INFO - PID 1646 | Values: 1094.4 1111.1 1114.1 1181.8 1208.0 9877.2 10367.1 11776.2 12092.9 12097.3 11663.2 11762.4 11766.2 11776.2 11789.2 2503.8 2552.5 2554.5 2561.6 2561.7 2144.3 2239.6 2239.9 2240.4 2240.8 2162.4 2240.1 2317.4 2324.7 2330.2 2131.8 2516.5 2526.5 2527.0 2531.7 2418.9 2459.3 2459.8 2462.9 2473.6 11628.0 11898.6 11901.8 11913.8 11914.0 6500.5 6751.7 6761.6 6770.2 6783.2 3637.9 3825.8 4105.5 4223.9 4373.0 1230.8 1237.1 1265.5 1274.2 1283.1 16866.5 16876.0 16928.7 16957.5 17010.3 5713.7 5850.3 5997.1 6007.4 6140.8 13915.9 13923.1 13923.1 13931.9 13939.8 6504.6 6508.3 6517.9 6523.2 6526.5 5958.9 5997.1 6018.1 6025.9 6218.7 4172.4 4514.3 4637.0 4655.9 4740.1 1321.4 1334.3 1335.8 1336.6 1341.9 694.9 783.9 791.6 801.5 809.0 6780.5 6953.5 6991.6 7042.6 7077.5 744.7 920.6 926.8 956.4 971.4 3999.2 4315.1 4347.6 4353.9 4430.7 13120.0 14832.9 15006.7 15492.6 15505.8 14682.9 15291.2 15294.8 15299.5 15303.5 8442.5 8668.6 8693.4 8712.9 8727.3 6752.5 6959.3 7134.5 7186.4 7194.6 13523.4 13660.6 13854.3 13929.5 13937.3 12368.0 12857.7 13965.4 14542.8 14561.2 7613.4 9140.0 9244.0 9244.6 9297.2 10635.5 10741.1 10761.7 10769.7 10777.4 8963.7 9179.7 9234.9 9322.0 9397.0 7019.7 8937.0 8940.6 9090.6 9217.5 8167.0 8291.5 8402.7 8424.2 8429.4 5994.9 6053.8 6173.6 6176.5 6281.6 6009.9 6134.0 6246.9 6262.6 6318.7 05:33:03 INFO - PID 1646 | 05:33:03 INFO - PID 1646 | [#4] prototype.html Cycles:180 Average:4925.47 Median:5574.28 stddev:1526.87 (27.4%) stddev-sans-first:1492.09 05:33:03 INFO - PID 1646 | Values: 353.2 390.7 396.1 412.8 416.1 5116.7 5581.7 5782.4 5819.5 5836.7 4458.9 4783.4 5529.8 5585.5 5762.9 4236.6 4264.4 4298.5 4304.8 4318.3 3540.6 3723.6 4274.4 4307.0 4314.7 4062.9 4173.0 4241.9 4259.7 4309.5 4170.4 4178.2 4209.9 4215.5 4224.1 3709.0 3725.4 3742.8 3747.0 3749.4 5342.8 5456.1 5608.4 5613.6 5666.6 4371.1 4967.2 4982.4 4984.3 5018.5 5151.7 5794.8 6031.7 6032.5 6046.4 3953.9 4129.6 4148.4 4153.1 4174.0 5143.3 5566.8 6054.9 6236.9 6409.9 3489.3 4083.3 4090.8 4101.7 4116.8 4014.3 4302.2 4321.2 4324.6 4335.7 4822.4 4992.5 5014.2 5014.5 5031.0 6064.7 6102.7 6108.5 6135.4 6152.0 1463.8 1491.1 1492.5 1492.8 1528.8 930.7 983.7 985.2 990.8 1005.2 5086.3 5780.4 5789.4 5792.8 5849.5 6370.0 6380.4 6381.5 6413.6 6418.9 5075.2 5182.9 5736.6 5778.9 5809.2 2806.5 3140.5 3240.6 3251.5 3289.4 5248.7 5346.8 6188.7 6510.0 6559.7 6232.6 6442.1 6472.8 6478.4 6492.3 6455.7 6484.4 6503.3 6507.8 6556.9 5796.0 6002.2 6258.3 6371.6 6393.5 6246.0 6255.9 6268.5 6270.6 6282.4 5496.8 5986.5 6195.4 6207.9 6519.2 3724.5 3914.8 4070.4 4217.7 4253.5 5999.6 6174.4 6271.4 6315.3 6377.6 6069.2 6087.6 6093.6 6114.7 6115.4 6016.0 6061.5 6067.5 6086.5 6112.1 5767.4 5917.5 5947.3 5965.5 6021.5 4848.9 5010.6 6034.9 6048.8 6061.6 5168.5 5229.5 5371.9 5939.7 5952.7 05:33:03 INFO - PID 1646 | 05:33:03 INFO - PID 1646 | [#5] yui.html Cycles:180 Average:20451.93 Median:18408.54 stddev:28526.31 (155.0%) stddev-sans-first:28567.84 05:33:03 INFO - PID 1646 | Values: 715.5 837.5 861.5 862.3 877.5 13070.9 17879.6 18399.3 18417.8 18486.5 16503.7 17585.1 17709.5 17779.9 17813.6 652.4 670.6 881.7 925.2 964.8 694.2 926.4 960.8 966.6 973.2 1023.6 1024.2 1025.5 1026.0 1029.4 1018.9 1022.8 1023.0 1024.6 1025.0 765.4 765.4 765.8 766.1 767.5 16459.5 16466.8 16644.8 17023.8 17257.7 16537.8 16541.3 16732.3 16920.0 16962.0 13797.9 13822.2 13849.5 13881.8 14042.2 3007.6 3350.9 3367.8 3371.3 3376.0 81314.0 109796.5 109906.0 110266.4 111107.9 11907.2 11946.9 12091.3 12132.5 12139.2 19394.3 19645.6 19944.2 20031.7 20084.0 7532.5 7621.4 7626.1 7627.5 7713.8 3433.3 3475.7 3498.0 3541.6 3553.8 4189.4 4273.6 4317.2 4324.2 4326.4 861.8 863.1 866.8 875.8 876.4 617.2 619.8 651.4 661.2 671.6 10713.3 11366.9 11607.9 11650.8 11696.3 618.5 633.6 638.2 650.7 665.5 5224.2 5247.8 5320.5 5329.0 5448.0 102675.5 103637.0 103934.0 105051.0 106805.4 80712.0 90707.0 95455.1 95551.1 96871.0 75426.0 77528.6 78019.6 79016.0 79609.6 9588.6 10257.2 10606.7 11249.6 11550.3 38306.0 38771.0 38807.6 40082.8 41473.0 42988.4 48743.5 48837.5 49303.0 50654.7 15497.1 15500.1 15636.0 15760.2 15789.0 17590.0 17752.0 17777.0 18111.1 18166.3 13912.8 13972.6 13976.1 14090.4 14106.6 15343.5 15588.5 15732.6 15886.3 15911.6 15257.2 15257.6 15419.5 15463.5 15537.4 11507.8 11725.5 11809.1 11924.5 11924.8 11535.5 11602.8 12238.2 12367.9 12417.2 05:33:03 INFO - PID 1646 | -------- Summary: end -------- 05:33:03 INFO - PID 1646 | 05:33:04 INFO - TEST-INFO | 1646: exit 0 05:33:04 INFO - TEST-OK | dromaeo_css | took 1119583ms 05:33:04 INFO - TEST-START | kraken 05:33:04 INFO - operating with platform_type : mac_ 05:33:04 INFO - Initialising browser for kraken test... 05:33:04 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/tmpEqOX2G/profile http://localhost:49235/getInfo.html) 05:33:07 INFO - PID 1657 | __metrics Screen width/height:1600/1200 05:33:07 INFO - PID 1657 | colorDepth:24 05:33:07 INFO - PID 1657 | Browser inner width/height: 1024/689 05:33:07 INFO - PID 1657 | __metrics 05:33:07 INFO - PID 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:33:07 INFO - PID 1657 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:33:08 INFO - TEST-INFO | 1657: exit 0 05:33:08 INFO - Browser initialized. 05:33:08 INFO - Running cycle 1/1 for kraken test... 05:33:08 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/T/tmpEqOX2G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:20 INFO - PID 1658 | RSS: Main: 253816832 05:33:20 INFO - PID 1658 | 05:33:23 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 05:33:24 INFO - PID 1658 | RSS: Main: 321470464 05:33:24 INFO - PID 1658 | 05:33:27 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 05:33:27 INFO - PID 1658 | RSS: Main: 302563328 05:33:27 INFO - PID 1658 | 05:33:31 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 05:33:31 INFO - PID 1658 | RSS: Main: 390479872 05:33:31 INFO - PID 1658 | 05:33:33 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 05:33:34 INFO - PID 1658 | RSS: Main: 294596608 05:33:34 INFO - PID 1658 | 05:33:36 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:33:37 INFO - PID 1658 | RSS: Main: 297308160 05:33:37 INFO - PID 1658 | 05:33:39 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 05:33:40 INFO - PID 1658 | RSS: Main: 359710720 05:33:40 INFO - PID 1658 | 05:33:43 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 05:33:44 INFO - PID 1658 | RSS: Main: 384802816 05:33:44 INFO - PID 1658 | 05:33:46 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 05:33:47 INFO - PID 1658 | RSS: Main: 400584704 05:33:47 INFO - PID 1658 | 05:33:48 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:33:49 INFO - PID 1658 | RSS: Main: 337780736 05:33:49 INFO - PID 1658 | 05:33:51 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:33:52 INFO - PID 1658 | RSS: Main: 336973824 05:33:52 INFO - PID 1658 | 05:33:54 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:33:54 INFO - PID 1658 | RSS: Main: 338821120 05:33:54 INFO - PID 1658 | 05:33:57 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:33:58 INFO - PID 1658 | RSS: Main: 358588416 05:33:58 INFO - PID 1658 | 05:34:01 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:34:02 INFO - PID 1658 | RSS: Main: 351178752 05:34:02 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 05:34:04 INFO - PID 1658 | RSS: Main: 394629120 05:34:04 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | __start_tp_report 05:34:04 INFO - PID 1658 | _x_x_mozilla_page_load 05:34:04 INFO - PID 1658 | _x_x_mozilla_page_load_details 05:34:04 INFO - PID 1658 | |i|pagename|runs| 05:34:04 INFO - PID 1658 | |0;ai-astar;111;110;111;112;111;112;111;111;110;111 05:34:04 INFO - PID 1658 | |1;audio-beat-detection;146;111;108;150;111;109;109;110;137;109 05:34:04 INFO - PID 1658 | |2;audio-dft;182;183;185;186;198;267;185;184;184;181 05:34:04 INFO - PID 1658 | |3;audio-fft;78;60;77;119;86;60;62;60;81;84 05:34:04 INFO - PID 1658 | |4;audio-oscillator;86;71;85;68;68;69;91;68;69;89 05:34:04 INFO - PID 1658 | |5;imaging-gaussian-blur;89;88;89;88;88;88;88;88;88;88 05:34:04 INFO - PID 1658 | |6;imaging-darkroom;96;96;94;95;95;95;96;96;97;96 05:34:04 INFO - PID 1658 | |7;imaging-desaturate;88;87;86;84;85;86;84;83;83;86 05:34:04 INFO - PID 1658 | |8;json-parse-financial;50;50;51;48;49;50;50;49;48;50 05:34:04 INFO - PID 1658 | |9;json-stringify-tinderbox;54;60;59;71;65;62;59;59;59;59 05:34:04 INFO - PID 1658 | |10;stanford-crypto-aes;81;83;83;83;83;83;83;82;83;83 05:34:04 INFO - PID 1658 | |11;stanford-crypto-ccm;144;139;138;123;128;142;140;149;197;141 05:34:04 INFO - PID 1658 | |12;stanford-crypto-pbkdf2;187;189;231;187;183;184;185;184;180;190 05:34:04 INFO - PID 1658 | |13;stanford-crypto-sha256-iterative;69;68;68;65;81;91;92;94;93;68 05:34:04 INFO - PID 1658 | __end_tp_report 05:34:04 INFO - PID 1658 | __start_cc_report 05:34:04 INFO - PID 1658 | _x_x_mozilla_cycle_collect,2187 05:34:04 INFO - PID 1658 | __end_cc_report 05:34:04 INFO - PID 1658 | __startTimestamp1492518844335__endTimestamp 05:34:04 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | ------- Summary: start ------- 05:34:04 INFO - PID 1658 | Number of tests: 14 05:34:04 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:34:04 INFO - PID 1658 | Values: 111.0 110.0 111.0 112.0 111.0 112.0 111.0 111.0 110.0 111.0 05:34:04 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | [#1] audio-beat-detection Cycles:10 Average:120.00 Median:111.00 stddev:17.11 (15.4%) stddev-sans-first:15.34 05:34:04 INFO - PID 1658 | Values: 146.0 111.0 108.0 150.0 111.0 109.0 109.0 110.0 137.0 109.0 05:34:04 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | [#2] audio-dft Cycles:10 Average:193.50 Median:185.00 stddev:26.25 (14.2%) stddev-sans-first:27.51 05:34:04 INFO - PID 1658 | Values: 182.0 183.0 185.0 186.0 198.0 267.0 185.0 184.0 184.0 181.0 05:34:04 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | [#3] audio-fft Cycles:10 Average:76.70 Median:77.50 stddev:18.26 (23.6%) stddev-sans-first:19.37 05:34:04 INFO - PID 1658 | Values: 78.0 60.0 77.0 119.0 86.0 60.0 62.0 60.0 81.0 84.0 05:34:04 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | [#4] audio-oscillator Cycles:10 Average:76.40 Median:78.00 stddev:9.94 (12.7%) stddev-sans-first:9.91 05:34:04 INFO - PID 1658 | Values: 86.0 71.0 85.0 68.0 68.0 69.0 91.0 68.0 69.0 89.0 05:34:04 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:88.00 stddev:0.42 (0.5%) stddev-sans-first:0.33 05:34:04 INFO - PID 1658 | Values: 89.0 88.0 89.0 88.0 88.0 88.0 88.0 88.0 88.0 88.0 05:34:04 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:96.00 stddev:0.84 (0.9%) stddev-sans-first:0.88 05:34:04 INFO - PID 1658 | Values: 96.0 96.0 94.0 95.0 95.0 95.0 96.0 96.0 97.0 96.0 05:34:04 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:86.00 stddev:1.69 (2.0%) stddev-sans-first:1.45 05:34:04 INFO - PID 1658 | Values: 88.0 87.0 86.0 84.0 85.0 86.0 84.0 83.0 83.0 86.0 05:34:04 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | [#8] json-parse-financial Cycles:10 Average:49.50 Median:50.00 stddev:0.97 (1.9%) stddev-sans-first:1.01 05:34:04 INFO - PID 1658 | Values: 50.0 50.0 51.0 48.0 49.0 50.0 50.0 49.0 48.0 50.0 05:34:04 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:59.50 stddev:4.55 (7.6%) stddev-sans-first:4.13 05:34:04 INFO - PID 1658 | Values: 54.0 60.0 59.0 71.0 65.0 62.0 59.0 59.0 59.0 59.0 05:34:04 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:0.67 (0.8%) stddev-sans-first:0.33 05:34:04 INFO - PID 1658 | Values: 81.0 83.0 83.0 83.0 83.0 83.0 83.0 82.0 83.0 83.0 05:34:04 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:141.50 stddev:20.06 (14.2%) stddev-sans-first:21.27 05:34:04 INFO - PID 1658 | Values: 144.0 139.0 138.0 123.0 128.0 142.0 140.0 149.0 197.0 141.0 05:34:04 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.00 Median:187.00 stddev:14.70 (7.9%) stddev-sans-first:15.56 05:34:04 INFO - PID 1658 | Values: 187.0 189.0 231.0 187.0 183.0 184.0 185.0 184.0 180.0 190.0 05:34:04 INFO - PID 1658 | 05:34:04 INFO - PID 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.90 Median:86.00 stddev:12.46 (14.5%) stddev-sans-first:12.69 05:34:04 INFO - PID 1658 | Values: 69.0 68.0 68.0 65.0 81.0 91.0 92.0 94.0 93.0 68.0 05:34:04 INFO - PID 1658 | -------- Summary: end -------- 05:34:04 INFO - PID 1658 | 05:34:05 INFO - TEST-INFO | 1658: exit 0 05:34:05 INFO - TEST-OK | kraken | took 60902ms 05:34:05 INFO - SUITE-END | took 1180s 05:34:05 INFO - Completed test suite (00:19:40) 05:34:05 INFO - javascript benchmark 05:34:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7675.253885097673, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3449.172198672318, 3452.413089774738, 3470.132466883279, 3495.528103706002, 3512.192195794967, 5884.735186916589, 6031.87936241276, 6077.301110372308, 6095.664738439384, 6114.785982490614, 5999.67001814899, 6111.205543279379, 6124.717717612933, 6131.08033794931, 6148.292946311176, 5178.792848286064, 5220.190870415092, 5256.316678831747, 5308.309919710432, 5336.59975501837, 5140.5373516383515, 5246.9768395162955, 5288.286081379003, 5302.973485132569, 5351.17056856186, 5205.349331333602, 5237.685738855643, 5318.813841515567, 5326.866828329284, 5338.946610533883, 5191.792328306863, 5223.112070947948, 5268.683878967274, 5273.367195936474, 5312.787488500456, 5251.10731175701, 5252.65857719247, 5275.393329767087, 5278.683279003272, 5302.840914772524, 5812.767489300423, 5925.022371308729, 5960.344362120163, 6092.66490343031, 6121.66330851803, 6309.0536419536975, 6380.011098279774, 6382.6170429774365, 6384.968075159594, 6387.457066149383, 6429.0, 6430.839229019265, 6433.9678301608665, 6439.678016099177, 6449.709763060673, 5952.077427998667, 6015.368386319461, 6134.539909506805, 6142.01727723571, 6166.568340216187, 5349.946500535023, 6222.81331560054, 6264.906026409608, 6315.463185629181, 6320.810375688737, 6323.588966717149, 6340.080688300263, 6351.047342898602, 6356.77751278703, 6357.968210159012, 6358.841028974312, 6364.459020983269, 6397.136386587844, 6419.0, 6423.839404014937, 5383.407825139231, 6296.590721603081, 6302.432781049636, 6365.0, 6398.456131228898, 6359.904601430982, 6367.713452894631, 6389.265234498, 6391.169148010822, 6413.967930160413, 5199.428062913076, 5204.713740744295, 5219.0083884061905, 5223.817166399158, 5253.1857562077175, 4018.015586181346, 4610.4697959734385, 4618.237990731559, 4657.4876763555985, 4699.130660827758, 6122.571420000557, 6155.35368786271, 6170.81487555374, 6188.412100850412, 6196.597221180609, 6500.057491663682, 6512.706928188243, 6526.184226971629, 6531.477481801539, 6536.477081833537, 5941.197938278364, 6148.354422785633, 6148.631082135086, 6149.7847575335545, 6155.6614386209185, 5656.773729050874, 5680.289963754531, 5719.342275638355, 5790.478856902899, 5804.187413762077, 6587.176602924635, 6611.570247933869, 6655.367740064686, 6668.466522678077, 6668.766593169215, 6282.120503129474, 6346.492280617447, 6356.237251529846, 6431.067495213261, 6433.228012638513, 6628.5691430056895, 6643.667816609053, 6650.068990341259, 6659.0, 6692.096566963398, 6265.4361107500545, 6286.402791734778, 6373.139626150596, 6374.362563743589, 6384.872302554016, 6331.588446750947, 6430.292667806444, 6449.451796597342, 6454.0641606967665, 6463.870722585428, 6257.5932564383165, 6272.121902933502, 6315.431611155018, 6316.210473690789, 6343.365663433619, 6170.197874276495, 6264.937350626617, 6355.0, 6367.076773867856, 6385.45723613498, 6230.0, 6280.277768056732, 6292.2449306081735, 6296.275928268308, 6303.086052522451, 6219.378062193744, 6312.3056463788025, 6317.652529110943, 6330.588511746721, 6337.366263373626, 6070.544709146743, 6112.17485639433, 6262.937370626236, 6270.090836828543, 6296.590721603081], "value": 5903.43422344643, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.3666593393419, 804.3364224514775, 823.9299659528941, 1129.4860838318566, 1160.628598848369, 27720.02979895704, 31051.0, 37312.62687373126, 37440.0, 37952.62047379525, 40090.59909400905, 40328.19343613126, 40416.79791601045, 40425.0, 40438.59561404385, 6169.383061693839, 8480.575971201431, 8648.567571621425, 8650.43772154811, 8653.004904435977, 6171.598846075013, 8450.32397408209, 8624.18070283322, 8629.007664118644, 8644.956775216115, 8640.438371505863, 8671.262942649882, 8680.56597170139, 8684.348673849487, 8684.392092553524, 8576.356773242002, 8600.010998735163, 8631.913680863237, 8644.913550864474, 8645.178708022728, 8422.0, 8488.618012189467, 8491.490510569385, 8498.575071246474, 8499.490030598185, 37814.62185378166, 37987.05032374185, 38030.42954355687, 38058.24271966004, 38097.61902380968, 3579.2125732338845, 3610.2418492116685, 3611.747177697562, 3616.0959760059986, 3623.0942264433893, 30734.538981915288, 30837.38325233483, 30875.0, 30885.38229235403, 30906.845465772753, 3100.333428312901, 3139.4192074466296, 3147.3233254850315, 3158.0, 3170.2708377073404, 279651.0, 283961.0, 284624.0, 284861.9999999979, 285509.0, 49185.26222106671, 49269.26096108561, 49273.0, 49300.50699493031, 49321.260181097314, 52528.74712528716, 52594.47405525972, 52670.20994685083, 52696.73651631794, 52747.0, 14497.637559061108, 14620.195889225983, 14621.488247911271, 14632.0, 14657.413703451955, 10194.796104077877, 10306.896931030744, 11868.406579670982, 11874.584389546497, 11879.406029698654, 10939.23425360233, 11028.613998510174, 11046.834297485544, 11049.17131215162, 11058.336499810037, 4750.904981900412, 5354.571634269249, 5516.448355164452, 5520.861978450491, 5550.639208451437, 1035.471909326249, 1040.375774535288, 1045.1273186889032, 1066.5200659703164, 1074.1031238915593, 22742.545149096924, 23299.883500582728, 24513.0, 24518.896649650807, 24585.262442126765, 986.3637953520083, 1121.030308782897, 1132.592266783957, 1167.2121318110412, 1182.804837201852, 12483.375831208403, 12525.56160534377, 12537.686557836127, 12552.560660376843, 12592.181508201938, 320431.0, 320690.0, 320708.0, 320757.0, 321153.394233032, 41049.38425923613, 54839.72580137153, 54848.0, 54881.90236195254, 54900.0, 1508.6605513759316, 1512.4328376858457, 1561.7266978278756, 1564.5541020809242, 1574.3781206423398, 22310.88844555767, 23861.0, 24003.879980600683, 24047.2345680242, 24092.277231683078, 32443.513347300282, 38489.615103848606, 38527.0, 38527.229455410175, 38553.614463855, 287910.0, 288277.5586122056, 288498.0, 288844.0, 288976.0, 34680.0, 35136.82431587826, 35501.82249088738, 35567.0, 35622.82188589144, 38090.61909380871, 38766.80616596899, 38839.2232155361, 46308.30537541872, 46380.76809616065, 28731.0, 28856.855715721285, 29651.703482964895, 30637.846810765805, 30873.691263087083, 30424.543631845983, 30943.91696290619, 31060.844695776377, 31520.84239578879, 31536.89620863259, 37032.0, 37116.072098197765, 37501.0, 37620.29572232172, 37726.679566216146, 21047.57904841864, 26523.734762652897, 30651.927182548505, 31380.843095784374, 31529.842350788098, 22235.444113896636, 23574.29277121689, 24379.885149147103, 24554.75445245596, 25252.62121068222], "value": 17348.397200686853, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.65220800887096, 354.2472246476238, 430.19124046792024, 437.3221506664669, 449.4988088281567, 20874.95625218739, 21664.783352166472, 21743.130274789008, 21944.561108777816, 22894.65658015131, 22750.88624556879, 22864.0, 23124.768752312473, 23142.30573082806, 23626.409339766473, 6177.258728952532, 6267.122602835618, 6480.254770701359, 6485.513586481009, 6489.740410383579, 6257.061440783873, 6304.211973503312, 6363.204599425072, 6385.489160867142, 6390.520710946675, 6002.699865006754, 6232.283287421937, 6250.218722659668, 6286.308506064329, 6308.9684551577175, 6264.561480696353, 6277.027060805583, 6330.746770129213, 6376.0, 6379.202599675041, 5632.211490391349, 5686.090225563931, 5692.658440493542, 5703.116017017369, 5703.429657034305, 26160.607590886153, 27282.727172728217, 27586.862065689544, 27968.503937007874, 28327.85836070827, 2151.236311109549, 2195.7584665686763, 2199.604071267171, 2200.6698995150696, 2204.0522575292616, 16910.661786764194, 17499.212535435938, 17788.288468461375, 17926.641467170582, 18043.819561804346, 2083.0834432849497, 2101.915923363079, 2154.396768904709, 2154.7198864147563, 2164.512984578473, 150692.2465387677, 153363.0, 156331.0, 157685.0, 159289.20355398266, 10178.0, 10203.846942295871, 11723.296602203895, 11998.460069296903, 12429.378531073591, 14387.273527176596, 16693.165341732863, 16725.16374181286, 16763.49709508717, 16832.0, 8631.223189912938, 8986.68546600866, 8991.055939126429, 9131.77170570741, 9171.77070573241, 6561.573497722633, 7953.2842044216295, 8509.531975741394, 8563.571821408905, 8721.127887211354, 7172.641367931687, 7915.960420197977, 7949.085855126619, 7955.681772729026, 7966.203379661987, 2125.4261349435565, 2129.2973318804757, 2130.254410956153, 2138.518833262535, 2230.364346161336, 943.8820147481565, 946.1644409844879, 948.4072454715803, 986.8174387738292, 989.42118860466, 19507.0, 19805.801941980397, 20194.79805201929, 20213.898930505547, 20224.494387640425, 973.4256788494822, 997.3543652972653, 1000.7948370584159, 1003.5634498992962, 1007.8253501470426, 10193.0, 10279.897201028043, 10641.840372394421, 10662.360258384522, 10682.359058456517, 557980.0, 562864.0, 566142.0, 585627.0, 586540.8748431338, 102218.48890755499, 114814.0, 115537.0, 125932.0, 127983.36008319899, 1147.300146910384, 1150.1776229995594, 1175.9470823812949, 1181.6927598824195, 1184.135581025856, 17575.121243938007, 18050.0, 20969.580608388052, 22962.19632312861, 23098.307050788502, 59928.801423972145, 60383.69808150931, 60557.69721151366, 60821.695891520256, 61478.770424592156, 70089.0, 75597.62201188959, 76971.0, 77353.0, 79310.0, 8749.16882896124, 8880.333974952033, 8956.955215223883, 9008.504532250789, 9408.29437792182, 14310.713785724436, 14647.26763661834, 14830.961832672041, 15046.54860354191, 15146.01550899188, 12084.939575302067, 12090.75818483643, 12252.264864108181, 12414.751704966031, 12493.18794278369, 11591.072714182677, 11693.123015774021, 11706.0, 11722.003629691571, 12034.819477707666, 11908.76182476363, 12250.877491224974, 12305.323207223688, 12414.81377779352, 12648.177868438523, 8940.73177804667, 9061.275097992277, 9151.725448236564, 9187.03536128697, 9194.356395052282, 10032.598696052368, 11812.173147879566, 11855.881441185478, 12051.57819476314, 12254.509819607116], "value": 10478.918472771908, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1094.3707368263251, 1111.0833562311093, 1114.0753174864863, 1181.7990941539938, 1207.9551188222188, 9877.160441362485, 10367.06696397324, 11776.234544754596, 12092.939535302334, 12097.334646594456, 11663.241889277191, 11762.411879406038, 11766.176367654247, 11776.175667703264, 11789.233699809507, 2503.7621425964503, 2552.52778236026, 2554.463562651845, 2561.602951542505, 2561.6669832921693, 2144.335256070623, 2239.5744808486415, 2239.9216027439043, 2240.3838944290287, 2240.8207343412487, 2162.3945295317335, 2240.092762431218, 2317.351141680324, 2324.7094113235844, 2330.1960823515947, 2131.776163502841, 2516.547021536123, 2526.4820711754046, 2527.0397249045427, 2531.6708827852444, 2418.8790560471907, 2459.274514018369, 2459.8155138364514, 2462.9261122166185, 2473.6042233242597, 11628.011619012394, 11898.583549575724, 11901.761964760743, 11913.821292680617, 11914.046876249879, 6500.544961852672, 6751.696173672197, 6761.560498567577, 6770.221424536192, 6783.152105986752, 3637.8722595995328, 3825.7704537727827, 4105.507339119295, 4223.915521689549, 4372.99421133138, 1230.846144231971, 1237.0660151585585, 1265.51934236943, 1274.171788337588, 1283.0954177304977, 16866.494005179866, 16876.0, 16928.746068808978, 16957.49127526176, 17010.31958721662, 5713.685747283939, 5850.297964244318, 5997.13041608973, 6007.3992600739575, 6140.785072522441, 13915.930420348035, 13923.094998825043, 13923.094998825043, 13931.930340348435, 13939.790903136462, 6504.60972341661, 6508.3491650835485, 6517.9348206517325, 6523.249826269945, 6526.477881769447, 5958.940410595838, 5997.1304160896425, 6018.067199584071, 6025.879482410327, 6218.720157592828, 4172.3532852407925, 4514.34541991416, 4636.953630463652, 4655.883602909955, 4740.14677358072, 1321.3987635625767, 1334.2728213123871, 1335.8463776665612, 1336.62574479146, 1341.8926485881107, 694.9409300209438, 783.925527074927, 791.5923299500762, 801.4990630855715, 808.9676412943417, 6780.525363224527, 6953.513254072166, 6991.580505169706, 7042.61265630385, 7077.504574679826, 744.7058411927259, 920.6179435534312, 926.7766548156503, 956.4171296504296, 971.4025874087527, 3999.1801680655394, 4315.136972605492, 4347.608715215582, 4353.912921741611, 4430.734155950653, 13120.0, 14832.92583537097, 15006.724428423488, 15492.612684682748, 15505.767413488808, 14682.926585367219, 15291.158986255641, 15294.770578441332, 15299.46451874179, 15303.540893773205, 8442.535660538606, 8668.566571671392, 8693.391462597558, 8712.912870871336, 8727.301815854717, 6752.527323087336, 6959.269276726073, 7134.464915131282, 7186.425085993213, 7194.640267986684, 13523.391447385087, 13660.590182294547, 13854.30728463593, 13929.512467063603, 13937.30313484342, 12368.0, 12857.678558036125, 13965.441382344592, 14542.781858271923, 14561.199134047305, 7613.428992825671, 9140.04029576885, 9243.953780231055, 9244.583993720164, 9297.209737172416, 10635.521401536795, 10741.087007604441, 10761.677149685522, 10769.676909692722, 10777.353358798497, 8963.731088067369, 9179.678711245075, 9234.93798213214, 9322.0, 9396.953015235154, 7019.719211231493, 8937.0, 8940.642374304955, 9090.636374545209, 9217.539123043687, 8167.0, 8291.502509849428, 8402.663893444194, 8424.157584241526, 8429.367797415342, 5994.864382956067, 6053.757849685963, 6173.59871608344, 6176.505879529716, 6281.59169653971, 6009.909851352146, 6134.0, 6246.9062964054665, 6262.624242545462, 6318.652474113968], "value": 5382.040221187922, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.2088122605363, 390.6737873875314, 396.0593590223219, 412.75028607692326, 416.08876560332885, 5116.692998420092, 5581.748821303041, 5782.421757824215, 5819.505342045926, 5836.737346819393, 4458.8885277867985, 4783.378160839086, 5529.806456774014, 5585.497305242528, 5762.855928601776, 4236.639885609719, 4264.381664658623, 4298.46269216348, 4304.849330273441, 4318.330658747899, 3540.6459354064646, 3723.5717892442444, 4274.430850240038, 4306.956930430702, 4314.697971142022, 4062.939055914164, 4173.040200753813, 4241.851535196269, 4259.70182087254, 4309.504406993205, 4170.35359519275, 4178.22702799983, 4209.915801683965, 4215.451991241134, 4224.112936283384, 3708.962910370889, 3725.4225595032813, 3742.8128593570214, 3746.981265093657, 3749.4000959846567, 5342.786288548492, 5456.072467680504, 5608.355039170507, 5613.578981576398, 5666.603337766358, 4371.104363113333, 4967.211803750647, 4982.377202849644, 4984.3021976923255, 5018.5232402921665, 5151.665141765773, 5794.768209271624, 6031.728572214217, 6032.517398608101, 6046.425589568984, 3953.881383558498, 4129.648979836717, 4148.423599032349, 4153.1070819773895, 4173.9582604174175, 5143.3313669223135, 5566.805161819317, 6054.878902421927, 6236.906446403307, 6409.904126219667, 3489.284696637234, 4083.2854250506043, 4090.754554726726, 4101.692373071972, 4116.794160291974, 4014.3175660137845, 4302.182585308844, 4321.157374312042, 4324.589164029412, 4335.674824388184, 4822.397200349957, 4992.475790042066, 5014.222795466709, 5014.52362025607, 5030.974845125751, 6064.696765161724, 6102.664353460514, 6108.450239478469, 6135.386461353918, 6151.96924015377, 1463.785058401524, 1491.0978857791097, 1492.4627134231669, 1492.8206716693908, 1528.7922541192556, 930.692871352452, 983.7048885334372, 985.2069084387138, 990.8266053440619, 1005.1807776661997, 5086.287919691246, 5780.421957804186, 5789.363170051291, 5792.82621521355, 5849.532037436995, 6369.9681501592195, 6380.393862583047, 6381.489480841615, 6413.621071469656, 6418.8716225675225, 5075.157911569533, 5182.937497812939, 5736.569757268222, 5778.908284068088, 5809.244798176294, 2806.4948309304114, 3140.497520396771, 3240.6273278573267, 3251.463508521115, 3289.3914625793827, 5248.711320877312, 5346.845361236811, 6188.721507532172, 6510.0, 6559.704813283318, 6232.594881332699, 6442.130312407859, 6472.838179045468, 6478.449331806849, 6492.285848556655, 6455.677216139175, 6484.416402523795, 6503.317151699003, 6507.837304067436, 6556.868862622721, 5796.01467750475, 6002.247471594456, 6258.311585725475, 6371.585846919936, 6393.488520918222, 6245.96877015612, 6255.874882502416, 6268.498520118471, 6270.623762574261, 6282.403171698681, 5496.780128794803, 5986.491148252273, 6195.411435913581, 6207.944649409702, 6519.217693876765, 3724.5344331958504, 3914.7651140931634, 4070.430139780374, 4217.746935183899, 4253.5108462527205, 5999.5800293979, 6174.351693072163, 6271.404216599416, 6315.3053164152825, 6377.617342959437, 6069.241344831896, 6087.564974010431, 6093.634381937098, 6114.6636934969, 6115.449609535163, 6015.969300568717, 6061.545384096122, 6067.543789490403, 6086.543509236736, 6112.083187521907, 5767.423257674199, 5917.497012753965, 5947.256592925884, 5965.463108320272, 6021.518278537619, 4848.854534363974, 5010.574101201293, 6034.853377858193, 6048.818535443944, 6061.605995610271, 5168.457311982338, 5229.50319719626, 5371.8987607539575, 5939.732712027882, 5952.732127054206], "value": 4459.627645333889, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.5206011971978, 837.4891316297058, 861.5304658960865, 862.2886118951862, 877.5173654490029, 13070.869291307084, 17879.55301117473, 18399.26402943884, 18417.815821841778, 18486.537836554075, 16503.669926601462, 17585.120743962816, 17709.46871593851, 17779.91110044451, 17813.64372712545, 652.4486808646686, 670.6378555579981, 881.7222574888922, 925.2366797392144, 964.763632909938, 694.2294053600499, 926.4256161180077, 960.7598100474881, 966.6085235479642, 973.1679414100948, 1023.6212601337515, 1024.1806554756201, 1025.523131743739, 1026.0457774269926, 1029.4235228272191, 1018.9032041956002, 1022.8107800056976, 1023.0, 1024.5748014573942, 1025.0108645157422, 765.3532764813779, 765.3915137465729, 765.7740966414921, 766.1457474915485, 767.5471471831646, 16459.506214813573, 16466.847320687557, 16644.83355166445, 17023.82976170235, 17257.65484690312, 16537.751933721003, 16541.338346466127, 16732.330706771714, 16920.0, 16961.982281063174, 13797.931010344984, 13822.170669759847, 13849.515266965709, 13881.79177312331, 14042.227677477735, 3007.593974813416, 3350.9497357539412, 3367.8147701876387, 3371.325734853039, 3376.037829218661, 81314.0, 109796.4510177444, 109906.0, 110266.44866775615, 111107.88892111056, 11907.226030308002, 11946.88053119475, 12091.274523528617, 12132.45403956824, 12139.150259481752, 19394.321198757974, 19645.607087858163, 19944.20223191056, 20031.699524507145, 20084.0, 7532.472726909064, 7621.3902887769955, 7626.084869815658, 7627.54234745917, 7713.8457230855065, 3433.296174284266, 3475.687188153028, 3498.0205542447648, 3541.6281290464644, 3553.7690050147175, 4189.392538082022, 4273.589218628903, 4317.179735850241, 4324.17840610283, 4326.372675961968, 861.8104017116225, 863.0980625246632, 866.7616405488541, 875.7679215008028, 876.4303202918027, 617.1945610977627, 619.7985654662252, 651.3519048546726, 661.1933441201726, 671.6138220523219, 10713.303635263683, 11366.886331136582, 11607.941960290145, 11650.766984660258, 11696.298222106701, 618.4650277509921, 633.5628416392766, 638.1990601794811, 650.7494614573424, 665.5008743442418, 5224.216367544823, 5247.842564723064, 5320.494553017457, 5328.973355133199, 5447.972760136253, 102675.48662256642, 103637.0, 103934.0, 105051.0, 106805.39791903128, 80712.0, 90707.0, 95455.06811648543, 95551.106606689, 96871.0, 75426.0, 77528.61235693785, 78019.60990195013, 79016.0, 79609.60195198987, 9588.616455341707, 10257.230707696803, 10606.681799546026, 11249.550017999189, 11550.306981581132, 38306.0, 38771.0, 38807.61192388153, 40082.799586001885, 41473.0, 42988.35517467178, 48743.51256487532, 48837.51162488329, 49303.0, 50654.74672626613, 15497.07017578949, 15500.069995800288, 15636.0, 15760.211989400714, 15789.0, 17590.0, 17752.0, 17777.0, 18111.094445277948, 18166.273349066418, 13912.791308130589, 13972.580822575339, 13976.09155404936, 14090.36593353281, 14106.576802695936, 15343.46297879569, 15588.532344029698, 15732.606684832514, 15886.285117169524, 15911.602209944844, 15257.237138143271, 15257.6185595361, 15419.537413877602, 15463.5360939172, 15537.378504859678, 11507.827382589436, 11725.472353743931, 11809.05527557776, 11924.463399147233, 11924.821127683264, 11535.538578457103, 11602.83971602833, 12238.204516706386, 12367.876321237032, 12417.19288246261], "value": 7935.916325122299, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1452.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 111.0, 112.0, 111.0, 112.0, 111.0, 111.0, 110.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 108.0, 150.0, 111.0, 109.0, 109.0, 110.0, 137.0, 109.0], "value": 120.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 185.0, 186.0, 198.0, 267.0, 185.0, 184.0, 184.0, 181.0], "value": 193.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 60.0, 77.0, 119.0, 86.0, 60.0, 62.0, 60.0, 81.0, 84.0], "value": 76.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 85.0, 68.0, 68.0, 69.0, 91.0, 68.0, 69.0, 89.0], "value": 76.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 88.0, 88.0, 88.0, 88.0, 88.0, 88.0, 88.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 94.0, 95.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 86.0, 84.0, 85.0, 86.0, 84.0, 83.0, 83.0, 86.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 51.0, 48.0, 49.0, 50.0, 50.0, 49.0, 48.0, 50.0], "value": 49.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 60.0, 59.0, 71.0, 65.0, 62.0, 59.0, 59.0, 59.0, 59.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 83.0, 83.0, 83.0, 83.0, 83.0, 82.0, 83.0, 83.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 139.0, 138.0, 123.0, 128.0, 142.0, 140.0, 149.0, 197.0, 141.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 189.0, 231.0, 187.0, 183.0, 184.0, 185.0, 184.0, 180.0, 190.0], "value": 190.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 65.0, 81.0, 91.0, 92.0, 94.0, 93.0, 68.0], "value": 78.9, "unit": "score"}]}]} 05:34:06 INFO - Return code: 0 05:34:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:34:06 ERROR - # TBPL SUCCESS # 05:34:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:34:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:34:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:34:06 INFO - 2017-04-18 05:34:06.147 screenresolution[1663:10534] starting screenresolution argv=screenresolution get 05:34:06 INFO - 2017-04-18 05:34:06.150 screenresolution[1663:10534] Display 0: 1600x1200x32@60 05:34:06 INFO - 2017-04-18 05:34:06.156 screenresolution[1664:10537] starting screenresolution argv=screenresolution list 05:34:06 INFO - Available Modes on Display 0 05:34:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:34:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:34:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:34:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:34:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:34:06 INFO - Intel Iris: 05:34:06 INFO - Chipset Model: Intel Iris 05:34:06 INFO - Type: GPU 05:34:06 INFO - Bus: Built-In 05:34:06 INFO - VRAM (Dynamic, Max): 1536 MB 05:34:06 INFO - Vendor: Intel (0x8086) 05:34:06 INFO - Device ID: 0x0a2e 05:34:06 INFO - Revision ID: 0x0009 05:34:06 INFO - Displays: 05:34:06 INFO - Display: 05:34:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:34:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:34:06 INFO - Display Serial Number: 1600x1200 60 05:34:06 INFO - Main Display: Yes 05:34:06 INFO - Mirror: Off 05:34:06 INFO - Online: Yes 05:34:06 INFO - Rotation: Supported 05:34:06 INFO - Return code: 0 05:34:06 INFO - Running post-action listener: _resource_record_post_action 05:34:06 INFO - [mozharness: 2017-04-18 12:34:06.392527Z] Finished run-tests step (success) 05:34:06 INFO - Running post-run listener: _resource_record_post_run 05:34:06 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 32988672; Write bytes: 517630464; Read time: 202; Write time: 1617 05:34:06 INFO - TinderboxPrint: CPU usage
53.4% 05:34:06 INFO - TinderboxPrint: I/O read bytes / time
32,988,672 / 202 05:34:06 INFO - TinderboxPrint: I/O write bytes / time
517,630,464 / 1,617 05:34:06 INFO - TinderboxPrint: CPU idle
2,238.7 (46.6%) 05:34:06 INFO - TinderboxPrint: CPU system
960.4 (20.0%) 05:34:06 INFO - TinderboxPrint: CPU user
1,606.6 (33.4%) 05:34:06 INFO - TinderboxPrint: Swap in / out
238,059,520 / 0 05:34:06 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209553920; Write bytes: 205669888; Read time: 16161; Write time: 454 05:34:06 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 30846464; Write bytes: 304882688; Read time: 181; Write time: 1133 05:34:06 INFO - Running post-run listener: _upload_blobber_files 05:34:06 INFO - Blob upload gear active. 05:34:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:34:06 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 05:34:06 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'] 05:34:06 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 05:34:07 INFO - (blobuploader) - INFO - Open directory for files ... 05:34:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:34:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:34:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:08 INFO - (blobuploader) - INFO - Done attempting. 05:34:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:34:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:34:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:09 INFO - (blobuploader) - INFO - Done attempting. 05:34:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:34:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:34:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:10 INFO - (blobuploader) - INFO - Done attempting. 05:34:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:34:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:34:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:12 INFO - (blobuploader) - INFO - Done attempting. 05:34:12 INFO - (blobuploader) - INFO - Iteration through files over. 05:34:12 INFO - Return code: 0 05:34:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:34:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:34:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c633048891f7133e404e75d467105263725c1d7f87a3c16ef4541d729d2f31d0eea8c87efe793ee5ee263e7785f715507cf5cb768e80a670daa22f348471f0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5f319c160a1d2f18ec00731765103acb8925845041cf69e89c5db83deeb721332c702ba125a1eec52e1c1d922dcccd401d15f317e60d9ff2c39b33e6e080c6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c834c3dff0bd6f31f635beb594be3d311049d3286d7ca524212198f78e4abea6c6ead8326c7f9a6f522d1c0d2415f138215b75913e5aae89c310285bfd3d7399", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/521c219656defaa82ae0608809667049b650d82217a45f312e5f69ac2624a0f1c08ad1698654f684d1ade142945f2f12b78e14ecddbaf8f69d8c35cec649f30b"} 05:34:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:34:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:34:12 INFO - Contents: 05:34:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c633048891f7133e404e75d467105263725c1d7f87a3c16ef4541d729d2f31d0eea8c87efe793ee5ee263e7785f715507cf5cb768e80a670daa22f348471f0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5f319c160a1d2f18ec00731765103acb8925845041cf69e89c5db83deeb721332c702ba125a1eec52e1c1d922dcccd401d15f317e60d9ff2c39b33e6e080c6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c834c3dff0bd6f31f635beb594be3d311049d3286d7ca524212198f78e4abea6c6ead8326c7f9a6f522d1c0d2415f138215b75913e5aae89c310285bfd3d7399", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/521c219656defaa82ae0608809667049b650d82217a45f312e5f69ac2624a0f1c08ad1698654f684d1ade142945f2f12b78e14ecddbaf8f69d8c35cec649f30b"} 05:34:12 INFO - Running post-run listener: copy_logs_to_upload_dir 05:34:12 INFO - Copying logs to upload dir... 05:34:12 INFO - mkdir: /builds/slave/test/build/upload/logs 05:34:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.121503 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-04-18 05:34:12.307044) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 05:34:12.312966) ========= 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.h5XtUHtnzu/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.GZJat8tUn0/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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/0c633048891f7133e404e75d467105263725c1d7f87a3c16ef4541d729d2f31d0eea8c87efe793ee5ee263e7785f715507cf5cb768e80a670daa22f348471f0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5f319c160a1d2f18ec00731765103acb8925845041cf69e89c5db83deeb721332c702ba125a1eec52e1c1d922dcccd401d15f317e60d9ff2c39b33e6e080c6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c834c3dff0bd6f31f635beb594be3d311049d3286d7ca524212198f78e4abea6c6ead8326c7f9a6f522d1c0d2415f138215b75913e5aae89c310285bfd3d7399", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/521c219656defaa82ae0608809667049b650d82217a45f312e5f69ac2624a0f1c08ad1698654f684d1ade142945f2f12b78e14ecddbaf8f69d8c35cec649f30b"} build_url:https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/DMG30y4CSueeRiDT-Lkvwg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c633048891f7133e404e75d467105263725c1d7f87a3c16ef4541d729d2f31d0eea8c87efe793ee5ee263e7785f715507cf5cb768e80a670daa22f348471f0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5f319c160a1d2f18ec00731765103acb8925845041cf69e89c5db83deeb721332c702ba125a1eec52e1c1d922dcccd401d15f317e60d9ff2c39b33e6e080c6c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c834c3dff0bd6f31f635beb594be3d311049d3286d7ca524212198f78e4abea6c6ead8326c7f9a6f522d1c0d2415f138215b75913e5aae89c310285bfd3d7399", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/521c219656defaa82ae0608809667049b650d82217a45f312e5f69ac2624a0f1c08ad1698654f684d1ade142945f2f12b78e14ecddbaf8f69d8c35cec649f30b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 05:34:12.352160) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 05:34:12.352542) ========= 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.h5XtUHtnzu/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.GZJat8tUn0/Listeners TMPDIR=/var/folders/vs/y0ftz2f17fq_g0l29r50mgb800000w/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.005457 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 05:34:12.401462) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 05:34:12.401892) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 05:34:12.402429) ========= ========= Total master_lag: 0.19 =========