builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0222 starttime: 1484035854.95 results: success (0) buildid: 20170109211108 builduid: c50c174bd31f49f4a16782e0834eaf32 revision: 3218ea763746c4ddef980b9095dc04ade8abe4b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 00:10:54.950141) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-10 00:10:54.950592) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 00:10:54.950866) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-10 00:10:54.974863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 00:10:54.975200) ========= 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.Tvo3C1ZFJm/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.P2IwB3BFy5/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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-01-10 00:10:54-- 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% 33.1M=0s 2017-01-10 00:10:55 (33.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.584061 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 00:10:55.611799) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 00:10:55.612184) ========= 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.Tvo3C1ZFJm/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.P2IwB3BFy5/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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.026195 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 00:10:55.736180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-10 00:10:55.736521) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3218ea763746c4ddef980b9095dc04ade8abe4b0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3218ea763746c4ddef980b9095dc04ade8abe4b0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Tvo3C1ZFJm/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.P2IwB3BFy5/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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-01-10 00:10:55,843 truncating revision to first 12 chars 2017-01-10 00:10:55,843 Setting DEBUG logging. 2017-01-10 00:10:55,843 attempt 1/10 2017-01-10 00:10:55,843 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3218ea763746?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-10 00:10:56,579 unpacking tar archive at: mozilla-beta-3218ea763746/testing/mozharness/ program finished with exit code 0 elapsedTime=1.039337 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-10 00:10:56.806165) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 00:10:56.806518) ========= script_repo_revision: 3218ea763746c4ddef980b9095dc04ade8abe4b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-10 00:10:56.806891) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 00:10:56.807175) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-10 00:10:56.831670) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-01-10 00:10:56.832067) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Tvo3C1ZFJm/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.P2IwB3BFy5/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:10:57 INFO - MultiFileLogger online at 20170110 00:10:57 in /builds/slave/test 00:10:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 00:10:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:10:57 INFO - {'append_to_log': False, 00:10:57 INFO - 'base_work_dir': '/builds/slave/test', 00:10:57 INFO - 'blob_upload_branch': 'Mozilla-Beta', 00:10:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:10:57 INFO - 'branch': 'Mozilla-Beta', 00:10:57 INFO - 'buildbot_json_path': 'buildprops.json', 00:10:57 INFO - 'config_files': ('talos/mac_config.py',), 00:10:57 INFO - 'default_actions': ('clobber', 00:10:57 INFO - 'read-buildbot-config', 00:10:57 INFO - 'download-and-extract', 00:10:57 INFO - 'populate-webroot', 00:10:57 INFO - 'create-virtualenv', 00:10:57 INFO - 'install', 00:10:57 INFO - 'run-tests'), 00:10:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:10:57 INFO - 'download_minidump_stackwalk': True, 00:10:57 INFO - 'download_symbols': 'ondemand', 00:10:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:10:57 INFO - 'tooltool.py': '/tools/tooltool.py', 00:10:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:10:57 INFO - '/tools/misc-python/virtualenv.py')}, 00:10:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:10:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:10:57 INFO - 'installer_path': 'installer.exe', 00:10:57 INFO - 'log_level': 'info', 00:10:57 INFO - 'log_name': 'talos', 00:10:57 INFO - 'log_to_console': True, 00:10:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:10:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:10:57 INFO - 'opt_config_files': (), 00:10:57 INFO - 'pip_index': False, 00:10:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:10:57 INFO - 'cmd': ('bash', 00:10:57 INFO - '-c', 00:10:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:10:57 INFO - 'enabled': True, 00:10:57 INFO - 'halt_on_failure': False, 00:10:57 INFO - 'name': 'check_screen_resolution'},), 00:10:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:10:57 INFO - 'cmd': ('bash', 00:10:57 INFO - '-c', 00:10:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:10:57 INFO - 'enabled': True, 00:10:57 INFO - 'halt_on_failure': False, 00:10:57 INFO - 'name': 'check_screen_resolution'},), 00:10:57 INFO - 'run_cmd_checks_enabled': True, 00:10:57 INFO - 'sps_profile': False, 00:10:57 INFO - 'sps_profile_interval': 0, 00:10:57 INFO - 'suite': 'dromaeojs', 00:10:57 INFO - 'system_bits': '32', 00:10:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:10:57 INFO - 'title': 't-yosemite-r7-0222', 00:10:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:10:57 INFO - 'use_talos_json': True, 00:10:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:10:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:10:57 INFO - 'work_dir': 'build'} 00:10:57 INFO - [mozharness: 2017-01-10 08:10:57.030114Z] Running clobber step. 00:10:57 INFO - Running pre-action listener: _resource_record_pre_action 00:10:57 INFO - Running main action method: clobber 00:10:57 INFO - rmtree: /builds/slave/test/build 00:10:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:10:59 INFO - Running post-action listener: _resource_record_post_action 00:10:59 INFO - [mozharness: 2017-01-10 08:10:59.401903Z] Finished clobber step (success) 00:10:59 INFO - [mozharness: 2017-01-10 08:10:59.402029Z] Running read-buildbot-config step. 00:10:59 INFO - Running pre-action listener: _resource_record_pre_action 00:10:59 INFO - Running main action method: read_buildbot_config 00:10:59 INFO - Using buildbot properties: 00:10:59 INFO - { 00:10:59 INFO - "project": "", 00:10:59 INFO - "product": "firefox", 00:10:59 INFO - "script_repo_revision": "production", 00:10:59 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 00:10:59 INFO - "repository": "", 00:10:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 00:10:59 INFO - "buildid": "20170109211108", 00:10:59 INFO - "pgo_build": "False", 00:10:59 INFO - "basedir": "/builds/slave/test", 00:10:59 INFO - "buildnumber": 5, 00:10:59 INFO - "slavename": "t-yosemite-r7-0222", 00:10:59 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 00:10:59 INFO - "platform": "yosemite_r7", 00:10:59 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 00:10:59 INFO - "branch": "mozilla-beta", 00:10:59 INFO - "repo_path": "releases/mozilla-beta", 00:10:59 INFO - "revision": "3218ea763746c4ddef980b9095dc04ade8abe4b0", 00:10:59 INFO - "stage_platform": "macosx64", 00:10:59 INFO - "builduid": "c50c174bd31f49f4a16782e0834eaf32", 00:10:59 INFO - "slavebuilddir": "test" 00:10:59 INFO - } 00:10:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 00:10:59 INFO - Running post-action listener: _resource_record_post_action 00:10:59 INFO - [mozharness: 2017-01-10 08:10:59.405408Z] Finished read-buildbot-config step (success) 00:10:59 INFO - [mozharness: 2017-01-10 08:10:59.405539Z] Running download-and-extract step. 00:10:59 INFO - Running pre-action listener: _resource_record_pre_action 00:10:59 INFO - Running main action method: download_and_extract 00:10:59 INFO - mkdir: /builds/slave/test/build/tests 00:10:59 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')]} 00:10:59 INFO - trying https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 00:10:59 INFO - Downloading https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 00:10:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 00:11:00 INFO - Downloaded 1165 bytes. 00:11:00 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 00:11:00 INFO - Using the following test package requirements: 00:11:00 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 00:11:00 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 00:11:00 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 00:11:00 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 00:11:00 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 00:11:00 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 00:11:00 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 00:11:00 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 00:11:00 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 00:11:00 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 00:11:00 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 00:11:00 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 00:11:00 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 00:11:00 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 00:11:00 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 00:11:00 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 00:11:00 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 00:11:00 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 00:11:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 00:11:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 00:11:00 INFO - Fetch https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 00:11:00 INFO - Expected file size: 16234543 00:11:07 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 00:11:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 00:11:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 00:11:07 INFO - Fetch https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 00:11:08 INFO - Expected file size: 16234543 00:11:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 00:11:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 00:11:14 INFO - Fetch https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 00:11:15 INFO - Expected file size: 14414089 00:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:11:16 INFO - trying https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 00:11:16 INFO - Downloading https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 00:11:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 00:11:18 INFO - Downloaded 86139286 bytes. 00:11:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 00:11:18 INFO - mkdir: /builds/slave/test/properties 00:11:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:11:18 INFO - Writing to file /builds/slave/test/properties/build_url 00:11:18 INFO - Contents: 00:11:18 INFO - build_url:https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 00:11:19 INFO - Running post-action listener: _resource_record_post_action 00:11:19 INFO - Running post-action listener: set_extra_try_arguments 00:11:19 INFO - [mozharness: 2017-01-10 08:11:19.556473Z] Finished download-and-extract step (success) 00:11:19 INFO - [mozharness: 2017-01-10 08:11:19.556615Z] Running populate-webroot step. 00:11:19 INFO - Running pre-action listener: _resource_record_pre_action 00:11:19 INFO - Running main action method: populate_webroot 00:11:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:11:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:11:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:11:19 INFO - '--tppagecycles', 00:11:19 INFO - '7'], 00:11:19 INFO - 'tests': ['tsvgm']}}, 00:11:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:11:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:11:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:11:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:11:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:11:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:11:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:11:19 INFO - 'talos_options': ['--disable-e10s'], 00:11:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:11:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:11:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:11:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:11:19 INFO - 'talos_options': ['--disable-e10s'], 00:11:19 INFO - 'tests': ['damp', 'tps']}, 00:11:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:11:19 INFO - 'tests': ['damp', 'tps']}, 00:11:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:11:19 INFO - 'tests': ['dromaeo_dom']}, 00:11:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:11:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:11:19 INFO - 'tests': ['basic_compositor_video']}, 00:11:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:11:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:11:19 INFO - 'tests': ['a11yr', 00:11:19 INFO - 'ts_paint', 00:11:19 INFO - 'tpaint', 00:11:19 INFO - 'sessionrestore', 00:11:19 INFO - 'sessionrestore_no_auto_restore', 00:11:19 INFO - 'tabpaint']}, 00:11:19 INFO - 'other-e10s': {'tests': ['a11yr', 00:11:19 INFO - 'ts_paint', 00:11:19 INFO - 'tpaint', 00:11:19 INFO - 'sessionrestore', 00:11:19 INFO - 'sessionrestore_no_auto_restore', 00:11:19 INFO - 'tabpaint']}, 00:11:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:11:19 INFO - 'ts_paint', 00:11:19 INFO - 'tpaint', 00:11:19 INFO - 'sessionrestore', 00:11:19 INFO - 'sessionrestore_no_auto_restore', 00:11:19 INFO - 'tabpaint']}, 00:11:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:11:19 INFO - 'ts_paint', 00:11:19 INFO - 'tpaint', 00:11:19 INFO - 'sessionrestore', 00:11:19 INFO - 'sessionrestore_no_auto_restore', 00:11:19 INFO - 'tabpaint']}, 00:11:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:11:19 INFO - 'tests': ['a11yr', 00:11:19 INFO - 'ts_paint', 00:11:19 INFO - 'tpaint', 00:11:19 INFO - 'sessionrestore', 00:11:19 INFO - 'sessionrestore_no_auto_restore', 00:11:19 INFO - 'tabpaint']}, 00:11:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:11:19 INFO - 'tests': ['a11yr', 00:11:19 INFO - 'ts_paint', 00:11:19 INFO - 'tpaint', 00:11:19 INFO - 'sessionrestore', 00:11:19 INFO - 'sessionrestore_no_auto_restore', 00:11:19 INFO - 'tabpaint']}, 00:11:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:11:19 INFO - 'tests': ['tsvgx', 00:11:19 INFO - 'tsvgr_opacity', 00:11:19 INFO - 'tart', 00:11:19 INFO - 'tscrollx', 00:11:19 INFO - 'cart']}, 00:11:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:11:19 INFO - 'tsvgr_opacity', 00:11:19 INFO - 'tart', 00:11:19 INFO - 'tscrollx', 00:11:19 INFO - 'cart']}, 00:11:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:11:19 INFO - 'talos_options': ['--disable-e10s'], 00:11:19 INFO - 'tests': ['tp5o']}, 00:11:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:11:19 INFO - 'tests': ['tp5o']}, 00:11:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:11:19 INFO - 'talos_options': ['--disable-e10s', 00:11:19 INFO - '--xperf_path', 00:11:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:11:19 INFO - 'tests': ['tp5n']}, 00:11:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:11:19 INFO - 'talos_options': ['--xperf_path', 00:11:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:11:19 INFO - 'tests': ['tp5n']}}, 00:11:19 INFO - 'talos.zip': {'path': '', 00:11:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:11:19 INFO - Running post-action listener: _resource_record_post_action 00:11:19 INFO - [mozharness: 2017-01-10 08:11:19.574905Z] Finished populate-webroot step (success) 00:11:19 INFO - [mozharness: 2017-01-10 08:11:19.575029Z] Running create-virtualenv step. 00:11:19 INFO - Running pre-action listener: _resource_record_pre_action 00:11:19 INFO - Running main action method: create_virtualenv 00:11:19 INFO - Creating virtualenv /builds/slave/test/build/venv 00:11:19 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 00:11:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:11:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:11:19 INFO - Using real prefix '/tools/python27' 00:11:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:11:20 INFO - Installing distribute.............................................................................................................................................................................................done. 00:11:23 INFO - Installing pip.................done. 00:11:23 INFO - Return code: 0 00:11:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:23 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 0x100b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ad5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feee1579a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100973d30>, '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 0x1007d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10096bb20>, '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.Tvo3C1ZFJm/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.P2IwB3BFy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:11:23 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 00:11:23 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 00:11:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tvo3C1ZFJm/Render', 00:11:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:11:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:11:23 INFO - 'HOME': '/Users/cltbld', 00:11:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:11:23 INFO - 'LOGNAME': 'cltbld', 00:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:11:23 INFO - 'MOZ_NO_REMOTE': '1', 00:11:23 INFO - 'NO_EM_RESTART': '1', 00:11:23 INFO - 'PAGER': '/bin/cat', 00:11:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:11:23 INFO - 'PWD': '/builds/slave/test', 00:11:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:11:23 INFO - 'SHELL': '/bin/bash', 00:11:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2IwB3BFy5/Listeners', 00:11:23 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:11:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:11:23 INFO - 'USER': 'cltbld', 00:11:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:11:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:11:23 INFO - 'XPC_FLAGS': '0x0', 00:11:23 INFO - 'XPC_SERVICE_NAME': '0', 00:11:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:11:23 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 00:11:23 INFO - Cleaning up... 00:11:23 INFO - Return code: 0 00:11:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:23 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 0x100b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ad5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feee1579a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100973d30>, '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 0x1007d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10096bb20>, '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.Tvo3C1ZFJm/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.P2IwB3BFy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:11:23 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 00:11:23 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 00:11:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tvo3C1ZFJm/Render', 00:11:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:11:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:11:23 INFO - 'HOME': '/Users/cltbld', 00:11:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:11:23 INFO - 'LOGNAME': 'cltbld', 00:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:11:23 INFO - 'MOZ_NO_REMOTE': '1', 00:11:23 INFO - 'NO_EM_RESTART': '1', 00:11:23 INFO - 'PAGER': '/bin/cat', 00:11:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:11:23 INFO - 'PWD': '/builds/slave/test', 00:11:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:11:23 INFO - 'SHELL': '/bin/bash', 00:11:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2IwB3BFy5/Listeners', 00:11:23 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:11:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:11:23 INFO - 'USER': 'cltbld', 00:11:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:11:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:11:23 INFO - 'XPC_FLAGS': '0x0', 00:11:23 INFO - 'XPC_SERVICE_NAME': '0', 00:11:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:11:23 INFO - Downloading/unpacking psutil>=3.1.1 00:11:23 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 00:11:23 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 00:11:23 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 00:11:23 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 00:11:23 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 00:11:23 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 00:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:11:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:11:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:11:27 INFO - Installing collected packages: psutil 00:11:27 INFO - Running setup.py install for psutil 00:11:27 INFO - building 'psutil._psutil_osx' extension 00:11:27 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 00:11:28 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 00:11:28 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 00:11:28 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 00:11:28 INFO - building 'psutil._psutil_posix' extension 00:11:28 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 00:11:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:11:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:11:28 INFO - ^ 00:11:28 INFO - 1 warning generated. 00:11:28 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 00:11:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:11:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:11:28 INFO - Successfully installed psutil 00:11:28 INFO - Cleaning up... 00:11:28 INFO - Return code: 0 00:11:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:11: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')]} 00:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11: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')]} 00:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ad5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feee1579a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100973d30>, '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 0x1007d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10096bb20>, '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.Tvo3C1ZFJm/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.P2IwB3BFy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:11:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tvo3C1ZFJm/Render', 00:11:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:11:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:11:28 INFO - 'HOME': '/Users/cltbld', 00:11:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:11:28 INFO - 'LOGNAME': 'cltbld', 00:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:11:28 INFO - 'MOZ_NO_REMOTE': '1', 00:11:28 INFO - 'NO_EM_RESTART': '1', 00:11:28 INFO - 'PAGER': '/bin/cat', 00:11:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:11:28 INFO - 'PWD': '/builds/slave/test', 00:11:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:11:28 INFO - 'SHELL': '/bin/bash', 00:11:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2IwB3BFy5/Listeners', 00:11:28 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:11:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:11:28 INFO - 'USER': 'cltbld', 00:11:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:11:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:11:28 INFO - 'XPC_FLAGS': '0x0', 00:11:28 INFO - 'XPC_SERVICE_NAME': '0', 00:11:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:11:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:11:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:11:31 INFO - Installing collected packages: mozsystemmonitor 00:11:31 INFO - Running setup.py install for mozsystemmonitor 00:11:32 INFO - Successfully installed mozsystemmonitor 00:11:32 INFO - Cleaning up... 00:11:32 INFO - Return code: 0 00:11:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:11:32 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')]} 00:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:32 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')]} 00:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:32 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 0x100b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ad5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feee1579a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100973d30>, '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 0x1007d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10096bb20>, '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.Tvo3C1ZFJm/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.P2IwB3BFy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:11:32 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 00:11:32 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 00:11:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tvo3C1ZFJm/Render', 00:11:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:11:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:11:32 INFO - 'HOME': '/Users/cltbld', 00:11:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:11:32 INFO - 'LOGNAME': 'cltbld', 00:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:11:32 INFO - 'MOZ_NO_REMOTE': '1', 00:11:32 INFO - 'NO_EM_RESTART': '1', 00:11:32 INFO - 'PAGER': '/bin/cat', 00:11:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:11:32 INFO - 'PWD': '/builds/slave/test', 00:11:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:11:32 INFO - 'SHELL': '/bin/bash', 00:11:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2IwB3BFy5/Listeners', 00:11:32 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:11:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:11:32 INFO - 'USER': 'cltbld', 00:11:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:11:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:11:32 INFO - 'XPC_FLAGS': '0x0', 00:11:32 INFO - 'XPC_SERVICE_NAME': '0', 00:11:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:11:32 INFO - Downloading/unpacking jsonschema==2.5.1 00:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:11:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:11:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:11:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:11:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:11:35 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 00:11:35 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 00:11:35 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 00:11:35 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 00:11:35 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 00:11:35 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 00:11:35 INFO - Downloading functools32-3.2.3-2.tar.gz 00:11:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:11:35 INFO - warning: no files found matching '*.txt' 00:11:35 INFO - no previously-included directories found matching 'build' 00:11:35 INFO - no previously-included directories found matching 'dist' 00:11:35 INFO - no previously-included directories found matching '.git*' 00:11:35 INFO - Installing collected packages: jsonschema, functools32 00:11:35 INFO - Running setup.py install for functools32 00:11:35 INFO - warning: no files found matching '*.txt' 00:11:35 INFO - no previously-included directories found matching 'build' 00:11:35 INFO - no previously-included directories found matching 'dist' 00:11:35 INFO - no previously-included directories found matching '.git*' 00:11:35 INFO - Successfully installed jsonschema functools32 00:11:35 INFO - Cleaning up... 00:11:35 INFO - Return code: 0 00:11:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:11: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')]} 00:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11: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')]} 00:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11: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', '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 0x100b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ad5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feee1579a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100973d30>, '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 0x1007d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10096bb20>, '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.Tvo3C1ZFJm/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.P2IwB3BFy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:11: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:11: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 functools32==3.2.3-2 00:11:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tvo3C1ZFJm/Render', 00:11:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:11:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:11:35 INFO - 'HOME': '/Users/cltbld', 00:11:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:11:35 INFO - 'LOGNAME': 'cltbld', 00:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:11:35 INFO - 'MOZ_NO_REMOTE': '1', 00:11:35 INFO - 'NO_EM_RESTART': '1', 00:11:35 INFO - 'PAGER': '/bin/cat', 00:11:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:11:35 INFO - 'PWD': '/builds/slave/test', 00:11:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:11:35 INFO - 'SHELL': '/bin/bash', 00:11:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2IwB3BFy5/Listeners', 00:11:35 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:11:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:11:35 INFO - 'USER': 'cltbld', 00:11:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:11:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:11:35 INFO - 'XPC_FLAGS': '0x0', 00:11:35 INFO - 'XPC_SERVICE_NAME': '0', 00:11:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:11:36 INFO - Cleaning up... 00:11:36 INFO - Return code: 0 00:11:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:11: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')]} 00:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11: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')]} 00:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11: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', '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 0x100b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ad5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feee1579a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100973d30>, '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 0x1007d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10096bb20>, '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.Tvo3C1ZFJm/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.P2IwB3BFy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:11: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:11: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 blobuploader==1.2.4 00:11:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tvo3C1ZFJm/Render', 00:11:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:11:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:11:36 INFO - 'HOME': '/Users/cltbld', 00:11:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:11:36 INFO - 'LOGNAME': 'cltbld', 00:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:11:36 INFO - 'MOZ_NO_REMOTE': '1', 00:11:36 INFO - 'NO_EM_RESTART': '1', 00:11:36 INFO - 'PAGER': '/bin/cat', 00:11:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:11:36 INFO - 'PWD': '/builds/slave/test', 00:11:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:11:36 INFO - 'SHELL': '/bin/bash', 00:11:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2IwB3BFy5/Listeners', 00:11:36 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:11:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:11:36 INFO - 'USER': 'cltbld', 00:11:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:11:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:11:36 INFO - 'XPC_FLAGS': '0x0', 00:11:36 INFO - 'XPC_SERVICE_NAME': '0', 00:11:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:11:36 INFO - Downloading/unpacking blobuploader==1.2.4 00:11: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 00:11: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 00:11: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 00:11: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 00:11: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 00:11: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 00:11:39 INFO - Downloading blobuploader-1.2.4.tar.gz 00:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:11:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:11:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:11:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:11:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:11:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:11:40 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 00:11:40 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 00:11:40 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 00:11:40 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 00:11:40 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 00:11:40 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 00:11:40 INFO - Downloading docopt-0.6.1.tar.gz 00:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:11:40 INFO - Installing collected packages: blobuploader, requests, docopt 00:11:40 INFO - Running setup.py install for blobuploader 00:11:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:11:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:11:41 INFO - Running setup.py install for requests 00:11:41 INFO - Running setup.py install for docopt 00:11:41 INFO - Successfully installed blobuploader requests docopt 00:11:41 INFO - Cleaning up... 00:11:41 INFO - Return code: 0 00:11:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:11: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')]} 00:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11: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')]} 00:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:41 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 0x100b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ad5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feee1579a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100973d30>, '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 0x1007d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10096bb20>, '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.Tvo3C1ZFJm/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.P2IwB3BFy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:11:41 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 00:11:41 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 00:11:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tvo3C1ZFJm/Render', 00:11:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:11:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:11:41 INFO - 'HOME': '/Users/cltbld', 00:11:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:11:41 INFO - 'LOGNAME': 'cltbld', 00:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:11:41 INFO - 'MOZ_NO_REMOTE': '1', 00:11:41 INFO - 'NO_EM_RESTART': '1', 00:11:41 INFO - 'PAGER': '/bin/cat', 00:11:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:11:41 INFO - 'PWD': '/builds/slave/test', 00:11:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:11:41 INFO - 'SHELL': '/bin/bash', 00:11:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2IwB3BFy5/Listeners', 00:11:41 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:11:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:11:41 INFO - 'USER': 'cltbld', 00:11:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:11:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:11:41 INFO - 'XPC_FLAGS': '0x0', 00:11:41 INFO - 'XPC_SERVICE_NAME': '0', 00:11:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:11:41 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-hlhJFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:11:42 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-kltY0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:11:42 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-A98C0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:11:42 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-eMe8em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:11:42 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-5gQRwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:11:42 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-51IKct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:11:42 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-OrrADk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:11:42 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-Nd0_r5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:11:42 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-aVO85C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:11:42 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-tgT0W_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:11:43 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-GdmjuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:11:43 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-0CYUct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:11:43 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-X3g3HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:11:43 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-b3KnZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:11:43 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-AB2AjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:11:43 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-NSJw8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:11:43 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-hvC6bB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:11:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:11:43 INFO - Running setup.py install for manifestparser 00:11:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:11:43 INFO - Running setup.py install for mozcrash 00:11:44 INFO - Running setup.py install for mozdebug 00:11:44 INFO - Running setup.py install for mozdevice 00:11:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:11:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:11:44 INFO - Running setup.py install for mozfile 00:11:44 INFO - Running setup.py install for mozhttpd 00:11:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:11:44 INFO - Running setup.py install for mozinfo 00:11:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:11:44 INFO - Running setup.py install for mozInstall 00:11:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:11:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:11:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:11:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:11:44 INFO - Running setup.py install for mozleak 00:11:45 INFO - Running setup.py install for mozlog 00:11:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:11:45 INFO - Running setup.py install for moznetwork 00:11:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:11:45 INFO - Running setup.py install for mozprocess 00:11:45 INFO - Running setup.py install for mozprofile 00:11:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:11:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:11:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:11:45 INFO - Running setup.py install for mozrunner 00:11:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:11:45 INFO - Running setup.py install for mozscreenshot 00:11:46 INFO - Running setup.py install for moztest 00:11:46 INFO - Running setup.py install for mozversion 00:11:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:11:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:11:46 INFO - Cleaning up... 00:11:46 INFO - Return code: 0 00:11:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:46 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 0x100b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ad5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feee1579a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100973d30>, '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 0x1007d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10096bb20>, '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.Tvo3C1ZFJm/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.P2IwB3BFy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:11:46 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 00:11:46 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 00:11:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tvo3C1ZFJm/Render', 00:11:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:11:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:11:46 INFO - 'HOME': '/Users/cltbld', 00:11:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:11:46 INFO - 'LOGNAME': 'cltbld', 00:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:11:46 INFO - 'MOZ_NO_REMOTE': '1', 00:11:46 INFO - 'NO_EM_RESTART': '1', 00:11:46 INFO - 'PAGER': '/bin/cat', 00:11:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:11:46 INFO - 'PWD': '/builds/slave/test', 00:11:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:11:46 INFO - 'SHELL': '/bin/bash', 00:11:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2IwB3BFy5/Listeners', 00:11:46 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:11:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:11:46 INFO - 'USER': 'cltbld', 00:11:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:11:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:11:46 INFO - 'XPC_FLAGS': '0x0', 00:11:46 INFO - 'XPC_SERVICE_NAME': '0', 00:11:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:11:46 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-4hdVrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:11:46 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)) 00:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:11:46 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-qkfYhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 00:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:11:46 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-GJkQPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:11:46 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)) 00:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:11:46 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-mtAk1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 00:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:11:47 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-VyA8rC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:11:47 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)) 00:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:11:47 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-z0S7PW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:11:47 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)) 00:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:11:47 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-bEMYpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:11:47 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)) 00:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:11:47 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-2d8jAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:11:47 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)) 00:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:11:47 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-FbAmlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:11:47 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)) 00:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:11:47 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-CLTk7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:11:47 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)) 00:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:11:47 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-K4DgC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:11:47 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)) 00:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:11:47 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-5vtgnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:11:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 00:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:11:47 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-_Fj0F3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:11:47 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)) 00:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:11:47 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-aX6Mwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 00:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:11:48 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-_pYqv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:11:48 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)) 00:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:11:48 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-tvCJiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 00:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:11:48 INFO - Running setup.py (path:/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/pip-uHOLqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:11:48 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)) 00:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:11:48 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)) 00:11:48 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:11:48 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:11:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:11: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 00:11: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 00:11: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 00:11: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 00:11: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 00:11: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 00:11:51 INFO - Downloading blessings-1.6.tar.gz 00:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:11:51 INFO - Installing collected packages: blessings 00:11:51 INFO - Running setup.py install for blessings 00:11:51 INFO - Successfully installed blessings 00:11:51 INFO - Cleaning up... 00:11:51 INFO - Return code: 0 00:11:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:11:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:11:51 INFO - Reading from file tmpfile_stdout 00:11:51 INFO - Current package versions: 00:11:51 INFO - blessings == 1.6 00:11:51 INFO - blobuploader == 1.2.4 00:11:51 INFO - docopt == 0.6.1 00:11:51 INFO - functools32 == 3.2.3-2 00:11:51 INFO - jsonschema == 2.5.1 00:11:51 INFO - manifestparser == 1.1 00:11:51 INFO - mozInstall == 1.12 00:11:51 INFO - mozcrash == 0.17 00:11:51 INFO - mozdebug == 0.1 00:11:51 INFO - mozdevice == 0.48 00:11:51 INFO - mozfile == 1.2 00:11:51 INFO - mozhttpd == 0.7 00:11:51 INFO - mozinfo == 0.9 00:11:51 INFO - mozleak == 0.1 00:11:51 INFO - mozlog == 3.4 00:11:51 INFO - moznetwork == 0.27 00:11:51 INFO - mozprocess == 0.23 00:11:51 INFO - mozprofile == 0.28 00:11:51 INFO - mozrunner == 6.12 00:11:51 INFO - mozscreenshot == 0.1 00:11:51 INFO - mozsystemmonitor == 0.3 00:11:51 INFO - moztest == 0.7 00:11:51 INFO - mozversion == 1.4 00:11:51 INFO - psutil == 3.1.1 00:11:51 INFO - requests == 1.2.3 00:11:51 INFO - wsgiref == 0.1.2 00:11:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:11:51 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')]} 00:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:51 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')]} 00:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:51 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 0x100b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ad5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feee1579a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100973d30>, '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 0x1007d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10096bb20>, '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.Tvo3C1ZFJm/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.P2IwB3BFy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:11:51 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 00:11:51 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 00:11:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tvo3C1ZFJm/Render', 00:11:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:11:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:11:51 INFO - 'HOME': '/Users/cltbld', 00:11:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:11:51 INFO - 'LOGNAME': 'cltbld', 00:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:11:51 INFO - 'MOZ_NO_REMOTE': '1', 00:11:51 INFO - 'NO_EM_RESTART': '1', 00:11:51 INFO - 'PAGER': '/bin/cat', 00:11:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:11:51 INFO - 'PWD': '/builds/slave/test', 00:11:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:11:51 INFO - 'SHELL': '/bin/bash', 00:11:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2IwB3BFy5/Listeners', 00:11:51 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:11:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:11:51 INFO - 'USER': 'cltbld', 00:11:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:11:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:11:51 INFO - 'XPC_FLAGS': '0x0', 00:11:51 INFO - 'XPC_SERVICE_NAME': '0', 00:11:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:11:51 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)) 00:11:51 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)) 00:11:51 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)) 00:11:51 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)) 00:11:51 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)) 00:11:51 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)) 00:11:51 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)) 00:11:51 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)) 00:11:51 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)) 00:11:51 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)) 00:11:51 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)) 00:11:51 INFO - Cleaning up... 00:11:51 INFO - Return code: 0 00:11:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:11:51 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')]} 00:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:51 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')]} 00:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:11:51 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 0x100b5f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ad5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feee1579a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100973d30>, '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 0x1007d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10096bb20>, '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.Tvo3C1ZFJm/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.P2IwB3BFy5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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 00:11:51 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 00:11:51 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 00:11:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tvo3C1ZFJm/Render', 00:11:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:11:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:11:51 INFO - 'HOME': '/Users/cltbld', 00:11:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:11:51 INFO - 'LOGNAME': 'cltbld', 00:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:11:51 INFO - 'MOZ_NO_REMOTE': '1', 00:11:51 INFO - 'NO_EM_RESTART': '1', 00:11:51 INFO - 'PAGER': '/bin/cat', 00:11:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:11:51 INFO - 'PWD': '/builds/slave/test', 00:11:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:11:51 INFO - 'SHELL': '/bin/bash', 00:11:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2IwB3BFy5/Listeners', 00:11:51 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:11:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:11:51 INFO - 'USER': 'cltbld', 00:11:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:11:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:11:51 INFO - 'XPC_FLAGS': '0x0', 00:11:51 INFO - 'XPC_SERVICE_NAME': '0', 00:11:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:11:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:11:52 INFO - Cleaning up... 00:11:52 INFO - Return code: 0 00:11:52 INFO - Running post-action listener: _resource_record_post_action 00:11:52 INFO - Running post-action listener: _start_resource_monitoring 00:11:52 INFO - Starting resource monitoring. 00:11:52 INFO - [mozharness: 2017-01-10 08:11:52.259786Z] Finished create-virtualenv step (success) 00:11:52 INFO - [mozharness: 2017-01-10 08:11:52.260749Z] Running install step. 00:11:52 INFO - Running pre-action listener: _resource_record_pre_action 00:11:52 INFO - Running main action method: install 00:11:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:11:52 INFO - Reading from file tmpfile_stdout 00:11:52 INFO - Detecting whether we're running mozinstall >=1.0... 00:11:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:11:52 INFO - Reading from file tmpfile_stdout 00:11:52 INFO - Output received: 00:11:52 INFO - Usage: mozinstall [options] installer 00:11:52 INFO - Options: 00:11:52 INFO - -h, --help show this help message and exit 00:11:52 INFO - -d DEST, --destination=DEST 00:11:52 INFO - Directory to install application into. [default: 00:11:52 INFO - "/builds/slave/test"] 00:11:52 INFO - --app=APP Application being installed. [default: firefox] 00:11:52 INFO - mkdir: /builds/slave/test/build/application 00:11:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 00:12:14 INFO - Reading from file tmpfile_stdout 00:12:14 INFO - Output received: 00:12:14 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 00:12:14 INFO - Running post-action listener: _resource_record_post_action 00:12:14 INFO - [mozharness: 2017-01-10 08:12:14.393819Z] Finished install step (success) 00:12:14 INFO - [mozharness: 2017-01-10 08:12:14.393958Z] Running run-tests step. 00:12:14 INFO - Running pre-action listener: _resource_record_pre_action 00:12:14 INFO - Running main action method: run_tests 00:12:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:12:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:12:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:12:14 INFO - 2017-01-10 00:12:14.408 screenresolution[1631:7705] starting screenresolution argv=screenresolution get 00:12:14 INFO - 2017-01-10 00:12:14.411 screenresolution[1631:7705] Display 0: 1600x1200x32@60 00:12:14 INFO - 2017-01-10 00:12:14.416 screenresolution[1632:7707] starting screenresolution argv=screenresolution list 00:12:14 INFO - Available Modes on Display 0 00:12:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:12:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:12:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:12:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:12:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:12:14 INFO - Intel Iris: 00:12:14 INFO - Chipset Model: Intel Iris 00:12:14 INFO - Type: GPU 00:12:14 INFO - Bus: Built-In 00:12:14 INFO - VRAM (Dynamic, Max): 1536 MB 00:12:14 INFO - Vendor: Intel (0x8086) 00:12:14 INFO - Device ID: 0x0a2e 00:12:14 INFO - Revision ID: 0x0009 00:12:14 INFO - Displays: 00:12:14 INFO - Display: 00:12:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:12:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:12:14 INFO - Display Serial Number: 1600x1200 60 00:12:14 INFO - Main Display: Yes 00:12:14 INFO - Mirror: Off 00:12:14 INFO - Online: Yes 00:12:14 INFO - Rotation: Supported 00:12:14 INFO - Return code: 0 00:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:12:14 INFO - Python 2.7.3 00:12:14 INFO - Return code: 0 00:12:14 INFO - grabbing minidump binary from tooltool 00:12:14 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')]} 00:12:14 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 0x100973d30>, '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 0x1007d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10096bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:12:14 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 00:12:14 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 00:12:14 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 00:12:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:12:14 INFO - Return code: 0 00:12:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:12:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:12:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:12:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:12:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0222', '--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 00:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0222 --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 00:12:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tvo3C1ZFJm/Render', 00:12:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:12:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:12:14 INFO - 'HOME': '/Users/cltbld', 00:12:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:12:14 INFO - 'LOGNAME': 'cltbld', 00:12:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:12:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:12:14 INFO - 'MOZ_NO_REMOTE': '1', 00:12:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:12:14 INFO - 'NO_EM_RESTART': '1', 00:12:14 INFO - 'PAGER': '/bin/cat', 00:12:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:12:14 INFO - 'PWD': '/builds/slave/test', 00:12:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:12:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:12:14 INFO - 'SHELL': '/bin/bash', 00:12:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P2IwB3BFy5/Listeners', 00:12:14 INFO - 'TMPDIR': '/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/', 00:12:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:12:14 INFO - 'USER': 'cltbld', 00:12:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:12:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:12:14 INFO - 'XPC_FLAGS': '0x0', 00:12:14 INFO - 'XPC_SERVICE_NAME': '0', 00:12:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:12:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0222', '--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 00:12:14 INFO - mozversion application_buildid: 20170109211108 00:12:14 INFO - mozversion application_changeset: 3218ea763746c4ddef980b9095dc04ade8abe4b0 00:12:14 INFO - mozversion application_display_name: Firefox 00:12:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:12:14 INFO - mozversion application_name: Firefox 00:12:14 INFO - mozversion application_remotingname: firefox 00:12:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 00:12:14 INFO - mozversion application_vendor: Mozilla 00:12:14 INFO - mozversion application_version: 51.0 00:12:14 INFO - mozversion platform_buildid: 20170109211108 00:12:14 INFO - mozversion platform_changeset: 3218ea763746c4ddef980b9095dc04ade8abe4b0 00:12:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 00:12:14 INFO - mozversion platform_version: 51.0 00:12:14 INFO - using testdate: 1484035934 00:12:14 INFO - actual date: 1484035934 00:12:14 INFO - starting webserver on 'localhost:49236' 00:12:14 INFO - SUITE-START | Running 2 tests 00:12:14 INFO - TEST-START | dromaeo_css 00:12:14 INFO - operating with platform_type : mac_ 00:12:14 INFO - Initialising browser for dromaeo_css test... 00:12:15 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/tmpuWC_83/profile http://localhost:49236/getInfo.html) 00:12:17 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 00:12:17 INFO - PROCESS | 1642 | colorDepth:24 00:12:17 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 00:12:17 INFO - PROCESS | 1642 | __metrics 00:12:17 INFO - PROCESS | 1642 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:12:17 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:12:18 INFO - TEST-INFO | 1642: exit 0 00:12:18 INFO - Browser initialized. 00:12:18 INFO - Running cycle 1/1 for dromaeo_css test... 00:12:18 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/tmpuWC_83/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:12:30 INFO - PROCESS | 1645 | RSS: Main: 169185280 00:12:30 INFO - PROCESS | 1645 | 00:13:21 INFO - PROCESS | 1645 | 1484036001514 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 00:15:31 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 00:15:33 INFO - PROCESS | 1645 | RSS: Main: 277213184 00:15:33 INFO - PROCESS | 1645 | 00:18:35 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 00:18:36 INFO - PROCESS | 1645 | RSS: Main: 300716032 00:18:36 INFO - PROCESS | 1645 | 00:21:38 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 00:21:39 INFO - PROCESS | 1645 | RSS: Main: 262438912 00:21:39 INFO - PROCESS | 1645 | 00:24:41 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 00:24:41 INFO - PROCESS | 1645 | RSS: Main: 264462336 00:24:41 INFO - PROCESS | 1645 | 00:27:45 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 00:27:45 INFO - PROCESS | 1645 | RSS: Main: 259411968 00:27:45 INFO - PROCESS | 1645 | 00:30:48 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 00:30:48 INFO - PROCESS | 1645 | RSS: Main: 493379584 00:30:48 INFO - PROCESS | 1645 | 00:30:48 INFO - PROCESS | 1645 | __start_tp_report 00:30:48 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 00:30:48 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 00:30:48 INFO - PROCESS | 1645 | |i|pagename|runs| 00:30:48 INFO - PROCESS | 1645 | |0;dojo.html;2873.726995935386;3450.171958729906;3465.4108801503744;3476.7913925164476;3525.242072954316;5720.771169153234;5765.913511297334;5777.942220577793;5804.187413762077;5846.649201047935;5775.36470988192;5840.474357307841;5853.385394533577;5857.238558987337;5876.529877609792;5266.947330526694;5322.946770532303;5324.893502129955;5332.653377530468;5371.597130215249;5270.631055826094;5285.577153827685;5393.1101368274385;5397.001554712371;5401.43284955078;5229.398619158807;5291.444398338177;5295.0733621616255;5298.47015298469;5325.4940780625775;5263.631545791796;5288.391834938954;5341.679499230058;5346.572274218053;5353.197020446964;5166.974165129188;5225.4513276105845;5291.444398338158;5321.707306098163;5336.91994620081;5702.857428564277;5723.284589426322;5755;5762.88474230513;5776.768929242825;6182.814515564495;6227.283862355842;6266.87466250677;6286.937130628727;6292.779752708679;5512.33851937766;6295.0872123542285;6310.400511951358;6319.988801791691;6342.143810585558;5744.454276843693;5756.539476841926;5799.072148456226;5801.593888427769;5822.854428639233;6257.7184026718905;6263;6273.215848018997;6299.811005669837;6302.558820882494;6194.132821405007;6197.876042479215;6205.906911396332;6222.408871157233;6226.283977342573;6177.413145751147;6235.96882015587;6246.031865060832;6269.937300627026;6322.462590679752;6214.151980742363;6219.378062193835;6255.56211065221;6288.402601752826;6319.905201421982;6262.3111457739615;6291.653959032205;6318.368163183737;6319.873602528016;6332.461740752087;4784.521547845257;4941.604671626261;4983.451820299764;4984.90030199394;5066.417362003343;4312.547182545787;4331.480222373272;4341.218580655449;4342.457192850894;4402.031553058322;5548.69482178476;5572.275604171513;5585.804496842591;5616.410276920946;5635.633683810539;6068.908966365508;6093.146959425684;6169.383061693885;6218.129461875341;6264.874702505925;5876.44173803488;5945.583809133319;5992.970035149797;5993.820185394445;6016.09758536223;5442.83671489848;5481.671099734029;5487.972560137174;5489.945100549024;5504.146857237135;6230.190075290183;6324.3991820776955;6437.388448097423;6458.483321334282;6463.838404039842;6222.782202622887;6223.844403889939;6240.5319601031015;6251.9687401562705;6267.0599410087025;6408.903866441914;6411;6429.54993150475;6440.8389790255615;6443.484521238196;6221.222347206599;6221.2845522765465;6280;6290.182276304051;6294.842628934313;6113.719560719409;6133.79375043651;6151.630902145886;6193.163922870355;6242.719077641426;5013.721501017218;6153.938460615336;6162.722677479614;6180.6909654517995;6207.6585787782105;6136.29432615255;6161.168242287234;6165.229346331708;6178.41305076017;6179.907301390573;5928.970355148197;5929.0513517836935;5955.285365756137;5965.433283838029;6002.6398416093425;6152.169457123231;6190.102435146789;6217.502599791916;6225.252969643671;6226.844328891814;4793.520647935178;5482.8211934434285;5748.971255143865;5926.229590153425;6147.170132032118 00:30:48 INFO - PROCESS | 1645 | |1;ext.html;475.8191887082909;476.80451015083815;482.94235623983496;490.36252871267345;528.3712382265106;30822.53766193506;35231.471527927104;41406.37890431642;42751;42985;43976.78011609938;44358.778206108924;44750.77624611872;44833.55166448335;44924.55075449245;8288.419810613259;9301.813963720722;9984.45085520296;10156.593736250541;10170.491475426235;9344.205742511895;12141;12404.751904961895;12436.440360183813;12525.874741252608;12415.937920310385;12474.93762531186;12492.312922789242;12508.562200322991;12509.937450312736;12270.447829847633;12338.074644401617;12359.443825027894;12374.56689015889;12388.380580971005;12197.817032744517;12273.202241854251;12287.69280767979;12298.692532686755;12328.753424931541;42004.57995420037;42302.78848605768;42388.57611423908;42465.57534424678;42527.9368015799;3522.6477352264824;3657.561092668897;3659.780413175218;3736.981315093434;4435.112977404532;31607.683923160705;31873.521897171562;32069.35861282761;32247.51628725571;32385.676143238503;3277.8361081946045;3279.4916787897914;3356.513305570703;3386.238096428284;3393.779404338735;514508;514967;515884;516397.9999999962;518019;34613.65386346104;60409.48976275628;60714.696426517585;60750.696246518484;60824.69587652033;33997;34276.31447371088;34354.656453435644;34385.82807085948;34976.82511587426;15484.535463935874;15653.530394088195;15654.843451565566;15661.138637374826;15686.372545098297;12205;12234.143609947218;12258.632241032783;13430.798538021938;13532.391042403115;7469.962650186714;7530.6611202496015;7814.10137834145;7945;7951.204879512118;2907.646791760011;3227.6772322767533;3237.8704851805664;3279.6064472263483;3316.3533111043116;893.4996402014892;969.5976169889558;979.9020097990144;1070.5343175718588;1081.6106201767357;30966.845165774026;31359.216019599236;31403.528947065814;31740.523892141173;32806.50790238148;948.5209968965628;1125.909927205838;1145.919785614999;1188.5839956015325;1198.526582000105;15183.16492592918;15974.840251597569;16533;16602.667946641242;16617.50147495577;699202;703665;704552;704668;705919;59608.70195648994;59927.70036149791;60022.099668505005;60078;60124.69937650284;1305.6801083734547;1338.4980632262902;1405.8313002439568;1417.7518934186269;1447.6742732885227;30300.69699302979;31692.366152676357;32594.83702581472;32803.835980819946;33216.83391583027;50507.74746126246;51214.23178652248;51282;51353;51355.71610709762;558371;558462;558538.2073089608;560211;562797;28106.87572497077;28423.147305580867;28515.28711782222;29341.26646833846;29402.705972940854;48982.5101748978;48983.75508122579;49196.75401623112;49946;49979.50020499894;33192.17019574434;40141.59858401379;40183.79908100441;40845.591544085364;42372;40496.98757531085;40922.97692557591;41618.79190604028;41744.12491196019;42346.15307693891;39536.01159971024;39954.200915982095;40047.799761001006;40491;40601.39097913475;34354.484682730275;35532;35550.82224588861;36396.72611458692;36450.63549364579;26252.60621090647;26342.73657263403;26399.868000659873;26940.32649183786;26982.595261070706 00:30:48 INFO - PROCESS | 1645 | |2;jquery.html;385.1488211053572;386.56125297787;390.3715018819699;397.1520803085412;414.2481396265777;21019.57960840782;21172.470688232803;21681.457963550918;22664.980075896583;22665.09339626415;12097.213681110721;12400.255984640928;19554.70667939982;21513.67729484059;21748.9125543723;5460.290162278908;5925.111233315016;6197.1324014637985;6241;6298.2442106947;5300.787968481256;6198.760247950428;6216.254049514065;6291.874162516747;6296.590721603081;5201.271821944931;6274.121622972787;6315.684215789215;6329.398707122839;6338.239411270654;6022.759089636409;6186.938130618726;6280.905786413207;6312.715927783238;6336.334684858092;6116.633002019848;6121.296050954153;6129.846753831145;6133.877322453571;6139.6009259398;20292.492687682778;25988.35029124287;26853.32866678329;27024.59463108055;27256.863715681295;2159.276642324823;2535.4548772014105;2598.9870050649624;2670.212287375229;2675.745804148603;10238.846417303672;10406;10590.788184236271;10642.255042147053;16251.918740406341;1902.8202514440998;1914.329984505426;1917.7794553626372;1929.2283086765406;1939.8545109116872;82686.58656706678;124165;131224.34387828095;132979;133245;11457.828132578017;11736.061115110771;11836.88163118375;11851.288922664668;11884.07533904572;15434.614134646723;15457.458988935557;15481.84518154804;15484.690306193814;15492.690146197237;8975.775605609912;9106.089391060841;9107.180353768194;9107.772305692411;9228.354015219005;9064.728058158265;9074.319426043074;9089.5000774958;9229.907700923039;9247.12152345526;4687.718736875799;4687.742174180385;4710.481846996828;4727.905441891212;4750.643701722384;1796.2545543599522;1889.2915156816193;1946.3771593090357;1950.2101648832245;1952.9121189546504;728.3590440412403;756.5574139128562;759.1687102622619;835.8955130608674;982.8820541535061;20487.59024819525;22324.21865234709;22343.55312893733;22379.776202238096;22484.213052543084;911.4596332198563;933.8505839065717;940.7177846645978;953.8712273843081;985.3742873275378;11353.205275630626;11681.948624623825;11684.824727628922;11695.766084678258;11709.355985420883;521016;612879;617089;631781;633289;126669;127778;145987.2700636511;148076;150304.2484787569;1021.918246540275;1038.5118994072925;1049.7165765243494;1056.1128651932413;1072.4905669806935;19385.903070484557;20712.48218794542;20746.896265518575;20778.792212077686;20797.37607871766;57434.42565574291;57988.420115798304;58624;58895.70552147212;60253.0962035561;79956.60021699854;80009.19990800017;80197.5990120069;81289;82563.58718206371;6291.993281075006;7858.6070696466095;8638.26574741154;8649.740507784776;8751.474911505331;13356.599302020955;13445.462181513021;13530;13627.795583066063;14009.299535023005;11426.657200284004;11458.369789661316;11482;11710.70723231926;11901.345426001306;11419.0864730823;11526.193166478266;11570.88429115698;11627.418629068343;12033.338166400932;11396.772064558829;11630.360330181922;11978.520859165885;12004.75990480203;12019.519219231133;8478.23695867375;8584.957075214834;8617.741467755977;8734.56327183651;8775.297976162019;11347.20569560123;11649.068074553847;12031.518739250332;12040;12096.334701591497 00:30:48 INFO - PROCESS | 1645 | |3;mootools.html;1548.5354393681896;1550.643352029033;1820.1718218210715;1927.3350694010578;1982.1377700700205;8913.509756963364;9493.288003399746;9494.24046076314;9508.714738557837;9517;8252.298554622865;8578.356623253265;8579.35654825889;8654.826903461942;8658.437201581894;2221.9000144993474;2391.5336509380677;2468.8024958003407;2469.80241580674;2469.839460435066;2075.5952589245103;2422.87885605719;2430.173740928084;2454.067454367338;2471.88876500557;2428.9271321860283;2438.280707191374;2444.352246654638;2444.767747064026;2446.755324467548;2428.6842710447618;2428.9392765180837;2431.744666809986;2434.892124083538;2438.2928950604305;2402.027178992511;2442.584760590686;2442.792362649177;2444.1201167579657;2444.5721998650342;9279.814403711887;9288.953555232249;9370.67202647911;9419.48192849393;9421.010793866613;5434.755436005389;5596.58025648078;5609.943900560983;5612.663240205601;5615.382307946123;3502.2820321833965;3586.067622418164;3697.186618943828;3707.295613833363;3712.535933008374;1053.536443964653;1066.3548553125402;1069.5721711315537;1071.6249312740556;1099.9175061870392;10392.272540922138;12346.75306493874;12501.74996500074;12525.248485090833;12541.623751287385;4535.365048893158;4810.494898035726;4905.23968784839;4984.501549844987;5028.421731500851;8785.648574057093;10491.580336786443;10531.315464494783;10539.156867450585;10549.997750213717;5612.719364031782;5627.971860140673;5628.240187574625;5629.352624448159;5632.295963004624;5009.699418034929;5102.08162530748;5124.538791508708;5127.897442051138;5146.25379320004;4074.2258970795456;4108.322126849096;4137.379393091061;4183.97908010458;4219.535851056381;1313.1989486413281;1319.9538016169388;1323.4706117553055;1332.8333958255218;1345.5223395694584;874.6151693254948;887.3699673232078;908.6910450446879;926.8934072581604;928.2434815625244;5903.468687818031;5911.556633252523;5982.132590774313;6019.578629495893;6140.078988151813;446.76991349455056;454.3344001038428;470.22882472744726;471.8324994626927;472.5463554987182;3901.063744701308;3935.2129574085297;3944.1914407546383;3946;4021.3766866135797;11171.44142792857;11173.608923687632;11554.017908477874;11743.11926605508;11743.706407339714;9517.90482095184;11504;11532.36571988532;11533.308001519936;11536.365499897418;8532.701355452653;8619.39664223511;8662.133786621287;8744.213020828156;8752.387332886765;5805.390434004369;5894.322152952293;5953.255843019622;6073.453389194994;6115.388461153849;10531;10534.683959481228;10678;10791.02880740737;10815.35107893529;10281.948590257001;10701.625443109453;10726.624568140078;10898.400587967737;10911.454427278763;7166.355028047501;7412.703491860265;7651.1583725789005;7756.806079848049;7846.450748447783;6916.723331066701;8799;8882.200601945857;8886.955565222133;8889.777755556162;7807.102183248772;7829.177936316605;7839.921600784147;7853.214678532101;7898.881516777138;7659.348955338635;7694.345980591488;7726.6136693166245;7787.143414224318;7811.960940195263;7195.676194571152;7222.06113205301;7266.091738532684;7282.96358518204;7362;4993.300937868628;5062.645614806928;5213.139831927841;5218.582513398843;5252.597670933395;5078.898422031465;5117.334746482933;5236.371635403623;5282.075636763474;5351.5718742501285 00:30:48 INFO - PROCESS | 1645 | |4;prototype.html;260.22063918563896;306.69024285471664;315.18996179817873;320.5256220793226;324.43062425443344;5326.9733651331735;5448.839672989667;5467.371252305986;5474.972625136868;5498.340199176105;4134.090500089983;4491.910161796762;5202.297689811874;5213.791448342071;5381.865453363658;3209.3420848726073;3724.9383925581214;4051.534073581539;4058.715889887709;4072.411759413831;3901.7854018028997;4140.979295103521;4151.584841515854;4186.204621121992;4198.433211516437;3671.871484498043;3928.4696565963513;3989.2819292527333;4113.547509773923;4118.4440100586335;3650.8904732858055;3890.7860067696265;4139.234241665302;4174.0817020255645;4180.393842892779;3612.3858943979585;3616;3634.691051260646;3646.08847788053;3648.5804132524568;4327.697061205717;5067.417247016603;5289.497497737709;5301.469853014668;5326.203743034937;3919.4708714323488;4490.7530085845265;4636.281376386665;4748.335233067373;4821.783019764084;4682.906341873144;5436.728163591804;5689.829305120812;5691.288588926384;5733.827985160452;3983.5817239190046;3993.30451944936;3996.48045754053;4021.8592349267633;4042.7372220805555;4918.483559226265;5201.852879008184;5662.819814371455;5952.166696662471;5977.342492325841;4055.1484188320783;4068.7355321903983;4072.714909956334;4086.40747091676;4087.89780255496;4013.6187062229624;4140.385249752599;4156.875293741193;4164.063085805669;4166.979165104216;4311.636923199909;4371.715838470489;4453.042595841909;4717.410323709536;4748.240281555004;5630.324361076697;5667.603267771299;5672.801451949162;5681.1084407181215;5709.429057094258;1228.3182833527478;1262.1165184370977;1358.8641135886332;1401.955543120382;1402.4390243902317;765.8468306338755;823.6293667849492;915.8855143107112;942.7313215733483;960.5245403525299;4865.637621465995;5279.577633789288;5299.920501192485;5319.893602128013;5328.8276579152525;5712.257406537124;5790.507806836466;5804.622699524517;5827.562932780059;5861.6189947653265;3894.196178751351;4204.957950420518;5107.059317459341;5267.236250743621;5480;3115.3924984628234;3124.42198193335;3127.5152351385573;3131.5302704594037;3133.592632957701;5327.413984461706;5468.7539060742365;5795.246617939641;5829.065380867897;6129.448349648553;5977.880442391128;6009.969950150221;6028.457438830526;6035.818925432244;6043.637381757021;5133.409657889316;6062.968515742129;6100.75596976116;6110.419510146529;6129.816105516842;4368.213721530155;5067.695938243717;5227.895442091213;5899.233099697012;5963.582549221686;5093.032323858455;5604.682899518692;5737.827865164052;5881.7647294109465;5899.852503687443;5053.29253904461;5802.94197058024;6039.214902062879;6140.425383089627;6146.78486252979;3876.5348158221195;3944.7041471889147;3966.3455529838407;3998.9600103998587;4006.679465642683;5036.992601479646;5994.670293133745;6020.578559500793;6021.397860213943;6026.608270462406;4631.76841157934;5109.259157422227;5324.653897496651;5445.972770136124;5864.970675146597;5065.924011139909;5753.252077229933;5790.002449155035;5795.8551036224435;5795.884082318415;5374.4625537445945;5646.689432081111;5651.660900345993;5652.7738890443925;5708.80019199326;4316.6330861877095;4920.237363208708;5664.159148276909;5667.4615911488345;5824.592613321254;5185.896282074413;5679.432056794452;5689.857753556194;5699.316082070178;5728.3412407572 00:30:48 INFO - PROCESS | 1645 | |5;yui.html;714.914210294765;766.6473422225777;806.1173015547977;853.2235665544356;866.33292364879;15528.53414397567;16207.432739854108;16898.239579218935;16923.492295231146;17227.397041103563;15289.311980960856;15625.609359766011;15682.84317156831;15689.45086921958;15701.764473532907;734.7354952217197;754.6943487887387;902.9232515236213;905.8867641544807;908.2869947091534;926.2821313482038;939.5067589515525;942.4769253064546;942.4910548303942;943.3302355327726;987.5753426026841;988.5699720621517;988.9258305627071;990.1583653894204;990.8414653655417;967.6951760195586;968.5205823117602;968.6851773173712;971.2861047130389;973.4986481961795;711.8754218011827;713.7002458967246;713.9678714457862;714.4391652552773;716.8852983522611;16171.595710107224;16565.503034908972;16741.246643901053;16748;16777.077260750655;15134.377609032681;15243.314050867737;15436.996595221386;15440.382384704599;15538.844611553854;11409.657710268622;11723.4138293085;11799.528018879235;12091.57679481214;12330.445129969174;4508.323751437278;4770.284457331393;4908.558229759339;4930.728809915453;4938.185199442088;103211.48394258055;113765;114034;115628;118629;10352.792944141074;10844.295120817122;10856.240063195659;11208.55165793359;11630.592929247436;21534.56930861374;21559.676604850938;21567.568648627253;21572.352829415144;21580.244691435724;7716.151223365426;7777;8114.350851931831;8147.837043259102;8197.672093116327;4013.177298653769;4404.053128577307;4523.11799199153;4523.457185137804;4678.649101317346;3507.2985402919517;3612.512310838003;3613.891583252454;3623.0761155905075;3636.1636823530735;652.7584793626388;657.5824351536809;664.6311297230084;671.2750229751954;679.2935347238915;544.5453046705966;577.6418620455345;656.678227668439;656.8522082531392;658.5061204096927;8028.237317454832;8539.701110461105;9154.176124148858;9172.633094676139;9213.170814626716;532.597888594109;572.928383952006;576.2969177603318;603.1375133559053;651.9119918810994;3635.381985062546;3880.5343358797127;4139.296319625671;4187.958120418818;4233.5131459881895;87772.12227877768;88824.6676299856;102637;154465;164165.17917410337;117364;117744;119833.99999999825;126193.73806262003;126726.73273267334;114608;115914;118702.81297186918;119463.40268298777;121401.39299303624;8271.33829293643;8428.325733941147;8546.316294696286;8567.314614830673;8732.91267087321;63763;64727.67636161789;69098.16312858052;69828.65085674742;70595.58808823692;76319;83776;89383;95655.04344956462;96742.51628741811;11404.543818247177;11472.598459053894;11593.338601225518;11681.649550513499;12081.395930203278;12578.245305281713;12615.621531354074;12747.899201275759;12880;13375.799363009368;11578.652640420802;11774.705632359259;11848.111391645489;11945.402729863647;12207.206531575419;11350.205485615928;12015.819762703391;12270.263784172621;12413.627591172279;12415;11022.779544408906;11571.826422603499;14460.638484037983;14688.339024743698;14899.106053636817;10150.695479135638;11172.385518796544;11314.60398886035;11916;12200.206986545845;9639.481589220024;11025.503852326505;11215.710193327546;11388.829167562659;12035.638930832089 00:30:48 INFO - PROCESS | 1645 | __end_tp_report 00:30:48 INFO - PROCESS | 1645 | __start_cc_report 00:30:48 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1048 00:30:48 INFO - PROCESS | 1645 | __end_cc_report 00:30:48 INFO - PROCESS | 1645 | __startTimestamp1484037048811__endTimestamp 00:30:48 INFO - PROCESS | 1645 | 00:30:48 INFO - PROCESS | 1645 | ------- Summary: start ------- 00:30:48 INFO - PROCESS | 1645 | Number of tests: 6 00:30:48 INFO - PROCESS | 1645 | 00:30:48 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5776.82 Median:5992.97 stddev:653.06 (10.9%) stddev-sans-first:614.07 00:30:48 INFO - PROCESS | 1645 | Values: 2873.7 3450.2 3465.4 3476.8 3525.2 5720.8 5765.9 5777.9 5804.2 5846.6 5775.4 5840.5 5853.4 5857.2 5876.5 5266.9 5322.9 5324.9 5332.7 5371.6 5270.6 5285.6 5393.1 5397.0 5401.4 5229.4 5291.4 5295.1 5298.5 5325.5 5263.6 5288.4 5341.7 5346.6 5353.2 5167.0 5225.5 5291.4 5321.7 5336.9 5702.9 5723.3 5755.0 5762.9 5776.8 6182.8 6227.3 6266.9 6286.9 6292.8 5512.3 6295.1 6310.4 6320.0 6342.1 5744.5 5756.5 5799.1 5801.6 5822.9 6257.7 6263.0 6273.2 6299.8 6302.6 6194.1 6197.9 6205.9 6222.4 6226.3 6177.4 6236.0 6246.0 6269.9 6322.5 6214.2 6219.4 6255.6 6288.4 6319.9 6262.3 6291.7 6318.4 6319.9 6332.5 4784.5 4941.6 4983.5 4984.9 5066.4 4312.5 4331.5 4341.2 4342.5 4402.0 5548.7 5572.3 5585.8 5616.4 5635.6 6068.9 6093.1 6169.4 6218.1 6264.9 5876.4 5945.6 5993.0 5993.8 6016.1 5442.8 5481.7 5488.0 5489.9 5504.1 6230.2 6324.4 6437.4 6458.5 6463.8 6222.8 6223.8 6240.5 6252.0 6267.1 6408.9 6411.0 6429.5 6440.8 6443.5 6221.2 6221.3 6280.0 6290.2 6294.8 6113.7 6133.8 6151.6 6193.2 6242.7 5013.7 6153.9 6162.7 6180.7 6207.7 6136.3 6161.2 6165.2 6178.4 6179.9 5929.0 5929.1 5955.3 5965.4 6002.6 6152.2 6190.1 6217.5 6225.3 6226.8 4793.5 5482.8 5749.0 5926.2 6147.2 00:30:48 INFO - PROCESS | 1645 | 00:30:48 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:71886.98 Median:19249.74 stddev:160219.97 (832.3%) stddev-sans-first:160579.72 00:30:48 INFO - PROCESS | 1645 | Values: 475.8 476.8 482.9 490.4 528.4 30822.5 35231.5 41406.4 42751.0 42985.0 43976.8 44358.8 44750.8 44833.6 44924.6 8288.4 9301.8 9984.5 10156.6 10170.5 9344.2 12141.0 12404.8 12436.4 12525.9 12415.9 12474.9 12492.3 12508.6 12509.9 12270.4 12338.1 12359.4 12374.6 12388.4 12197.8 12273.2 12287.7 12298.7 12328.8 42004.6 42302.8 42388.6 42465.6 42527.9 3522.6 3657.6 3659.8 3737.0 4435.1 31607.7 31873.5 32069.4 32247.5 32385.7 3277.8 3279.5 3356.5 3386.2 3393.8 514508.0 514967.0 515884.0 516398.0 518019.0 34613.7 60409.5 60714.7 60750.7 60824.7 33997.0 34276.3 34354.7 34385.8 34976.8 15484.5 15653.5 15654.8 15661.1 15686.4 12205.0 12234.1 12258.6 13430.8 13532.4 7470.0 7530.7 7814.1 7945.0 7951.2 2907.6 3227.7 3237.9 3279.6 3316.4 893.5 969.6 979.9 1070.5 1081.6 30966.8 31359.2 31403.5 31740.5 32806.5 948.5 1125.9 1145.9 1188.6 1198.5 15183.2 15974.8 16533.0 16602.7 16617.5 699202.0 703665.0 704552.0 704668.0 705919.0 59608.7 59927.7 60022.1 60078.0 60124.7 1305.7 1338.5 1405.8 1417.8 1447.7 30300.7 31692.4 32594.8 32803.8 33216.8 50507.7 51214.2 51282.0 51353.0 51355.7 558371.0 558462.0 558538.2 560211.0 562797.0 28106.9 28423.1 28515.3 29341.3 29402.7 48982.5 48983.8 49196.8 49946.0 49979.5 33192.2 40141.6 40183.8 40845.6 42372.0 40497.0 40923.0 41618.8 41744.1 42346.2 39536.0 39954.2 40047.8 40491.0 40601.4 34354.5 35532.0 35550.8 36396.7 36450.6 26252.6 26342.7 26399.9 26940.3 26982.6 00:30:48 INFO - PROCESS | 1645 | 00:30:48 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:36144.82 Median:12600.27 stddev:101312.35 (804.0%) stddev-sans-first:101560.98 00:30:48 INFO - PROCESS | 1645 | Values: 385.1 386.6 390.4 397.2 414.2 21019.6 21172.5 21681.5 22665.0 22665.1 12097.2 12400.3 19554.7 21513.7 21748.9 5460.3 5925.1 6197.1 6241.0 6298.2 5300.8 6198.8 6216.3 6291.9 6296.6 5201.3 6274.1 6315.7 6329.4 6338.2 6022.8 6186.9 6280.9 6312.7 6336.3 6116.6 6121.3 6129.8 6133.9 6139.6 20292.5 25988.4 26853.3 27024.6 27256.9 2159.3 2535.5 2599.0 2670.2 2675.7 10238.8 10406.0 10590.8 10642.3 16251.9 1902.8 1914.3 1917.8 1929.2 1939.9 82686.6 124165.0 131224.3 132979.0 133245.0 11457.8 11736.1 11836.9 11851.3 11884.1 15434.6 15457.5 15481.8 15484.7 15492.7 8975.8 9106.1 9107.2 9107.8 9228.4 9064.7 9074.3 9089.5 9229.9 9247.1 4687.7 4687.7 4710.5 4727.9 4750.6 1796.3 1889.3 1946.4 1950.2 1952.9 728.4 756.6 759.2 835.9 982.9 20487.6 22324.2 22343.6 22379.8 22484.2 911.5 933.9 940.7 953.9 985.4 11353.2 11681.9 11684.8 11695.8 11709.4 521016.0 612879.0 617089.0 631781.0 633289.0 126669.0 127778.0 145987.3 148076.0 150304.2 1021.9 1038.5 1049.7 1056.1 1072.5 19385.9 20712.5 20746.9 20778.8 20797.4 57434.4 57988.4 58624.0 58895.7 60253.1 79956.6 80009.2 80197.6 81289.0 82563.6 6292.0 7858.6 8638.3 8649.7 8751.5 13356.6 13445.5 13530.0 13627.8 14009.3 11426.7 11458.4 11482.0 11710.7 11901.3 11419.1 11526.2 11570.9 11627.4 12033.3 11396.8 11630.4 11978.5 12004.8 12019.5 8478.2 8585.0 8617.7 8734.6 8775.3 11347.2 11649.1 12031.5 12040.0 12096.3 00:30:48 INFO - PROCESS | 1645 | 00:30:48 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5941.17 Median:4944.87 stddev:3392.10 (68.6%) stddev-sans-first:3385.56 00:30:48 INFO - PROCESS | 1645 | Values: 1548.5 1550.6 1820.2 1927.3 1982.1 8913.5 9493.3 9494.2 9508.7 9517.0 8252.3 8578.4 8579.4 8654.8 8658.4 2221.9 2391.5 2468.8 2469.8 2469.8 2075.6 2422.9 2430.2 2454.1 2471.9 2428.9 2438.3 2444.4 2444.8 2446.8 2428.7 2428.9 2431.7 2434.9 2438.3 2402.0 2442.6 2442.8 2444.1 2444.6 9279.8 9289.0 9370.7 9419.5 9421.0 5434.8 5596.6 5609.9 5612.7 5615.4 3502.3 3586.1 3697.2 3707.3 3712.5 1053.5 1066.4 1069.6 1071.6 1099.9 10392.3 12346.8 12501.7 12525.2 12541.6 4535.4 4810.5 4905.2 4984.5 5028.4 8785.6 10491.6 10531.3 10539.2 10550.0 5612.7 5628.0 5628.2 5629.4 5632.3 5009.7 5102.1 5124.5 5127.9 5146.3 4074.2 4108.3 4137.4 4184.0 4219.5 1313.2 1320.0 1323.5 1332.8 1345.5 874.6 887.4 908.7 926.9 928.2 5903.5 5911.6 5982.1 6019.6 6140.1 446.8 454.3 470.2 471.8 472.5 3901.1 3935.2 3944.2 3946.0 4021.4 11171.4 11173.6 11554.0 11743.1 11743.7 9517.9 11504.0 11532.4 11533.3 11536.4 8532.7 8619.4 8662.1 8744.2 8752.4 5805.4 5894.3 5953.3 6073.5 6115.4 10531.0 10534.7 10678.0 10791.0 10815.4 10281.9 10701.6 10726.6 10898.4 10911.5 7166.4 7412.7 7651.2 7756.8 7846.5 6916.7 8799.0 8882.2 8887.0 8889.8 7807.1 7829.2 7839.9 7853.2 7898.9 7659.3 7694.3 7726.6 7787.1 7812.0 7195.7 7222.1 7266.1 7283.0 7362.0 4993.3 5062.6 5213.1 5218.6 5252.6 5078.9 5117.3 5236.4 5282.1 5351.6 00:30:48 INFO - PROCESS | 1645 | 00:30:48 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4608.32 Median:5159.65 stddev:1410.45 (27.3%) stddev-sans-first:1376.13 00:30:48 INFO - PROCESS | 1645 | Values: 260.2 306.7 315.2 320.5 324.4 5327.0 5448.8 5467.4 5475.0 5498.3 4134.1 4491.9 5202.3 5213.8 5381.9 3209.3 3724.9 4051.5 4058.7 4072.4 3901.8 4141.0 4151.6 4186.2 4198.4 3671.9 3928.5 3989.3 4113.5 4118.4 3650.9 3890.8 4139.2 4174.1 4180.4 3612.4 3616.0 3634.7 3646.1 3648.6 4327.7 5067.4 5289.5 5301.5 5326.2 3919.5 4490.8 4636.3 4748.3 4821.8 4682.9 5436.7 5689.8 5691.3 5733.8 3983.6 3993.3 3996.5 4021.9 4042.7 4918.5 5201.9 5662.8 5952.2 5977.3 4055.1 4068.7 4072.7 4086.4 4087.9 4013.6 4140.4 4156.9 4164.1 4167.0 4311.6 4371.7 4453.0 4717.4 4748.2 5630.3 5667.6 5672.8 5681.1 5709.4 1228.3 1262.1 1358.9 1402.0 1402.4 765.8 823.6 915.9 942.7 960.5 4865.6 5279.6 5299.9 5319.9 5328.8 5712.3 5790.5 5804.6 5827.6 5861.6 3894.2 4205.0 5107.1 5267.2 5480.0 3115.4 3124.4 3127.5 3131.5 3133.6 5327.4 5468.8 5795.2 5829.1 6129.4 5977.9 6010.0 6028.5 6035.8 6043.6 5133.4 6063.0 6100.8 6110.4 6129.8 4368.2 5067.7 5227.9 5899.2 5963.6 5093.0 5604.7 5737.8 5881.8 5899.9 5053.3 5802.9 6039.2 6140.4 6146.8 3876.5 3944.7 3966.3 3999.0 4006.7 5037.0 5994.7 6020.6 6021.4 6026.6 4631.8 5109.3 5324.7 5446.0 5865.0 5065.9 5753.3 5790.0 5795.9 5795.9 5374.5 5646.7 5651.7 5652.8 5708.8 4316.6 4920.2 5664.2 5667.5 5824.6 5185.9 5679.4 5689.9 5699.3 5728.3 00:30:48 INFO - PROCESS | 1645 | 00:30:48 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:24172.57 Median:3629.23 stddev:37893.76 (1044.1%) stddev-sans-first:37959.13 00:30:48 INFO - PROCESS | 1645 | Values: 714.9 766.6 806.1 853.2 866.3 15528.5 16207.4 16898.2 16923.5 17227.4 15289.3 15625.6 15682.8 15689.5 15701.8 734.7 754.7 902.9 905.9 908.3 926.3 939.5 942.5 942.5 943.3 987.6 988.6 988.9 990.2 990.8 967.7 968.5 968.7 971.3 973.5 711.9 713.7 714.0 714.4 716.9 16171.6 16565.5 16741.2 16748.0 16777.1 15134.4 15243.3 15437.0 15440.4 15538.8 11409.7 11723.4 11799.5 12091.6 12330.4 4508.3 4770.3 4908.6 4930.7 4938.2 103211.5 113765.0 114034.0 115628.0 118629.0 10352.8 10844.3 10856.2 11208.6 11630.6 21534.6 21559.7 21567.6 21572.4 21580.2 7716.2 7777.0 8114.4 8147.8 8197.7 4013.2 4404.1 4523.1 4523.5 4678.6 3507.3 3612.5 3613.9 3623.1 3636.2 652.8 657.6 664.6 671.3 679.3 544.5 577.6 656.7 656.9 658.5 8028.2 8539.7 9154.2 9172.6 9213.2 532.6 572.9 576.3 603.1 651.9 3635.4 3880.5 4139.3 4188.0 4233.5 87772.1 88824.7 102637.0 154465.0 164165.2 117364.0 117744.0 119834.0 126193.7 126726.7 114608.0 115914.0 118702.8 119463.4 121401.4 8271.3 8428.3 8546.3 8567.3 8732.9 63763.0 64727.7 69098.2 69828.7 70595.6 76319.0 83776.0 89383.0 95655.0 96742.5 11404.5 11472.6 11593.3 11681.6 12081.4 12578.2 12615.6 12747.9 12880.0 13375.8 11578.7 11774.7 11848.1 11945.4 12207.2 11350.2 12015.8 12270.3 12413.6 12415.0 11022.8 11571.8 14460.6 14688.3 14899.1 10150.7 11172.4 11314.6 11916.0 12200.2 9639.5 11025.5 11215.7 11388.8 12035.6 00:30:48 INFO - PROCESS | 1645 | -------- Summary: end -------- 00:30:48 INFO - PROCESS | 1645 | 00:30:49 INFO - TEST-INFO | 1645: exit 0 00:30:49 INFO - TEST-OK | dromaeo_css | took 1114407ms 00:30:49 INFO - TEST-START | kraken 00:30:49 INFO - operating with platform_type : mac_ 00:30:49 INFO - Initialising browser for kraken test... 00:30:49 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/tmp1gx09M/profile http://localhost:49236/getInfo.html) 00:30:51 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 00:30:51 INFO - PROCESS | 1653 | colorDepth:24 00:30:51 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 00:30:51 INFO - PROCESS | 1653 | __metrics 00:30:51 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:30:51 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:30:52 INFO - TEST-INFO | 1653: exit 0 00:30:52 INFO - Browser initialized. 00:30:52 INFO - Running cycle 1/1 for kraken test... 00:30:52 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/T/tmp1gx09M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:31:04 INFO - PROCESS | 1655 | RSS: Main: 169193472 00:31:04 INFO - PROCESS | 1655 | 00:31:06 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 00:31:07 INFO - PROCESS | 1655 | RSS: Main: 218542080 00:31:07 INFO - PROCESS | 1655 | 00:31:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 00:31:10 INFO - PROCESS | 1655 | RSS: Main: 232198144 00:31:10 INFO - PROCESS | 1655 | 00:31:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 00:31:14 INFO - PROCESS | 1655 | RSS: Main: 329863168 00:31:14 INFO - PROCESS | 1655 | 00:31:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 00:31:17 INFO - PROCESS | 1655 | RSS: Main: 227557376 00:31:17 INFO - PROCESS | 1655 | 00:31:19 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:31:19 INFO - PROCESS | 1655 | RSS: Main: 227979264 00:31:19 INFO - PROCESS | 1655 | 00:31:22 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 00:31:23 INFO - PROCESS | 1655 | RSS: Main: 268529664 00:31:23 INFO - PROCESS | 1655 | 00:31:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 00:31:26 INFO - PROCESS | 1655 | RSS: Main: 267198464 00:31:26 INFO - PROCESS | 1655 | 00:31:29 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 00:31:29 INFO - PROCESS | 1655 | RSS: Main: 267157504 00:31:29 INFO - PROCESS | 1655 | 00:31:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:31:32 INFO - PROCESS | 1655 | RSS: Main: 240324608 00:31:32 INFO - PROCESS | 1655 | 00:31:33 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:31:34 INFO - PROCESS | 1655 | RSS: Main: 244948992 00:31:34 INFO - PROCESS | 1655 | 00:31:36 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:31:37 INFO - PROCESS | 1655 | RSS: Main: 250388480 00:31:37 INFO - PROCESS | 1655 | 00:31:40 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:31:40 INFO - PROCESS | 1655 | RSS: Main: 259981312 00:31:40 INFO - PROCESS | 1655 | 00:31:43 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:31:44 INFO - PROCESS | 1655 | RSS: Main: 260763648 00:31:44 INFO - PROCESS | 1655 | 00:31:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 00:31:46 INFO - PROCESS | 1655 | RSS: Main: 304324608 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - PROCESS | 1655 | __start_tp_report 00:31:46 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 00:31:46 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 00:31:46 INFO - PROCESS | 1655 | |i|pagename|runs| 00:31:46 INFO - PROCESS | 1655 | |0;ai-astar;112;115;115;113;113;114;113;114;114;115 00:31:46 INFO - PROCESS | 1655 | |1;audio-beat-detection;142;108;110;137;107;107;108;108;131;102 00:31:46 INFO - PROCESS | 1655 | |2;audio-dft;182;181;181;182;184;184;183;181;184;182 00:31:46 INFO - PROCESS | 1655 | |3;audio-fft;80;62;64;110;84;77;58;57;81;58 00:31:46 INFO - PROCESS | 1655 | |4;audio-oscillator;81;92;125;99;75;68;90;67;68;87 00:31:46 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;89;86;89;86;88;85;90;86;90;86 00:31:46 INFO - PROCESS | 1655 | |6;imaging-darkroom;94;94;95;95;93;93;96;95;95;94 00:31:46 INFO - PROCESS | 1655 | |7;imaging-desaturate;87;84;87;86;84;86;84;94;131;85 00:31:46 INFO - PROCESS | 1655 | |8;json-parse-financial;58;54;54;55;57;56;58;57;56;57 00:31:46 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;63;67;69;77;69;67;68;68;68;70 00:31:46 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;84;83;99;97;99;78;80;83;86;88 00:31:46 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;130;152;136;140;149;149;147;140;165;143 00:31:46 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;160;162;161;160;163;163;160;158;158;159 00:31:46 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;68;65;66;66;65;65;66;64;63;64 00:31:46 INFO - PROCESS | 1655 | __end_tp_report 00:31:46 INFO - PROCESS | 1655 | __start_cc_report 00:31:46 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1843 00:31:46 INFO - PROCESS | 1655 | __end_cc_report 00:31:46 INFO - PROCESS | 1655 | __startTimestamp1484037106122__endTimestamp 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - PROCESS | 1655 | ------- Summary: start ------- 00:31:46 INFO - PROCESS | 1655 | Number of tests: 14 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:1.03 (0.9%) stddev-sans-first:0.87 00:31:46 INFO - PROCESS | 1655 | Values: 112.0 115.0 115.0 113.0 113.0 114.0 113.0 114.0 114.0 115.0 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:116.00 Median:109.00 stddev:14.64 (13.4%) stddev-sans-first:12.13 00:31:46 INFO - PROCESS | 1655 | Values: 142.0 108.0 110.0 137.0 107.0 107.0 108.0 108.0 131.0 102.0 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:182.40 Median:182.50 stddev:1.26 (0.7%) stddev-sans-first:1.33 00:31:46 INFO - PROCESS | 1655 | Values: 182.0 181.0 181.0 182.0 184.0 184.0 183.0 181.0 184.0 182.0 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:73.10 Median:70.50 stddev:16.76 (23.8%) stddev-sans-first:17.59 00:31:46 INFO - PROCESS | 1655 | Values: 80.0 62.0 64.0 110.0 84.0 77.0 58.0 57.0 81.0 58.0 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:85.20 Median:84.00 stddev:17.92 (21.3%) stddev-sans-first:18.95 00:31:46 INFO - PROCESS | 1655 | Values: 81.0 92.0 125.0 99.0 75.0 68.0 90.0 67.0 68.0 87.0 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.50 stddev:1.90 (2.1%) stddev-sans-first:1.94 00:31:46 INFO - PROCESS | 1655 | Values: 89.0 86.0 89.0 86.0 88.0 85.0 90.0 86.0 90.0 86.0 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:94.40 Median:95.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 00:31:46 INFO - PROCESS | 1655 | Values: 94.0 94.0 95.0 95.0 93.0 93.0 96.0 95.0 95.0 94.0 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:90.80 Median:86.00 stddev:14.43 (16.8%) stddev-sans-first:15.24 00:31:46 INFO - PROCESS | 1655 | Values: 87.0 84.0 87.0 86.0 84.0 86.0 84.0 94.0 131.0 85.0 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:1.48 (2.6%) stddev-sans-first:1.41 00:31:46 INFO - PROCESS | 1655 | Values: 58.0 54.0 54.0 55.0 57.0 56.0 58.0 57.0 56.0 57.0 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.50 stddev:3.50 (5.1%) stddev-sans-first:3.07 00:31:46 INFO - PROCESS | 1655 | Values: 63.0 67.0 69.0 77.0 69.0 67.0 68.0 68.0 68.0 70.0 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:87.00 stddev:7.86 (9.0%) stddev-sans-first:8.22 00:31:46 INFO - PROCESS | 1655 | Values: 84.0 83.0 99.0 97.0 99.0 78.0 80.0 83.0 86.0 88.0 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:148.00 stddev:9.69 (6.5%) stddev-sans-first:8.60 00:31:46 INFO - PROCESS | 1655 | Values: 130.0 152.0 136.0 140.0 149.0 149.0 147.0 140.0 165.0 143.0 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.50 stddev:1.84 (1.1%) stddev-sans-first:1.94 00:31:46 INFO - PROCESS | 1655 | Values: 160.0 162.0 161.0 160.0 163.0 163.0 160.0 158.0 158.0 159.0 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:1.40 (2.1%) stddev-sans-first:1.05 00:31:46 INFO - PROCESS | 1655 | Values: 68.0 65.0 66.0 66.0 65.0 65.0 66.0 64.0 63.0 64.0 00:31:46 INFO - PROCESS | 1655 | -------- Summary: end -------- 00:31:46 INFO - PROCESS | 1655 | 00:31:46 INFO - TEST-INFO | 1655: exit 0 00:31:46 INFO - TEST-OK | kraken | took 57529ms 00:31:46 INFO - SUITE-END | took 1171s 00:31:47 INFO - Completed test suite (00:19:32) 00:31:47 INFO - javascript benchmark 00:31:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2873.726995935386, 3450.171958729906, 3465.4108801503744, 3476.7913925164476, 3525.242072954316, 5720.771169153234, 5765.913511297334, 5777.942220577793, 5804.187413762077, 5846.649201047935, 5775.36470988192, 5840.474357307841, 5853.385394533577, 5857.238558987337, 5876.529877609792, 5266.947330526694, 5322.946770532303, 5324.893502129955, 5332.653377530468, 5371.597130215249, 5270.631055826094, 5285.577153827685, 5393.1101368274385, 5397.001554712371, 5401.43284955078, 5229.398619158807, 5291.444398338177, 5295.0733621616255, 5298.47015298469, 5325.4940780625775, 5263.631545791796, 5288.391834938954, 5341.679499230058, 5346.572274218053, 5353.197020446964, 5166.974165129188, 5225.4513276105845, 5291.444398338158, 5321.707306098163, 5336.91994620081, 5702.857428564277, 5723.284589426322, 5755.0, 5762.88474230513, 5776.768929242825, 6182.814515564495, 6227.283862355842, 6266.87466250677, 6286.937130628727, 6292.779752708679, 5512.33851937766, 6295.0872123542285, 6310.400511951358, 6319.988801791691, 6342.143810585558, 5744.454276843693, 5756.539476841926, 5799.072148456226, 5801.593888427769, 5822.854428639233, 6257.7184026718905, 6263.0, 6273.215848018997, 6299.811005669837, 6302.558820882494, 6194.132821405007, 6197.876042479215, 6205.906911396332, 6222.408871157233, 6226.283977342573, 6177.413145751147, 6235.96882015587, 6246.031865060832, 6269.937300627026, 6322.462590679752, 6214.151980742363, 6219.378062193835, 6255.56211065221, 6288.402601752826, 6319.905201421982, 6262.3111457739615, 6291.653959032205, 6318.368163183737, 6319.873602528016, 6332.461740752087, 4784.521547845257, 4941.604671626261, 4983.451820299764, 4984.90030199394, 5066.417362003343, 4312.547182545787, 4331.480222373272, 4341.218580655449, 4342.457192850894, 4402.031553058322, 5548.69482178476, 5572.275604171513, 5585.804496842591, 5616.410276920946, 5635.633683810539, 6068.908966365508, 6093.146959425684, 6169.383061693885, 6218.129461875341, 6264.874702505925, 5876.44173803488, 5945.583809133319, 5992.970035149797, 5993.820185394445, 6016.09758536223, 5442.83671489848, 5481.671099734029, 5487.972560137174, 5489.945100549024, 5504.146857237135, 6230.190075290183, 6324.3991820776955, 6437.388448097423, 6458.483321334282, 6463.838404039842, 6222.782202622887, 6223.844403889939, 6240.5319601031015, 6251.9687401562705, 6267.0599410087025, 6408.903866441914, 6411.0, 6429.54993150475, 6440.8389790255615, 6443.484521238196, 6221.222347206599, 6221.2845522765465, 6280.0, 6290.182276304051, 6294.842628934313, 6113.719560719409, 6133.79375043651, 6151.630902145886, 6193.163922870355, 6242.719077641426, 5013.721501017218, 6153.938460615336, 6162.722677479614, 6180.6909654517995, 6207.6585787782105, 6136.29432615255, 6161.168242287234, 6165.229346331708, 6178.41305076017, 6179.907301390573, 5928.970355148197, 5929.0513517836935, 5955.285365756137, 5965.433283838029, 6002.6398416093425, 6152.169457123231, 6190.102435146789, 6217.502599791916, 6225.252969643671, 6226.844328891814, 4793.520647935178, 5482.8211934434285, 5748.971255143865, 5926.229590153425, 6147.170132032118], "value": 5734.707568482009, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.8191887082909, 476.80451015083815, 482.94235623983496, 490.36252871267345, 528.3712382265106, 30822.53766193506, 35231.471527927104, 41406.37890431642, 42751.0, 42985.0, 43976.78011609938, 44358.778206108924, 44750.77624611872, 44833.55166448335, 44924.55075449245, 8288.419810613259, 9301.813963720722, 9984.45085520296, 10156.593736250541, 10170.491475426235, 9344.205742511895, 12141.0, 12404.751904961895, 12436.440360183813, 12525.874741252608, 12415.937920310385, 12474.93762531186, 12492.312922789242, 12508.562200322991, 12509.937450312736, 12270.447829847633, 12338.074644401617, 12359.443825027894, 12374.56689015889, 12388.380580971005, 12197.817032744517, 12273.202241854251, 12287.69280767979, 12298.692532686755, 12328.753424931541, 42004.57995420037, 42302.78848605768, 42388.57611423908, 42465.57534424678, 42527.9368015799, 3522.6477352264824, 3657.561092668897, 3659.780413175218, 3736.981315093434, 4435.112977404532, 31607.683923160705, 31873.521897171562, 32069.35861282761, 32247.51628725571, 32385.676143238503, 3277.8361081946045, 3279.4916787897914, 3356.513305570703, 3386.238096428284, 3393.779404338735, 514508.0, 514967.0, 515884.0, 516397.9999999962, 518019.0, 34613.65386346104, 60409.48976275628, 60714.696426517585, 60750.696246518484, 60824.69587652033, 33997.0, 34276.31447371088, 34354.656453435644, 34385.82807085948, 34976.82511587426, 15484.535463935874, 15653.530394088195, 15654.843451565566, 15661.138637374826, 15686.372545098297, 12205.0, 12234.143609947218, 12258.632241032783, 13430.798538021938, 13532.391042403115, 7469.962650186714, 7530.6611202496015, 7814.10137834145, 7945.0, 7951.204879512118, 2907.646791760011, 3227.6772322767533, 3237.8704851805664, 3279.6064472263483, 3316.3533111043116, 893.4996402014892, 969.5976169889558, 979.9020097990144, 1070.5343175718588, 1081.6106201767357, 30966.845165774026, 31359.216019599236, 31403.528947065814, 31740.523892141173, 32806.50790238148, 948.5209968965628, 1125.909927205838, 1145.919785614999, 1188.5839956015325, 1198.526582000105, 15183.16492592918, 15974.840251597569, 16533.0, 16602.667946641242, 16617.50147495577, 699202.0, 703665.0, 704552.0, 704668.0, 705919.0, 59608.70195648994, 59927.70036149791, 60022.099668505005, 60078.0, 60124.69937650284, 1305.6801083734547, 1338.4980632262902, 1405.8313002439568, 1417.7518934186269, 1447.6742732885227, 30300.69699302979, 31692.366152676357, 32594.83702581472, 32803.835980819946, 33216.83391583027, 50507.74746126246, 51214.23178652248, 51282.0, 51353.0, 51355.71610709762, 558371.0, 558462.0, 558538.2073089608, 560211.0, 562797.0, 28106.87572497077, 28423.147305580867, 28515.28711782222, 29341.26646833846, 29402.705972940854, 48982.5101748978, 48983.75508122579, 49196.75401623112, 49946.0, 49979.50020499894, 33192.17019574434, 40141.59858401379, 40183.79908100441, 40845.591544085364, 42372.0, 40496.98757531085, 40922.97692557591, 41618.79190604028, 41744.12491196019, 42346.15307693891, 39536.01159971024, 39954.200915982095, 40047.799761001006, 40491.0, 40601.39097913475, 34354.484682730275, 35532.0, 35550.82224588861, 36396.72611458692, 36450.63549364579, 26252.60621090647, 26342.73657263403, 26399.868000659873, 26940.32649183786, 26982.595261070706], "value": 19715.030624351017, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.1488211053572, 386.56125297787, 390.3715018819699, 397.1520803085412, 414.2481396265777, 21019.57960840782, 21172.470688232803, 21681.457963550918, 22664.980075896583, 22665.09339626415, 12097.213681110721, 12400.255984640928, 19554.70667939982, 21513.67729484059, 21748.9125543723, 5460.290162278908, 5925.111233315016, 6197.1324014637985, 6241.0, 6298.2442106947, 5300.787968481256, 6198.760247950428, 6216.254049514065, 6291.874162516747, 6296.590721603081, 5201.271821944931, 6274.121622972787, 6315.684215789215, 6329.398707122839, 6338.239411270654, 6022.759089636409, 6186.938130618726, 6280.905786413207, 6312.715927783238, 6336.334684858092, 6116.633002019848, 6121.296050954153, 6129.846753831145, 6133.877322453571, 6139.6009259398, 20292.492687682778, 25988.35029124287, 26853.32866678329, 27024.59463108055, 27256.863715681295, 2159.276642324823, 2535.4548772014105, 2598.9870050649624, 2670.212287375229, 2675.745804148603, 10238.846417303672, 10406.0, 10590.788184236271, 10642.255042147053, 16251.918740406341, 1902.8202514440998, 1914.329984505426, 1917.7794553626372, 1929.2283086765406, 1939.8545109116872, 82686.58656706678, 124165.0, 131224.34387828095, 132979.0, 133245.0, 11457.828132578017, 11736.061115110771, 11836.88163118375, 11851.288922664668, 11884.07533904572, 15434.614134646723, 15457.458988935557, 15481.84518154804, 15484.690306193814, 15492.690146197237, 8975.775605609912, 9106.089391060841, 9107.180353768194, 9107.772305692411, 9228.354015219005, 9064.728058158265, 9074.319426043074, 9089.5000774958, 9229.907700923039, 9247.12152345526, 4687.718736875799, 4687.742174180385, 4710.481846996828, 4727.905441891212, 4750.643701722384, 1796.2545543599522, 1889.2915156816193, 1946.3771593090357, 1950.2101648832245, 1952.9121189546504, 728.3590440412403, 756.5574139128562, 759.1687102622619, 835.8955130608674, 982.8820541535061, 20487.59024819525, 22324.21865234709, 22343.55312893733, 22379.776202238096, 22484.213052543084, 911.4596332198563, 933.8505839065717, 940.7177846645978, 953.8712273843081, 985.3742873275378, 11353.205275630626, 11681.948624623825, 11684.824727628922, 11695.766084678258, 11709.355985420883, 521016.0, 612879.0, 617089.0, 631781.0, 633289.0, 126669.0, 127778.0, 145987.2700636511, 148076.0, 150304.2484787569, 1021.918246540275, 1038.5118994072925, 1049.7165765243494, 1056.1128651932413, 1072.4905669806935, 19385.903070484557, 20712.48218794542, 20746.896265518575, 20778.792212077686, 20797.37607871766, 57434.42565574291, 57988.420115798304, 58624.0, 58895.70552147212, 60253.0962035561, 79956.60021699854, 80009.19990800017, 80197.5990120069, 81289.0, 82563.58718206371, 6291.993281075006, 7858.6070696466095, 8638.26574741154, 8649.740507784776, 8751.474911505331, 13356.599302020955, 13445.462181513021, 13530.0, 13627.795583066063, 14009.299535023005, 11426.657200284004, 11458.369789661316, 11482.0, 11710.70723231926, 11901.345426001306, 11419.0864730823, 11526.193166478266, 11570.88429115698, 11627.418629068343, 12033.338166400932, 11396.772064558829, 11630.360330181922, 11978.520859165885, 12004.75990480203, 12019.519219231133, 8478.23695867375, 8584.957075214834, 8617.741467755977, 8734.56327183651, 8775.297976162019, 11347.20569560123, 11649.068074553847, 12031.518739250332, 12040.0, 12096.334701591497], "value": 9974.13599405593, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1548.5354393681896, 1550.643352029033, 1820.1718218210715, 1927.3350694010578, 1982.1377700700205, 8913.509756963364, 9493.288003399746, 9494.24046076314, 9508.714738557837, 9517.0, 8252.298554622865, 8578.356623253265, 8579.35654825889, 8654.826903461942, 8658.437201581894, 2221.9000144993474, 2391.5336509380677, 2468.8024958003407, 2469.80241580674, 2469.839460435066, 2075.5952589245103, 2422.87885605719, 2430.173740928084, 2454.067454367338, 2471.88876500557, 2428.9271321860283, 2438.280707191374, 2444.352246654638, 2444.767747064026, 2446.755324467548, 2428.6842710447618, 2428.9392765180837, 2431.744666809986, 2434.892124083538, 2438.2928950604305, 2402.027178992511, 2442.584760590686, 2442.792362649177, 2444.1201167579657, 2444.5721998650342, 9279.814403711887, 9288.953555232249, 9370.67202647911, 9419.48192849393, 9421.010793866613, 5434.755436005389, 5596.58025648078, 5609.943900560983, 5612.663240205601, 5615.382307946123, 3502.2820321833965, 3586.067622418164, 3697.186618943828, 3707.295613833363, 3712.535933008374, 1053.536443964653, 1066.3548553125402, 1069.5721711315537, 1071.6249312740556, 1099.9175061870392, 10392.272540922138, 12346.75306493874, 12501.74996500074, 12525.248485090833, 12541.623751287385, 4535.365048893158, 4810.494898035726, 4905.23968784839, 4984.501549844987, 5028.421731500851, 8785.648574057093, 10491.580336786443, 10531.315464494783, 10539.156867450585, 10549.997750213717, 5612.719364031782, 5627.971860140673, 5628.240187574625, 5629.352624448159, 5632.295963004624, 5009.699418034929, 5102.08162530748, 5124.538791508708, 5127.897442051138, 5146.25379320004, 4074.2258970795456, 4108.322126849096, 4137.379393091061, 4183.97908010458, 4219.535851056381, 1313.1989486413281, 1319.9538016169388, 1323.4706117553055, 1332.8333958255218, 1345.5223395694584, 874.6151693254948, 887.3699673232078, 908.6910450446879, 926.8934072581604, 928.2434815625244, 5903.468687818031, 5911.556633252523, 5982.132590774313, 6019.578629495893, 6140.078988151813, 446.76991349455056, 454.3344001038428, 470.22882472744726, 471.8324994626927, 472.5463554987182, 3901.063744701308, 3935.2129574085297, 3944.1914407546383, 3946.0, 4021.3766866135797, 11171.44142792857, 11173.608923687632, 11554.017908477874, 11743.11926605508, 11743.706407339714, 9517.90482095184, 11504.0, 11532.36571988532, 11533.308001519936, 11536.365499897418, 8532.701355452653, 8619.39664223511, 8662.133786621287, 8744.213020828156, 8752.387332886765, 5805.390434004369, 5894.322152952293, 5953.255843019622, 6073.453389194994, 6115.388461153849, 10531.0, 10534.683959481228, 10678.0, 10791.02880740737, 10815.35107893529, 10281.948590257001, 10701.625443109453, 10726.624568140078, 10898.400587967737, 10911.454427278763, 7166.355028047501, 7412.703491860265, 7651.1583725789005, 7756.806079848049, 7846.450748447783, 6916.723331066701, 8799.0, 8882.200601945857, 8886.955565222133, 8889.777755556162, 7807.102183248772, 7829.177936316605, 7839.921600784147, 7853.214678532101, 7898.881516777138, 7659.348955338635, 7694.345980591488, 7726.6136693166245, 7787.143414224318, 7811.960940195263, 7195.676194571152, 7222.06113205301, 7266.091738532684, 7282.96358518204, 7362.0, 4993.300937868628, 5062.645614806928, 5213.139831927841, 5218.582513398843, 5252.597670933395, 5078.898422031465, 5117.334746482933, 5236.371635403623, 5282.075636763474, 5351.5718742501285], "value": 4672.856571366693, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [260.22063918563896, 306.69024285471664, 315.18996179817873, 320.5256220793226, 324.43062425443344, 5326.9733651331735, 5448.839672989667, 5467.371252305986, 5474.972625136868, 5498.340199176105, 4134.090500089983, 4491.910161796762, 5202.297689811874, 5213.791448342071, 5381.865453363658, 3209.3420848726073, 3724.9383925581214, 4051.534073581539, 4058.715889887709, 4072.411759413831, 3901.7854018028997, 4140.979295103521, 4151.584841515854, 4186.204621121992, 4198.433211516437, 3671.871484498043, 3928.4696565963513, 3989.2819292527333, 4113.547509773923, 4118.4440100586335, 3650.8904732858055, 3890.7860067696265, 4139.234241665302, 4174.0817020255645, 4180.393842892779, 3612.3858943979585, 3616.0, 3634.691051260646, 3646.08847788053, 3648.5804132524568, 4327.697061205717, 5067.417247016603, 5289.497497737709, 5301.469853014668, 5326.203743034937, 3919.4708714323488, 4490.7530085845265, 4636.281376386665, 4748.335233067373, 4821.783019764084, 4682.906341873144, 5436.728163591804, 5689.829305120812, 5691.288588926384, 5733.827985160452, 3983.5817239190046, 3993.30451944936, 3996.48045754053, 4021.8592349267633, 4042.7372220805555, 4918.483559226265, 5201.852879008184, 5662.819814371455, 5952.166696662471, 5977.342492325841, 4055.1484188320783, 4068.7355321903983, 4072.714909956334, 4086.40747091676, 4087.89780255496, 4013.6187062229624, 4140.385249752599, 4156.875293741193, 4164.063085805669, 4166.979165104216, 4311.636923199909, 4371.715838470489, 4453.042595841909, 4717.410323709536, 4748.240281555004, 5630.324361076697, 5667.603267771299, 5672.801451949162, 5681.1084407181215, 5709.429057094258, 1228.3182833527478, 1262.1165184370977, 1358.8641135886332, 1401.955543120382, 1402.4390243902317, 765.8468306338755, 823.6293667849492, 915.8855143107112, 942.7313215733483, 960.5245403525299, 4865.637621465995, 5279.577633789288, 5299.920501192485, 5319.893602128013, 5328.8276579152525, 5712.257406537124, 5790.507806836466, 5804.622699524517, 5827.562932780059, 5861.6189947653265, 3894.196178751351, 4204.957950420518, 5107.059317459341, 5267.236250743621, 5480.0, 3115.3924984628234, 3124.42198193335, 3127.5152351385573, 3131.5302704594037, 3133.592632957701, 5327.413984461706, 5468.7539060742365, 5795.246617939641, 5829.065380867897, 6129.448349648553, 5977.880442391128, 6009.969950150221, 6028.457438830526, 6035.818925432244, 6043.637381757021, 5133.409657889316, 6062.968515742129, 6100.75596976116, 6110.419510146529, 6129.816105516842, 4368.213721530155, 5067.695938243717, 5227.895442091213, 5899.233099697012, 5963.582549221686, 5093.032323858455, 5604.682899518692, 5737.827865164052, 5881.7647294109465, 5899.852503687443, 5053.29253904461, 5802.94197058024, 6039.214902062879, 6140.425383089627, 6146.78486252979, 3876.5348158221195, 3944.7041471889147, 3966.3455529838407, 3998.9600103998587, 4006.679465642683, 5036.992601479646, 5994.670293133745, 6020.578559500793, 6021.397860213943, 6026.608270462406, 4631.76841157934, 5109.259157422227, 5324.653897496651, 5445.972770136124, 5864.970675146597, 5065.924011139909, 5753.252077229933, 5790.002449155035, 5795.8551036224435, 5795.884082318415, 5374.4625537445945, 5646.689432081111, 5651.660900345993, 5652.7738890443925, 5708.80019199326, 4316.6330861877095, 4920.237363208708, 5664.159148276909, 5667.4615911488345, 5824.592613321254, 5185.896282074413, 5679.432056794452, 5689.857753556194, 5699.316082070178, 5728.3412407572], "value": 4157.336257726814, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.914210294765, 766.6473422225777, 806.1173015547977, 853.2235665544356, 866.33292364879, 15528.53414397567, 16207.432739854108, 16898.239579218935, 16923.492295231146, 17227.397041103563, 15289.311980960856, 15625.609359766011, 15682.84317156831, 15689.45086921958, 15701.764473532907, 734.7354952217197, 754.6943487887387, 902.9232515236213, 905.8867641544807, 908.2869947091534, 926.2821313482038, 939.5067589515525, 942.4769253064546, 942.4910548303942, 943.3302355327726, 987.5753426026841, 988.5699720621517, 988.9258305627071, 990.1583653894204, 990.8414653655417, 967.6951760195586, 968.5205823117602, 968.6851773173712, 971.2861047130389, 973.4986481961795, 711.8754218011827, 713.7002458967246, 713.9678714457862, 714.4391652552773, 716.8852983522611, 16171.595710107224, 16565.503034908972, 16741.246643901053, 16748.0, 16777.077260750655, 15134.377609032681, 15243.314050867737, 15436.996595221386, 15440.382384704599, 15538.844611553854, 11409.657710268622, 11723.4138293085, 11799.528018879235, 12091.57679481214, 12330.445129969174, 4508.323751437278, 4770.284457331393, 4908.558229759339, 4930.728809915453, 4938.185199442088, 103211.48394258055, 113765.0, 114034.0, 115628.0, 118629.0, 10352.792944141074, 10844.295120817122, 10856.240063195659, 11208.55165793359, 11630.592929247436, 21534.56930861374, 21559.676604850938, 21567.568648627253, 21572.352829415144, 21580.244691435724, 7716.151223365426, 7777.0, 8114.350851931831, 8147.837043259102, 8197.672093116327, 4013.177298653769, 4404.053128577307, 4523.11799199153, 4523.457185137804, 4678.649101317346, 3507.2985402919517, 3612.512310838003, 3613.891583252454, 3623.0761155905075, 3636.1636823530735, 652.7584793626388, 657.5824351536809, 664.6311297230084, 671.2750229751954, 679.2935347238915, 544.5453046705966, 577.6418620455345, 656.678227668439, 656.8522082531392, 658.5061204096927, 8028.237317454832, 8539.701110461105, 9154.176124148858, 9172.633094676139, 9213.170814626716, 532.597888594109, 572.928383952006, 576.2969177603318, 603.1375133559053, 651.9119918810994, 3635.381985062546, 3880.5343358797127, 4139.296319625671, 4187.958120418818, 4233.5131459881895, 87772.12227877768, 88824.6676299856, 102637.0, 154465.0, 164165.17917410337, 117364.0, 117744.0, 119833.99999999825, 126193.73806262003, 126726.73273267334, 114608.0, 115914.0, 118702.81297186918, 119463.40268298777, 121401.39299303624, 8271.33829293643, 8428.325733941147, 8546.316294696286, 8567.314614830673, 8732.91267087321, 63763.0, 64727.67636161789, 69098.16312858052, 69828.65085674742, 70595.58808823692, 76319.0, 83776.0, 89383.0, 95655.04344956462, 96742.51628741811, 11404.543818247177, 11472.598459053894, 11593.338601225518, 11681.649550513499, 12081.395930203278, 12578.245305281713, 12615.621531354074, 12747.899201275759, 12880.0, 13375.799363009368, 11578.652640420802, 11774.705632359259, 11848.111391645489, 11945.402729863647, 12207.206531575419, 11350.205485615928, 12015.819762703391, 12270.263784172621, 12413.627591172279, 12415.0, 11022.779544408906, 11571.826422603499, 14460.638484037983, 14688.339024743698, 14899.106053636817, 10150.695479135638, 11172.385518796544, 11314.60398886035, 11916.0, 12200.206986545845, 9639.481589220024, 11025.503852326505, 11215.710193327546, 11388.829167562659, 12035.638930832089], "value": 7831.194992486195, "unit": "score"}], "name": "dromaeo_css", "value": 7454.337317064611, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 115.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 110.0, 137.0, 107.0, 107.0, 108.0, 108.0, 131.0, 102.0], "value": 116.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 181.0, 181.0, 182.0, 184.0, 184.0, 183.0, 181.0, 184.0, 182.0], "value": 182.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 62.0, 64.0, 110.0, 84.0, 77.0, 58.0, 57.0, 81.0, 58.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 92.0, 125.0, 99.0, 75.0, 68.0, 90.0, 67.0, 68.0, 87.0], "value": 85.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 86.0, 88.0, 85.0, 90.0, 86.0, 90.0, 86.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 93.0, 93.0, 96.0, 95.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 86.0, 84.0, 86.0, 84.0, 94.0, 131.0, 85.0], "value": 90.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 54.0, 55.0, 57.0, 56.0, 58.0, 57.0, 56.0, 57.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 69.0, 77.0, 69.0, 67.0, 68.0, 68.0, 68.0, 70.0], "value": 68.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 99.0, 97.0, 99.0, 78.0, 80.0, 83.0, 86.0, 88.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 152.0, 136.0, 140.0, 149.0, 149.0, 147.0, 140.0, 165.0, 143.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 160.0, 163.0, 163.0, 160.0, 158.0, 158.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 64.0, 63.0, 64.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1426.4, "alertThreshold": 2.0}]} 00:31:47 INFO - Return code: 0 00:31:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:31:47 INFO - # TBPL SUCCESS # 00:31:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:31:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:31:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:31:47 INFO - 2017-01-10 00:31:47.462 screenresolution[1659:10106] starting screenresolution argv=screenresolution get 00:31:47 INFO - 2017-01-10 00:31:47.465 screenresolution[1659:10106] Display 0: 1600x1200x32@60 00:31:47 INFO - 2017-01-10 00:31:47.471 screenresolution[1660:10109] starting screenresolution argv=screenresolution list 00:31:47 INFO - Available Modes on Display 0 00:31:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:31:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:31:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:31:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:31:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:31:47 INFO - Intel Iris: 00:31:47 INFO - Chipset Model: Intel Iris 00:31:47 INFO - Type: GPU 00:31:47 INFO - Bus: Built-In 00:31:47 INFO - VRAM (Dynamic, Max): 1536 MB 00:31:47 INFO - Vendor: Intel (0x8086) 00:31:47 INFO - Device ID: 0x0a2e 00:31:47 INFO - Revision ID: 0x0009 00:31:47 INFO - Displays: 00:31:47 INFO - Display: 00:31:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:31:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:31:47 INFO - Display Serial Number: 1600x1200 60 00:31:47 INFO - Main Display: Yes 00:31:47 INFO - Mirror: Off 00:31:47 INFO - Online: Yes 00:31:47 INFO - Rotation: Supported 00:31:47 INFO - Return code: 0 00:31:47 INFO - Running post-action listener: _resource_record_post_action 00:31:47 INFO - [mozharness: 2017-01-10 08:31:47.695300Z] Finished run-tests step (success) 00:31:47 INFO - Running post-run listener: _resource_record_post_run 00:31:47 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 32418816; Write bytes: 492481536; Read time: 200; Write time: 1539 00:31:47 INFO - TinderboxPrint: CPU usage
53.2% 00:31:47 INFO - TinderboxPrint: I/O read bytes / time
32,418,816 / 200 00:31:47 INFO - TinderboxPrint: I/O write bytes / time
492,481,536 / 1,539 00:31:47 INFO - TinderboxPrint: CPU idle
2,235.3 (46.8%) 00:31:47 INFO - TinderboxPrint: CPU system
954.3 (20.0%) 00:31:47 INFO - TinderboxPrint: CPU user
1,588.1 (33.2%) 00:31:47 INFO - TinderboxPrint: Swap in / out
223,838,208 / 0 00:31:47 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 196317696; Write bytes: 197965824; Read time: 17764; Write time: 451 00:31:47 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 29137920; Write bytes: 293004288; Read time: 177; Write time: 1082 00:31:48 INFO - Running post-run listener: _upload_blobber_files 00:31:48 INFO - Blob upload gear active. 00:31:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:31:48 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 00:31:48 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:31:48 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:31:48 INFO - (blobuploader) - INFO - Open directory for files ... 00:31:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:31:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:31:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:31:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:31:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:31:49 INFO - (blobuploader) - INFO - Done attempting. 00:31:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:31:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:31:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:31:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:31:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:31:50 INFO - (blobuploader) - INFO - Done attempting. 00:31:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:31:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:31:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:31:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:31:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:31:52 INFO - (blobuploader) - INFO - Done attempting. 00:31:52 INFO - (blobuploader) - INFO - Iteration through files over. 00:31:52 INFO - Return code: 0 00:31:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:31:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:31:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee96f39db63b09e1673de9cee1f0621f9d025541cc08980c19b09c328967b41eae79f636683a5ca83162a919ce1ee7f3dfbe3f631604511f9bd6d7c692d73469", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a15c3a373716934968edcf21f434a9418af357cf8336850b06fb6b92476b2abdc7b37d3c61d0bee853717dc5d8e5292954266414de12c6e41856828658afab4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7dbc19892538cd68565d93115a846e0d4828fd8b563048f56e3cbbd4e687f1e1b3b258e289c48aa086f1d91c5094a70cec3f7d0e2595daf9bdc21ba69c9f1611"} 00:31:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:31:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:31:52 INFO - Contents: 00:31:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee96f39db63b09e1673de9cee1f0621f9d025541cc08980c19b09c328967b41eae79f636683a5ca83162a919ce1ee7f3dfbe3f631604511f9bd6d7c692d73469", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a15c3a373716934968edcf21f434a9418af357cf8336850b06fb6b92476b2abdc7b37d3c61d0bee853717dc5d8e5292954266414de12c6e41856828658afab4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7dbc19892538cd68565d93115a846e0d4828fd8b563048f56e3cbbd4e687f1e1b3b258e289c48aa086f1d91c5094a70cec3f7d0e2595daf9bdc21ba69c9f1611"} 00:31:52 INFO - Running post-run listener: copy_logs_to_upload_dir 00:31:52 INFO - Copying logs to upload dir... 00:31:52 INFO - mkdir: /builds/slave/test/build/upload/logs 00:31:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.759671 ========= master_lag: 1.10 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-01-10 00:31:53.692151) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2017-01-10 00:31:53.696869) ========= 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.Tvo3C1ZFJm/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.P2IwB3BFy5/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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/Mozilla-Beta/sha512/ee96f39db63b09e1673de9cee1f0621f9d025541cc08980c19b09c328967b41eae79f636683a5ca83162a919ce1ee7f3dfbe3f631604511f9bd6d7c692d73469", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a15c3a373716934968edcf21f434a9418af357cf8336850b06fb6b92476b2abdc7b37d3c61d0bee853717dc5d8e5292954266414de12c6e41856828658afab4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7dbc19892538cd68565d93115a846e0d4828fd8b563048f56e3cbbd4e687f1e1b3b258e289c48aa086f1d91c5094a70cec3f7d0e2595daf9bdc21ba69c9f1611"} build_url:https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011040 build_url: 'https://queue.taskcluster.net/v1/task/MghsYWIJQCmnAz7iMH8ZHw/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ee96f39db63b09e1673de9cee1f0621f9d025541cc08980c19b09c328967b41eae79f636683a5ca83162a919ce1ee7f3dfbe3f631604511f9bd6d7c692d73469", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a15c3a373716934968edcf21f434a9418af357cf8336850b06fb6b92476b2abdc7b37d3c61d0bee853717dc5d8e5292954266414de12c6e41856828658afab4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7dbc19892538cd68565d93115a846e0d4828fd8b563048f56e3cbbd4e687f1e1b3b258e289c48aa086f1d91c5094a70cec3f7d0e2595daf9bdc21ba69c9f1611"}' ========= master_lag: 2.16 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2017-01-10 00:31:55.863104) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 00:31:55.863496) ========= 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.Tvo3C1ZFJm/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.P2IwB3BFy5/Listeners TMPDIR=/var/folders/85/j97sz5wj77sdq3g1dc7sg48000000w/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.005338 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-10 00:31:55.891827) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 00:31:55.892135) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-10 00:31:55.892505) ========= ========= Total master_lag: 3.46 =========