builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0078 starttime: 1473596708.92 results: success (0) buildid: 20160911030419 builduid: b54cbc92bb4b4aa8927496db0d48c654 revision: 7e873393cc11d326338779e5a3ed2da031e30936 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-11 05:25:08.918188) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-11 05:25:08.918612) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-11 05:25:08.918928) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-11 05:25:09.212354) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-11 05:25:09.212612) ========= 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.1kwicHsD6r/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.6zwGCMXfzd/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 --2016-09-11 05:25:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.21M=0.001s 2016-09-11 05:25:09 (8.21 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.576374 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-11 05:25:09.818268) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-11 05:25:09.818598) ========= 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.1kwicHsD6r/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.6zwGCMXfzd/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.020706 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-11 05:25:09.868897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-11 05:25:09.869265) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7e873393cc11d326338779e5a3ed2da031e30936 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 7e873393cc11d326338779e5a3ed2da031e30936 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1kwicHsD6r/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.6zwGCMXfzd/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 2016-09-11 05:25:09,945 truncating revision to first 12 chars 2016-09-11 05:25:09,945 Setting DEBUG logging. 2016-09-11 05:25:09,946 attempt 1/10 2016-09-11 05:25:09,946 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7e873393cc11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-11 05:25:10,931 unpacking tar archive at: mozilla-central-7e873393cc11/testing/mozharness/ program finished with exit code 0 elapsedTime=1.258301 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-11 05:25:11.149819) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-11 05:25:11.150123) ========= script_repo_revision: 7e873393cc11d326338779e5a3ed2da031e30936 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-11 05:25:11.150512) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-11 05:25:11.150778) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-11 05:25:11.169946) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-11 05:25:11.170646) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1kwicHsD6r/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.6zwGCMXfzd/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:25:11 INFO - MultiFileLogger online at 20160911 05:25:11 in /builds/slave/test 05:25:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:25:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:25:11 INFO - {'append_to_log': False, 05:25:11 INFO - 'base_work_dir': '/builds/slave/test', 05:25:11 INFO - 'blob_upload_branch': 'Firefox', 05:25:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:25:11 INFO - 'branch': 'Firefox', 05:25:11 INFO - 'buildbot_json_path': 'buildprops.json', 05:25:11 INFO - 'config_files': ('talos/mac_config.py',), 05:25:11 INFO - 'default_actions': ('clobber', 05:25:11 INFO - 'read-buildbot-config', 05:25:11 INFO - 'download-and-extract', 05:25:11 INFO - 'populate-webroot', 05:25:11 INFO - 'create-virtualenv', 05:25:11 INFO - 'install', 05:25:11 INFO - 'run-tests'), 05:25:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:25:11 INFO - 'download_minidump_stackwalk': True, 05:25:11 INFO - 'download_symbols': 'ondemand', 05:25:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:25:11 INFO - 'tooltool.py': '/tools/tooltool.py', 05:25:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:25:11 INFO - '/tools/misc-python/virtualenv.py')}, 05:25:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:25:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:25:11 INFO - 'installer_path': 'installer.exe', 05:25:11 INFO - 'log_level': 'info', 05:25:11 INFO - 'log_name': 'talos', 05:25:11 INFO - 'log_to_console': True, 05:25:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:25:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:25:11 INFO - 'opt_config_files': (), 05:25:11 INFO - 'pip_index': False, 05:25:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:25:11 INFO - 'cmd': ('bash', 05:25:11 INFO - '-c', 05:25:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:25:11 INFO - 'enabled': True, 05:25:11 INFO - 'halt_on_failure': False, 05:25:11 INFO - 'name': 'check_screen_resolution'},), 05:25:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:25:11 INFO - 'cmd': ('bash', 05:25:11 INFO - '-c', 05:25:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:25:11 INFO - 'enabled': True, 05:25:11 INFO - 'halt_on_failure': False, 05:25:11 INFO - 'name': 'check_screen_resolution'},), 05:25:11 INFO - 'run_cmd_checks_enabled': True, 05:25:11 INFO - 'sps_profile': False, 05:25:11 INFO - 'sps_profile_interval': 0, 05:25:11 INFO - 'suite': 'dromaeojs', 05:25:11 INFO - 'system_bits': '32', 05:25:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:25:11 INFO - 'title': 't-yosemite-r7-0078', 05:25:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:25:11 INFO - 'use_talos_json': True, 05:25:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:25:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:25:11 INFO - 'work_dir': 'build'} 05:25:11 INFO - [mozharness: 2016-09-11 12:25:11.379513Z] Running clobber step. 05:25:11 INFO - Running pre-action listener: _resource_record_pre_action 05:25:11 INFO - Running main action method: clobber 05:25:11 INFO - rmtree: /builds/slave/test/build 05:25:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:25:11 INFO - Running post-action listener: _resource_record_post_action 05:25:11 INFO - [mozharness: 2016-09-11 12:25:11.971637Z] Finished clobber step (success) 05:25:11 INFO - [mozharness: 2016-09-11 12:25:11.971938Z] Running read-buildbot-config step. 05:25:11 INFO - Running pre-action listener: _resource_record_pre_action 05:25:11 INFO - Running main action method: read_buildbot_config 05:25:11 INFO - Using buildbot properties: 05:25:11 INFO - { 05:25:11 INFO - "project": "", 05:25:11 INFO - "product": "firefox", 05:25:11 INFO - "script_repo_revision": "production", 05:25:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:25:11 INFO - "repository": "", 05:25:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:25:11 INFO - "buildid": "20160911030419", 05:25:11 INFO - "stage_platform": "macosx64", 05:25:11 INFO - "basedir": "/builds/slave/test", 05:25:11 INFO - "nightly_build": "True", 05:25:11 INFO - "buildnumber": 44, 05:25:11 INFO - "slavename": "t-yosemite-r7-0078", 05:25:11 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:25:11 INFO - "platform": "yosemite_r7", 05:25:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:25:11 INFO - "branch": "mozilla-central", 05:25:11 INFO - "repo_path": "mozilla-central", 05:25:11 INFO - "revision": "7e873393cc11d326338779e5a3ed2da031e30936", 05:25:11 INFO - "pgo_build": "False", 05:25:11 INFO - "builduid": "b54cbc92bb4b4aa8927496db0d48c654", 05:25:11 INFO - "slavebuilddir": "test" 05:25:11 INFO - } 05:25:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:25:11 INFO - Running post-action listener: _resource_record_post_action 05:25:11 INFO - [mozharness: 2016-09-11 12:25:11.978112Z] Finished read-buildbot-config step (success) 05:25:11 INFO - [mozharness: 2016-09-11 12:25:11.978374Z] Running download-and-extract step. 05:25:11 INFO - Running pre-action listener: _resource_record_pre_action 05:25:11 INFO - Running main action method: download_and_extract 05:25:11 INFO - mkdir: /builds/slave/test/build/tests 05:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:11 INFO - trying https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:25:11 INFO - Downloading https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:25:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 05:25:13 INFO - Downloaded 1199 bytes. 05:25:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:25:13 INFO - Using the following test package requirements: 05:25:13 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:25:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:25:13 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:25:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:25:13 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:25:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:25:13 INFO - u'jsshell-mac.zip'], 05:25:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:25:13 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:25:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:25:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:25:13 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:25:13 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:25:13 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:25:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:25:13 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:25:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:25:13 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:25:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:25:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:25:14 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 05:25:21 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:25:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:25:22 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 05:25:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:25:29 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 05:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:30 INFO - trying https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:25:30 INFO - Downloading https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:25:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 05:25:36 INFO - Downloaded 111798448 bytes. 05:25:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:25:36 INFO - mkdir: /builds/slave/test/properties 05:25:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:25:36 INFO - Writing to file /builds/slave/test/properties/build_url 05:25:36 INFO - Contents: 05:25:36 INFO - build_url:https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:25:36 INFO - Running post-action listener: _resource_record_post_action 05:25:36 INFO - Running post-action listener: set_extra_try_arguments 05:25:36 INFO - [mozharness: 2016-09-11 12:25:36.720135Z] Finished download-and-extract step (success) 05:25:36 INFO - [mozharness: 2016-09-11 12:25:36.720265Z] Running populate-webroot step. 05:25:36 INFO - Running pre-action listener: _resource_record_pre_action 05:25:36 INFO - Running main action method: populate_webroot 05:25:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:25:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:25:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:25:36 INFO - '--tppagecycles', 05:25:36 INFO - '7'], 05:25:36 INFO - 'tests': ['tsvgm']}}, 05:25:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:25:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:25:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:25:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:25:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:25:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:25:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:36 INFO - 'talos_options': ['--disable-e10s'], 05:25:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:36 INFO - 'talos_options': ['--disable-e10s'], 05:25:36 INFO - 'tests': ['damp', 'tps']}, 05:25:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:36 INFO - 'tests': ['damp', 'tps']}, 05:25:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:25:36 INFO - 'tests': ['dromaeo_dom']}, 05:25:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:25:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:25:36 INFO - 'tests': ['basic_compositor_video']}, 05:25:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:25:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:25:36 INFO - 'tests': ['a11yr', 05:25:36 INFO - 'ts_paint', 05:25:36 INFO - 'tpaint', 05:25:36 INFO - 'sessionrestore', 05:25:36 INFO - 'sessionrestore_no_auto_restore', 05:25:36 INFO - 'tabpaint']}, 05:25:36 INFO - 'other-e10s': {'tests': ['a11yr', 05:25:36 INFO - 'ts_paint', 05:25:36 INFO - 'tpaint', 05:25:36 INFO - 'sessionrestore', 05:25:36 INFO - 'sessionrestore_no_auto_restore', 05:25:36 INFO - 'tabpaint']}, 05:25:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:25:36 INFO - 'ts_paint', 05:25:36 INFO - 'tpaint', 05:25:36 INFO - 'sessionrestore', 05:25:36 INFO - 'sessionrestore_no_auto_restore', 05:25:36 INFO - 'tabpaint']}, 05:25:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:25:36 INFO - 'ts_paint', 05:25:36 INFO - 'tpaint', 05:25:36 INFO - 'sessionrestore', 05:25:36 INFO - 'sessionrestore_no_auto_restore', 05:25:36 INFO - 'tabpaint']}, 05:25:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:25:36 INFO - 'tests': ['a11yr', 05:25:36 INFO - 'ts_paint', 05:25:36 INFO - 'tpaint', 05:25:36 INFO - 'sessionrestore', 05:25:36 INFO - 'sessionrestore_no_auto_restore', 05:25:36 INFO - 'tabpaint']}, 05:25:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:25:36 INFO - 'tests': ['a11yr', 05:25:36 INFO - 'ts_paint', 05:25:36 INFO - 'tpaint', 05:25:36 INFO - 'sessionrestore', 05:25:36 INFO - 'sessionrestore_no_auto_restore', 05:25:36 INFO - 'tabpaint']}, 05:25:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:25:36 INFO - 'tests': ['tsvgx', 05:25:36 INFO - 'tsvgr_opacity', 05:25:36 INFO - 'tart', 05:25:36 INFO - 'tscrollx', 05:25:36 INFO - 'cart']}, 05:25:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:25:36 INFO - 'tsvgr_opacity', 05:25:36 INFO - 'tart', 05:25:36 INFO - 'tscrollx', 05:25:36 INFO - 'cart']}, 05:25:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:36 INFO - 'talos_options': ['--disable-e10s'], 05:25:36 INFO - 'tests': ['tp5o']}, 05:25:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:36 INFO - 'tests': ['tp5o']}, 05:25:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:36 INFO - 'talos_options': ['--disable-e10s', 05:25:36 INFO - '--xperf_path', 05:25:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:36 INFO - 'tests': ['tp5n']}, 05:25:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:25:36 INFO - 'talos_options': ['--xperf_path', 05:25:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:36 INFO - 'tests': ['tp5n']}}, 05:25:36 INFO - 'talos.zip': {'path': '', 05:25:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:25:36 INFO - Running post-action listener: _resource_record_post_action 05:25:36 INFO - [mozharness: 2016-09-11 12:25:36.739165Z] Finished populate-webroot step (success) 05:25:36 INFO - [mozharness: 2016-09-11 12:25:36.739270Z] Running create-virtualenv step. 05:25:36 INFO - Running pre-action listener: _resource_record_pre_action 05:25:36 INFO - Running main action method: create_virtualenv 05:25:36 INFO - Creating virtualenv /builds/slave/test/build/venv 05:25:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:25:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:25:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:25:36 INFO - Using real prefix '/tools/python27' 05:25:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:25:37 INFO - Installing distribute.............................................................................................................................................................................................done. 05:25:40 INFO - Installing pip.................done. 05:25:40 INFO - Return code: 0 05:25:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:40 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 0x10f7d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f74b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d98d906c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e9d30>, '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 0x10f40fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e1b20>, '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.1kwicHsD6r/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.6zwGCMXfzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:25:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1kwicHsD6r/Render', 05:25:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:40 INFO - 'HOME': '/Users/cltbld', 05:25:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:40 INFO - 'LOGNAME': 'cltbld', 05:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:40 INFO - 'MOZ_NO_REMOTE': '1', 05:25:40 INFO - 'NO_EM_RESTART': '1', 05:25:40 INFO - 'PAGER': '/bin/cat', 05:25:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:40 INFO - 'PWD': '/builds/slave/test', 05:25:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:40 INFO - 'SHELL': '/bin/bash', 05:25:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6zwGCMXfzd/Listeners', 05:25:40 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:25:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:40 INFO - 'USER': 'cltbld', 05:25:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:40 INFO - 'XPC_FLAGS': '0x0', 05:25:40 INFO - 'XPC_SERVICE_NAME': '0', 05:25:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:25:40 INFO - Cleaning up... 05:25:40 INFO - Return code: 0 05:25:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:40 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 0x10f7d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f74b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d98d906c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e9d30>, '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 0x10f40fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e1b20>, '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.1kwicHsD6r/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.6zwGCMXfzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:25:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1kwicHsD6r/Render', 05:25:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:40 INFO - 'HOME': '/Users/cltbld', 05:25:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:40 INFO - 'LOGNAME': 'cltbld', 05:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:40 INFO - 'MOZ_NO_REMOTE': '1', 05:25:40 INFO - 'NO_EM_RESTART': '1', 05:25:40 INFO - 'PAGER': '/bin/cat', 05:25:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:40 INFO - 'PWD': '/builds/slave/test', 05:25:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:40 INFO - 'SHELL': '/bin/bash', 05:25:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6zwGCMXfzd/Listeners', 05:25:40 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:25:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:40 INFO - 'USER': 'cltbld', 05:25:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:40 INFO - 'XPC_FLAGS': '0x0', 05:25:40 INFO - 'XPC_SERVICE_NAME': '0', 05:25:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:40 INFO - Downloading/unpacking psutil>=3.1.1 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:25:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:44 INFO - Installing collected packages: psutil 05:25:44 INFO - Running setup.py install for psutil 05:25:44 INFO - building 'psutil._psutil_osx' extension 05:25:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:25:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:25:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:25:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:25:44 INFO - building 'psutil._psutil_posix' extension 05:25:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:25:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:25:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:25:44 INFO - ^ 05:25:45 INFO - 1 warning generated. 05:25:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:25:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:25:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:25:45 INFO - Successfully installed psutil 05:25:45 INFO - Cleaning up... 05:25:45 INFO - Return code: 0 05:25:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f7d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f74b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d98d906c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e9d30>, '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 0x10f40fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e1b20>, '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.1kwicHsD6r/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.6zwGCMXfzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:25:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:25:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1kwicHsD6r/Render', 05:25:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:45 INFO - 'HOME': '/Users/cltbld', 05:25:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:45 INFO - 'LOGNAME': 'cltbld', 05:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:45 INFO - 'MOZ_NO_REMOTE': '1', 05:25:45 INFO - 'NO_EM_RESTART': '1', 05:25:45 INFO - 'PAGER': '/bin/cat', 05:25:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:45 INFO - 'PWD': '/builds/slave/test', 05:25:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:45 INFO - 'SHELL': '/bin/bash', 05:25:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6zwGCMXfzd/Listeners', 05:25:45 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:25:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:45 INFO - 'USER': 'cltbld', 05:25:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:45 INFO - 'XPC_FLAGS': '0x0', 05:25:45 INFO - 'XPC_SERVICE_NAME': '0', 05:25:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:25:48 INFO - Installing collected packages: mozsystemmonitor 05:25:48 INFO - Running setup.py install for mozsystemmonitor 05:25:48 INFO - Successfully installed mozsystemmonitor 05:25:48 INFO - Cleaning up... 05:25:48 INFO - Return code: 0 05:25:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f7d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f74b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d98d906c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e9d30>, '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 0x10f40fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e1b20>, '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.1kwicHsD6r/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.6zwGCMXfzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:25:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1kwicHsD6r/Render', 05:25:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:48 INFO - 'HOME': '/Users/cltbld', 05:25:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:48 INFO - 'LOGNAME': 'cltbld', 05:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:48 INFO - 'MOZ_NO_REMOTE': '1', 05:25:48 INFO - 'NO_EM_RESTART': '1', 05:25:48 INFO - 'PAGER': '/bin/cat', 05:25:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:48 INFO - 'PWD': '/builds/slave/test', 05:25:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:48 INFO - 'SHELL': '/bin/bash', 05:25:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6zwGCMXfzd/Listeners', 05:25:48 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:25:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:48 INFO - 'USER': 'cltbld', 05:25:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:48 INFO - 'XPC_FLAGS': '0x0', 05:25:48 INFO - 'XPC_SERVICE_NAME': '0', 05:25:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:48 INFO - Downloading/unpacking jsonschema==2.5.1 05:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:25:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:51 INFO - Downloading functools32-3.2.3-2.tar.gz 05:25:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:25:51 INFO - warning: no files found matching '*.txt' 05:25:51 INFO - no previously-included directories found matching 'build' 05:25:51 INFO - no previously-included directories found matching 'dist' 05:25:51 INFO - no previously-included directories found matching '.git*' 05:25:51 INFO - Installing collected packages: jsonschema, functools32 05:25:51 INFO - Running setup.py install for functools32 05:25:51 INFO - warning: no files found matching '*.txt' 05:25:51 INFO - no previously-included directories found matching 'build' 05:25:51 INFO - no previously-included directories found matching 'dist' 05:25:51 INFO - no previously-included directories found matching '.git*' 05:25:51 INFO - Successfully installed jsonschema functools32 05:25:51 INFO - Cleaning up... 05:25:51 INFO - Return code: 0 05:25:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:25: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')]} 05:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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')]} 05:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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', '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 0x10f7d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f74b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d98d906c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e9d30>, '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 0x10f40fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e1b20>, '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.1kwicHsD6r/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.6zwGCMXfzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:25: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 functools32==3.2.3-2 05:25:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1kwicHsD6r/Render', 05:25:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:51 INFO - 'HOME': '/Users/cltbld', 05:25:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:51 INFO - 'LOGNAME': 'cltbld', 05:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:51 INFO - 'MOZ_NO_REMOTE': '1', 05:25:51 INFO - 'NO_EM_RESTART': '1', 05:25:51 INFO - 'PAGER': '/bin/cat', 05:25:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:51 INFO - 'PWD': '/builds/slave/test', 05:25:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:51 INFO - 'SHELL': '/bin/bash', 05:25:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6zwGCMXfzd/Listeners', 05:25:51 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:25:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:51 INFO - 'USER': 'cltbld', 05:25:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:51 INFO - 'XPC_FLAGS': '0x0', 05:25:51 INFO - 'XPC_SERVICE_NAME': '0', 05:25:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:25:51 INFO - Cleaning up... 05:25:51 INFO - Return code: 0 05:25:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:25: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')]} 05:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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')]} 05:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25: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', '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 0x10f7d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f74b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d98d906c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e9d30>, '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 0x10f40fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e1b20>, '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.1kwicHsD6r/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.6zwGCMXfzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:25: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 blobuploader==1.2.4 05:25:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1kwicHsD6r/Render', 05:25:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:51 INFO - 'HOME': '/Users/cltbld', 05:25:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:51 INFO - 'LOGNAME': 'cltbld', 05:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:51 INFO - 'MOZ_NO_REMOTE': '1', 05:25:51 INFO - 'NO_EM_RESTART': '1', 05:25:51 INFO - 'PAGER': '/bin/cat', 05:25:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:51 INFO - 'PWD': '/builds/slave/test', 05:25:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:51 INFO - 'SHELL': '/bin/bash', 05:25:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6zwGCMXfzd/Listeners', 05:25:51 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:25:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:51 INFO - 'USER': 'cltbld', 05:25:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:51 INFO - 'XPC_FLAGS': '0x0', 05:25:51 INFO - 'XPC_SERVICE_NAME': '0', 05:25:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:52 INFO - Downloading/unpacking blobuploader==1.2.4 05:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:54 INFO - Downloading blobuploader-1.2.4.tar.gz 05:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:25:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:25:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:55 INFO - Downloading docopt-0.6.1.tar.gz 05:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:25:55 INFO - Installing collected packages: blobuploader, requests, docopt 05:25:55 INFO - Running setup.py install for blobuploader 05:25:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:25:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:25:56 INFO - Running setup.py install for requests 05:25:56 INFO - Running setup.py install for docopt 05:25:56 INFO - Successfully installed blobuploader requests docopt 05:25:56 INFO - Cleaning up... 05:25:56 INFO - Return code: 0 05:25:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:56 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 0x10f7d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f74b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d98d906c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e9d30>, '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 0x10f40fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e1b20>, '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.1kwicHsD6r/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.6zwGCMXfzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:25:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1kwicHsD6r/Render', 05:25:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:56 INFO - 'HOME': '/Users/cltbld', 05:25:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:56 INFO - 'LOGNAME': 'cltbld', 05:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:56 INFO - 'MOZ_NO_REMOTE': '1', 05:25:56 INFO - 'NO_EM_RESTART': '1', 05:25:56 INFO - 'PAGER': '/bin/cat', 05:25:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:56 INFO - 'PWD': '/builds/slave/test', 05:25:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:56 INFO - 'SHELL': '/bin/bash', 05:25:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6zwGCMXfzd/Listeners', 05:25:56 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:25:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:56 INFO - 'USER': 'cltbld', 05:25:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:56 INFO - 'XPC_FLAGS': '0x0', 05:25:56 INFO - 'XPC_SERVICE_NAME': '0', 05:25:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:25:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-oYcHNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:25:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-MteDRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:25:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-LKROMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:25:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-ZFkqAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:25:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-qR0uEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:25:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-Up3tJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:25:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-trn4ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:25:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-K_ZYku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:25:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-RjxznI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:25:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-n7Hm_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:25:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-JJbitb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:25:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-tqlMvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:25:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-AmA1Pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:25:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-WBx8Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-nKPRTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:25:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-odkJ5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:25:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-3kpg4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:25:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:25:58 INFO - Running setup.py install for manifestparser 05:25:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:25:59 INFO - Running setup.py install for mozcrash 05:25:59 INFO - Running setup.py install for mozdebug 05:25:59 INFO - Running setup.py install for mozdevice 05:25:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:25:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:25:59 INFO - Running setup.py install for mozfile 05:25:59 INFO - Running setup.py install for mozhttpd 05:25:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:25:59 INFO - Running setup.py install for mozinfo 05:25:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:25:59 INFO - Running setup.py install for mozInstall 05:26:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Running setup.py install for mozleak 05:26:00 INFO - Running setup.py install for mozlog 05:26:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Running setup.py install for moznetwork 05:26:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Running setup.py install for mozprocess 05:26:00 INFO - Running setup.py install for mozprofile 05:26:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:26:00 INFO - Running setup.py install for mozrunner 05:26:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Running setup.py install for mozscreenshot 05:26:01 INFO - Running setup.py install for moztest 05:26:01 INFO - Running setup.py install for mozversion 05:26:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:26:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:26:01 INFO - Cleaning up... 05:26:01 INFO - Return code: 0 05:26:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:01 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 0x10f7d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f74b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d98d906c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e9d30>, '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 0x10f40fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e1b20>, '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.1kwicHsD6r/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.6zwGCMXfzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:26:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:26:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1kwicHsD6r/Render', 05:26:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:01 INFO - 'HOME': '/Users/cltbld', 05:26:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:01 INFO - 'LOGNAME': 'cltbld', 05:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:01 INFO - 'MOZ_NO_REMOTE': '1', 05:26:01 INFO - 'NO_EM_RESTART': '1', 05:26:01 INFO - 'PAGER': '/bin/cat', 05:26:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:01 INFO - 'PWD': '/builds/slave/test', 05:26:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:01 INFO - 'SHELL': '/bin/bash', 05:26:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6zwGCMXfzd/Listeners', 05:26:01 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:26:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:01 INFO - 'USER': 'cltbld', 05:26:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:01 INFO - 'XPC_FLAGS': '0x0', 05:26:01 INFO - 'XPC_SERVICE_NAME': '0', 05:26:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:01 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-UBLHm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:01 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-QPZMJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:01 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)) 05:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:01 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-NX9whD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-bp7AO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:02 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)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-pMScAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-wu4Z8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-93e3VE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-00_Pbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-ZSAY4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-rDAMzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-oDNhhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-K5MIIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:03 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)) 05:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:03 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-ZqwIJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:03 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-stZMZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:03 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)) 05:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:03 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-STj45T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:03 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-2NbEQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:03 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)) 05:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:03 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-i_Zxg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:26:03 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)) 05:26:03 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)) 05:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:26:03 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)) 05:26:03 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)) 05:26:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:06 INFO - Downloading blessings-1.6.tar.gz 05:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:26:06 INFO - Installing collected packages: blessings 05:26:06 INFO - Running setup.py install for blessings 05:26:06 INFO - Successfully installed blessings 05:26:06 INFO - Cleaning up... 05:26:06 INFO - Return code: 0 05:26:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:06 INFO - Reading from file tmpfile_stdout 05:26:06 INFO - Current package versions: 05:26:06 INFO - blessings == 1.6 05:26:06 INFO - blobuploader == 1.2.4 05:26:06 INFO - docopt == 0.6.1 05:26:06 INFO - functools32 == 3.2.3-2 05:26:06 INFO - jsonschema == 2.5.1 05:26:06 INFO - manifestparser == 1.1 05:26:06 INFO - mozInstall == 1.12 05:26:06 INFO - mozcrash == 0.17 05:26:06 INFO - mozdebug == 0.1 05:26:06 INFO - mozdevice == 0.48 05:26:06 INFO - mozfile == 1.2 05:26:06 INFO - mozhttpd == 0.7 05:26:06 INFO - mozinfo == 0.9 05:26:06 INFO - mozleak == 0.1 05:26:06 INFO - mozlog == 3.3 05:26:06 INFO - moznetwork == 0.27 05:26:06 INFO - mozprocess == 0.23 05:26:06 INFO - mozprofile == 0.28 05:26:06 INFO - mozrunner == 6.12 05:26:06 INFO - mozscreenshot == 0.1 05:26:06 INFO - mozsystemmonitor == 0.3 05:26:06 INFO - moztest == 0.7 05:26:06 INFO - mozversion == 1.4 05:26:06 INFO - psutil == 3.1.1 05:26:06 INFO - requests == 1.2.3 05:26:06 INFO - wsgiref == 0.1.2 05:26:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:06 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 0x10f7d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f74b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d98d906c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e9d30>, '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 0x10f40fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e1b20>, '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.1kwicHsD6r/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.6zwGCMXfzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:26:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1kwicHsD6r/Render', 05:26:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:06 INFO - 'HOME': '/Users/cltbld', 05:26:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:06 INFO - 'LOGNAME': 'cltbld', 05:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:06 INFO - 'MOZ_NO_REMOTE': '1', 05:26:06 INFO - 'NO_EM_RESTART': '1', 05:26:06 INFO - 'PAGER': '/bin/cat', 05:26:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:06 INFO - 'PWD': '/builds/slave/test', 05:26:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:06 INFO - 'SHELL': '/bin/bash', 05:26:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6zwGCMXfzd/Listeners', 05:26:06 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:26:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:06 INFO - 'USER': 'cltbld', 05:26:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:06 INFO - 'XPC_FLAGS': '0x0', 05:26:06 INFO - 'XPC_SERVICE_NAME': '0', 05:26:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:26:06 INFO - Cleaning up... 05:26:06 INFO - Return code: 0 05:26:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:06 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 0x10f7d5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f74b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d98d906c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e9d30>, '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 0x10f40fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e1b20>, '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.1kwicHsD6r/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.6zwGCMXfzd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:26:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1kwicHsD6r/Render', 05:26:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:06 INFO - 'HOME': '/Users/cltbld', 05:26:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:06 INFO - 'LOGNAME': 'cltbld', 05:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:06 INFO - 'MOZ_NO_REMOTE': '1', 05:26:06 INFO - 'NO_EM_RESTART': '1', 05:26:06 INFO - 'PAGER': '/bin/cat', 05:26:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:06 INFO - 'PWD': '/builds/slave/test', 05:26:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:06 INFO - 'SHELL': '/bin/bash', 05:26:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6zwGCMXfzd/Listeners', 05:26:06 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:26:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:06 INFO - 'USER': 'cltbld', 05:26:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:06 INFO - 'XPC_FLAGS': '0x0', 05:26:06 INFO - 'XPC_SERVICE_NAME': '0', 05:26:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:26:07 INFO - Cleaning up... 05:26:07 INFO - Return code: 0 05:26:07 INFO - Running post-action listener: _resource_record_post_action 05:26:07 INFO - Running post-action listener: _start_resource_monitoring 05:26:07 INFO - Starting resource monitoring. 05:26:07 INFO - [mozharness: 2016-09-11 12:26:07.266969Z] Finished create-virtualenv step (success) 05:26:07 INFO - [mozharness: 2016-09-11 12:26:07.267999Z] Running install step. 05:26:07 INFO - Running pre-action listener: _resource_record_pre_action 05:26:07 INFO - Running main action method: install 05:26:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:07 INFO - Reading from file tmpfile_stdout 05:26:07 INFO - Detecting whether we're running mozinstall >=1.0... 05:26:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:26:07 INFO - Reading from file tmpfile_stdout 05:26:07 INFO - Output received: 05:26:07 INFO - Usage: mozinstall [options] installer 05:26:07 INFO - Options: 05:26:07 INFO - -h, --help show this help message and exit 05:26:07 INFO - -d DEST, --destination=DEST 05:26:07 INFO - Directory to install application into. [default: 05:26:07 INFO - "/builds/slave/test"] 05:26:07 INFO - --app=APP Application being installed. [default: firefox] 05:26:07 INFO - mkdir: /builds/slave/test/build/application 05:26:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:26:41 INFO - Reading from file tmpfile_stdout 05:26:41 INFO - Output received: 05:26:41 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:26:41 INFO - Running post-action listener: _resource_record_post_action 05:26:41 INFO - [mozharness: 2016-09-11 12:26:41.848277Z] Finished install step (success) 05:26:41 INFO - [mozharness: 2016-09-11 12:26:41.848405Z] Running run-tests step. 05:26:41 INFO - Running pre-action listener: _resource_record_pre_action 05:26:41 INFO - Running main action method: run_tests 05:26:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:26:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:26:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:26:41 INFO - 2016-09-11 05:26:41.863 screenresolution[6365:112498] starting screenresolution argv=screenresolution get 05:26:41 INFO - 2016-09-11 05:26:41.866 screenresolution[6365:112498] Display 0: 1600x1200x32@60 05:26:41 INFO - 2016-09-11 05:26:41.872 screenresolution[6366:112500] starting screenresolution argv=screenresolution list 05:26:41 INFO - Available Modes on Display 0 05:26:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:26:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:26:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:26:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:26:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:26:42 INFO - Intel Iris: 05:26:42 INFO - Chipset Model: Intel Iris 05:26:42 INFO - Type: GPU 05:26:42 INFO - Bus: Built-In 05:26:42 INFO - VRAM (Dynamic, Max): 1536 MB 05:26:42 INFO - Vendor: Intel (0x8086) 05:26:42 INFO - Device ID: 0x0a2e 05:26:42 INFO - Revision ID: 0x0009 05:26:42 INFO - Displays: 05:26:42 INFO - Display: 05:26:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:26:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:26:42 INFO - Display Serial Number: 1600x1200 60 05:26:42 INFO - Main Display: Yes 05:26:42 INFO - Mirror: Off 05:26:42 INFO - Online: Yes 05:26:42 INFO - Rotation: Supported 05:26:42 INFO - Return code: 0 05:26:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:26:42 INFO - Python 2.7.3 05:26:42 INFO - Return code: 0 05:26:42 INFO - grabbing minidump binary from tooltool 05:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:42 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 0x10f5e9d30>, '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 0x10f40fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5e1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:26:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:26:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:26:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:26:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:26:42 INFO - Return code: 0 05:26:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:26:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:26:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:26:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:26:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:26:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0078 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:26:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1kwicHsD6r/Render', 05:26:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:42 INFO - 'HOME': '/Users/cltbld', 05:26:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:42 INFO - 'LOGNAME': 'cltbld', 05:26:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:26:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:42 INFO - 'MOZ_NO_REMOTE': '1', 05:26:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:26:42 INFO - 'NO_EM_RESTART': '1', 05:26:42 INFO - 'PAGER': '/bin/cat', 05:26:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:42 INFO - 'PWD': '/builds/slave/test', 05:26:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:26:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:42 INFO - 'SHELL': '/bin/bash', 05:26:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6zwGCMXfzd/Listeners', 05:26:42 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:26:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:42 INFO - 'USER': 'cltbld', 05:26:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:42 INFO - 'XPC_FLAGS': '0x0', 05:26:42 INFO - 'XPC_SERVICE_NAME': '0', 05:26:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:26:42 INFO - mozversion application_buildid: 20160911030419 05:26:42 INFO - mozversion application_changeset: 7e873393cc11d326338779e5a3ed2da031e30936 05:26:42 INFO - mozversion application_display_name: Nightly 05:26:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:26:42 INFO - mozversion application_name: Firefox 05:26:42 INFO - mozversion application_remotingname: firefox 05:26:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:26:42 INFO - mozversion application_vendor: Mozilla 05:26:42 INFO - mozversion application_version: 51.0a1 05:26:42 INFO - mozversion platform_buildid: 20160911030419 05:26:42 INFO - mozversion platform_changeset: 7e873393cc11d326338779e5a3ed2da031e30936 05:26:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:26:42 INFO - mozversion platform_version: 51.0a1 05:26:42 INFO - using testdate: 1473596802 05:26:42 INFO - actual date: 1473596802 05:26:42 INFO - starting webserver on 'localhost:56809' 05:26:42 INFO - SUITE-START | Running 2 tests 05:26:42 INFO - TEST-START | dromaeo_css 05:26:42 INFO - operating with platform_type : mac_ 05:26:42 INFO - Initialising browser for dromaeo_css test... 05:26:42 INFO - TEST-INFO | started process 6376 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmplj5CUs/profile http://localhost:56809/getInfo.html) 05:26:44 INFO - PROCESS | 6376 | __metrics Screen width/height:1600/1200 05:26:44 INFO - PROCESS | 6376 | colorDepth:24 05:26:44 INFO - PROCESS | 6376 | Browser inner width/height: 1024/689 05:26:44 INFO - PROCESS | 6376 | __metrics 05:26:45 INFO - PROCESS | 6376 | 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" 05:26:45 INFO - PROCESS | 6376 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:26:45 INFO - TEST-INFO | 6376: exit 0 05:26:45 INFO - Browser initialized. 05:26:45 INFO - Running cycle 1/1 for dromaeo_css test... 05:26:45 INFO - TEST-INFO | started process 6379 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmplj5CUs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:57 INFO - PROCESS | 6379 | RSS: Main: 233033728 05:26:57 INFO - PROCESS | 6379 | 05:27:49 INFO - PROCESS | 6379 | 1473596869375 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] 05:30:01 INFO - PROCESS | 6379 | Cycle 1(1): loaded http://localhost:56809/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56809/tests/dromaeo/cssquery-ext.html) 05:30:02 INFO - PROCESS | 6379 | RSS: Main: 372924416 05:30:02 INFO - PROCESS | 6379 | 05:33:05 INFO - PROCESS | 6379 | Cycle 1(1): loaded http://localhost:56809/tests/dromaeo/cssquery-ext.html (next: http://localhost:56809/tests/dromaeo/cssquery-jquery.html) 05:33:06 INFO - PROCESS | 6379 | RSS: Main: 370331648 05:33:06 INFO - PROCESS | 6379 | 05:36:08 INFO - PROCESS | 6379 | Cycle 1(1): loaded http://localhost:56809/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56809/tests/dromaeo/cssquery-mootools.html) 05:36:09 INFO - PROCESS | 6379 | RSS: Main: 354263040 05:36:09 INFO - PROCESS | 6379 | 05:39:11 INFO - PROCESS | 6379 | Cycle 1(1): loaded http://localhost:56809/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56809/tests/dromaeo/cssquery-prototype.html) 05:39:12 INFO - PROCESS | 6379 | RSS: Main: 346984448 05:39:12 INFO - PROCESS | 6379 | 05:42:15 INFO - PROCESS | 6379 | Cycle 1(1): loaded http://localhost:56809/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56809/tests/dromaeo/cssquery-yui.html) 05:42:16 INFO - PROCESS | 6379 | RSS: Main: 326172672 05:42:16 INFO - PROCESS | 6379 | 05:45:19 INFO - PROCESS | 6379 | Cycle 1(1): loaded http://localhost:56809/tests/dromaeo/cssquery-yui.html (next: http://localhost:56809/tests/dromaeo/cssquery-dojo.html) 05:45:20 INFO - PROCESS | 6379 | RSS: Main: 457424896 05:45:20 INFO - PROCESS | 6379 | 05:45:20 INFO - PROCESS | 6379 | __start_tp_report 05:45:20 INFO - PROCESS | 6379 | _x_x_mozilla_page_load 05:45:20 INFO - PROCESS | 6379 | _x_x_mozilla_page_load_details 05:45:20 INFO - PROCESS | 6379 | |i|pagename|runs| 05:45:20 INFO - PROCESS | 6379 | |0;dojo.html;2960.348723280878;3213.5661685672444;3260.087175590834;3302.0259023588037;3352.7653064285496;5522.171674248864;5526.668399896009;5616.466435688613;5648.802291919784;5673.177389278552;5621.550275977912;5622;5657.547396208303;5719.485246327829;5780.421957804228;5085.466026067265;5102.311187989611;5110.514501122406;5156.896862062757;5209.557187639055;5232.215167724834;5276.182191760283;5320.228566857803;5350.678959262456;5359;5208.990751829983;5219.921701174486;5228.372595288552;5265.7893684252585;5275.736213189325;5102.744862756847;5147.922781158286;5151;5196.584273258168;5223.52988231061;5061.848144555669;5155.66488178271;5161.303224064741;5167.069927413064;5181.145111056671;5610.13042978339;5612.579056570774;5616;5617.887642247132;5625.099984002581;6037.0870930556175;6097.237845269341;6130.938690613081;6137.1012032552535;6200.3179650238435;6199.194104766351;6262.78080267193;6287.245530536319;6303.842403939892;6311.337309582474;5759.6832174229985;5768.221290125821;5769.07694768835;5777.971110144506;5783.739731712083;6207.131001659771;6220.284667263232;6274.372562743781;6312.495000399957;6319.304876463585;6089.191684759588;6093.695315234309;6098.298695649968;6109.14471973924;6133.110698948717;6234.438900498977;6241.96879015602;6263.467605253604;6271.247450305992;6288.874222515524;6091.969540152271;6092.451679348791;6138.419052470195;6145.801568694062;6178.969105154445;6087.634741915499;6124.663143527148;6127.89207890682;6181.134641150243;6208.099825525273;4855.587275081658;4863.781129849094;4867.853964381004;4895.853124406202;4919.065377578248;4153.584641535883;4349.739015659071;4371.912561748747;4376.8905777355185;4423.867283981485;5480.986017586759;5617.578681598897;5621.381648018714;5678.517326027251;5683.261176047087;6108.342071131425;6189.257289125244;6198.2252218472695;6205.875882482415;6210.534209934273;5618.719064046782;5673.234113394721;5693.829185124453;5695.629784064023;5704.771809127671;5324.520793128637;5391.946080539223;5400.729963501809;5402.37872644643;5404.621676482609;6297.842553936188;6312.368763123743;6312.842178945563;6321.1782468278825;6327.335629758809;6117.785877494444;6127.494965205145;6128.380904898417;6245.7189426476825;6263.6241825490615;6198.287196972406;6259.2488901332135;6270.184875966095;6284.371562843679;6304.6847657617855;6092.939070609237;6131.601445906002;6137.263528376623;6156.476699480594;6160.414760597736;6243.594166379171;6252.968735156295;6256.374362563707;6284.3087260402235;6285.43431091204;5776.8555786104;5882.764689412375;5945;5967.970160149345;6011.489023432882;5929.258842644669;5933.940660593339;5974.4324289192455;6071.7571297147615;6103.298120716175;5842.853928651818;5860.94139058621;5876.823695289148;5911.3201981772645;5915.792947246826;5896.204012458264;6030.39696030411;6092.847678808065;6096.29892562361;6106.267247930276;5761.798337058183;5813.680247586254;5829.067349224104;5851.297844258716;5871.001929671881 05:45:20 INFO - PROCESS | 6379 | |1;ext.html;494.08347515358986;501.8971110922261;510.6170372220834;512.8820371314596;527.548945651468;28656.71343286569;30130.397392052146;39920.60277890271;40376.79811600938;40820;42125.36811947823;42482.787586062106;42508;42569.36145957805;42599.9350016249;9777.217822574195;9916.95041524795;9950.552225149886;9979.501024948724;9980.151687106605;9795.559199836025;9899.90100098997;9915.206783457306;9918.752031199205;9929.801403971916;9877.753056173617;9922.801543969117;9949.054839790208;9953.452560109192;9979.50102494876;9848;9886;9904.554295056667;9919.851202231901;9927.95036024819;9784.608615655365;9851.916289208182;9861;9863.506824658738;9870.2103831694;41258.38112428316;41578.37632435516;41625.1674966499;41647.791761041306;41851.372229416585;2841.303880549258;3312.205070783019;3448.8620455181763;3796.6393192646656;4014.598540145991;30224.69775302263;30236.244093897607;30635.540466893013;30923.845380772953;31094.37811243785;3236.6116066072223;3296.04414719731;3320.2031512436843;3392.6098498672723;3393.8812141574926;524829;525854;531220;531321;531472.3426382882;60966.390336096956;61469;61565.07652385218;61587.6920615403;61718.69140654358;65354;65515.67242163854;65517;65625.67187164034;65652;15483.690326193639;16213.189340532927;16442.424515141913;16512.4220652279;16522.75215871763;12647.304398258;12702.87297127017;12709.110362274552;12711.809322860165;12743.808842867364;16335.410565256687;16393.262303196385;17776.555586110193;18664.44006679802;18931.526711832037;6636.402723754885;7499.8500029999095;7601.555704416143;7716.99679041721;7754.883676744853;843.9957800210959;856.7876454816364;882.911708829112;942.9952850235705;1040.3913710479455;28327.57508637372;29437.55843662347;29488;30061.248468788017;30261;1031.9164876879247;1041.0838462153256;1067.199600299775;1083.978320433587;1150.4305368842477;14830.777538336934;15285.694286114216;15482.690346193012;15660;15672.92163539175;660023;670618;678227;682917;970998;55910.72044639832;56653;56789.43210567924;56818;56963.99999999917;1154.3362566524115;1345.724126554054;1378.4072848675166;1379.2069560002838;1380.4823191303262;29784.404311913207;30091;30185.09444716662;30298.394032118795;30309.242268943453;49078;50290.748546258495;50296.74851625718;50311.74844125756;50413.49586504088;535294;576604;580446;580683;582704;26351.868240658674;26803;26803.329916751456;26803.731962680904;26853.194404167905;44381.67419909631;44496.555034449244;44680.55319446894;45159.32261016022;46068.769656151504;37546.436803447425;37573.24853502969;38149.427758583086;38697.226055479296;38812.41781373338;37673;37735.05662358463;38009.00010975664;38611.806940965114;39060.41409378805;27736.340229405527;31483;37129.071773205884;38095.42856857094;38116.61883381242;25795.743702289663;27773.583396249476;31679.52480712837;33300.00099997004;33333.66666333305;24473.021079156635;24672;24740.38149046288;25266.36834079163;25502.48995020052 05:45:20 INFO - PROCESS | 6379 | |2;jquery.html;345.94637831136174;347.7166109620659;357.4513122357182;369.6950016236606;403.5540727496117;13206.339683015847;14921.925390373046;16125.354985800568;17388.65222695545;20908.790912090873;19600.90199549004;19752.209911603553;21004.894975525138;21143.15427382903;21221.57556848866;4542.795574199161;5634.802781902634;5634.802781902634;5640;5650.971745141269;4585.9541404586025;5523.558115350783;5533.09108357618;5562.527185189244;5585.134304182858;5567.47109024642;5567.693776842272;5575.0522411190195;5576.386597474275;5581.134924086773;5321;5449.591280653947;5525.917111243334;5526.889462210734;5531.197976293415;5345.705986170759;5349.545288650469;5352.732363381815;5355.491228333302;5358.785648574052;20381.082851271727;23930.64104038441;24845.378865528324;25165;25262.242132736046;2137.4335801012744;2152.5587254612765;2174.597699425611;2343.414146463384;2640.2475294540964;10283.691489255334;10328.27702060856;10536.157107431387;11642.708932276677;15534.689306213813;1838.8620853436046;1839.2826797548967;1869.5419622192514;1906.3213257914117;1913.5598812273256;110172.4491377546;120671;128482.71517284801;128646.99999999907;129356;11147.219694621299;11212.383318917538;11528.711782205344;11548.191626586058;11798.292102473879;14612.342444590018;14647.414103435956;14650.267486625626;14668.706625867422;14678.559643210721;8158.388120890957;8413.663453461915;8442.915570844336;8544.2310192083;8553.016403113597;8277.461964972377;8305.418620696493;8309.25216730485;8496.447730897471;8501.234888860032;4006.2187873364414;4354.716943398669;4428.645708343325;4523.389342438729;4592.448906131285;1586.8336772472223;1893.157544892537;1909.6085302512952;1913.2251438167564;1914.1864707499258;798.9001374828147;831.7213733399258;878.6353663229816;910.0308171797014;953.1516949914582;20670.379888603366;21446.57106857854;21527.67708484374;21612.135514579557;21672.89163554172;779.8947142135739;792.2354927494995;908.6092980018656;919.1406035356963;930.4417349590192;10401.427921464392;11145.498452569655;11180.385078820744;11305.773884522428;11349.546018159346;487884;549004;562145;562673;567682;85490;95039;98254.01745982592;125284;131231.68768312194;950.4439902656885;981.5779214937503;991.1476130527741;991.6727479931606;991.7074463033566;18534;19132.80867191366;19329.51676208106;19423.417297481097;19470.415887523395;51793;51966.74016629893;52476.9504609898;52501.7374913123;52658.473415265355;73873.63063184649;75820.62089689517;77178;77333;77751;7865.134835168242;8072.354211662935;8109.067457242257;8152.510849349058;8292.419530632798;11315.943420282845;12379;12636.431360588611;12691.77893868551;12795.552155674506;9405.341626086109;10818.242723009314;11005.834912476479;11089.39008354516;11185.832212516656;9141.862872057058;10611.41637209961;10790.406527641055;11103.444827758418;11196.328220306808;11061.059809916247;11061.225714199929;11303.265287756269;11333.773324533628;11454;6968.895466567904;7901.68393264263;7976.441649084509;8164.306033987177;8266.090730019572;7596.8480630388185;7826.686932522635;7895.328897043815;8412.761086981434;9388.624455021996 05:45:20 INFO - PROCESS | 6379 | |3;mootools.html;1546.126438562212;1585.6828634273147;1737.5656085978505;1844.9907750461246;1906.4947788835952;8086.312663423601;8388.62251198696;8532.658693652254;9070.410423322488;9080.455172689635;8214.876776848352;8737.86893196601;8865.734027979155;8869.157430044152;9011.324150688692;2393.270052633946;2416.4804567018086;2416.867072311022;2422.067504010951;2429.635554666805;2112.5563631637374;2379.619260918245;2410.3010127063217;2419.8790060496904;2423.8303318767607;2170.739511258651;2197.8021978022057;2331.4404542909665;2408.4821763320883;2413.1312727418117;2384.523095380922;2387.6776635154206;2392.9760702392928;2393.9162129325564;2398.85606863587;2217.634090375086;2363.4564050268536;2379.310000099969;2382.60686986647;2388.713354397466;8360.665573377057;9164.991850896396;9167.266618670557;9178.81642367149;9187.08129187076;4976.925346119811;5122.949795291956;5521.3926468088475;5523.28197334344;5526.115821468586;3527.3650742866275;3590;3699.667029967316;3711.1464363196346;3723.2181241939224;945.9195968342699;1077.7413420778958;1081.734974931139;1087.3530249501614;1101.1191047162238;10216.591336346537;11780.116491263103;11928.165028448098;11963.102767292401;11978.281303121841;4001.519817621846;4655.953440465552;4866;4878.585320247818;4888.608911287089;10192.082712555906;10240.795184096276;10247.590096396061;10255.384676919408;10259.076683098558;5515.917261241085;5518.19986102013;5518.668879867221;5518.944810551923;5523.585731070186;4960.875978100504;4968.503149685002;5003.897583498182;5040.420351659533;5057.190849464068;3544.4860495228563;3721.5534135903863;3906.7655940643085;3941.231459865356;3982.303096958021;1245.7383949370553;1252.6492582077033;1260.6533203369147;1267.113020885384;1267.3409826889965;605.7395320012349;728.3481284250566;769.6690423118113;786.5359437931647;832.9583520823935;5356.839294821161;5404.810831620953;5428.782848686008;5649.887002259932;5662.490375866109;809.7975506123469;882.7440042387764;915.6474757218518;926.5413620257881;953.1564565359706;3566.0906468850276;3583.498310236569;3587.264610754789;3694.8706795262037;3745.962540374616;10641.201909856636;11178.776424471465;11182.993530582287;11206.047485963622;11351.978321951065;11200.943995280135;11201.439928003567;11203.383813890314;11206.775864482664;11242.269252498561;8240.711575094843;8292.751217463485;8348.70779522726;8445.113263107409;8449.366297527587;5340.813071542478;5472.151816468454;5499.285092937893;5511.641743286674;5649.152627105967;10239.43683097407;10269.127124194229;10305.690829274834;10410.635627752992;10435.269531132748;10000.099991000845;10391.116755075904;10408.323458975143;10566.049055585034;10581.841272380767;7444.255574442513;7616.9238307616215;7619.771406857803;7619.809504762426;7624.58064806441;8264.132266111972;8300.584970751559;8395.160483951557;8397.160283971554;8498.74503764888;7595.430342724429;7639.732609358646;7667;7729.961350193438;7875.306809036085;6414.550981431255;7377.8155546111775;7415.073115860518;7422.109346878409;7439.962800185965;6988.6505674715045;7054.224035356004;7077.469189810682;7158;7168.032315637531;4194;4758.119747846521;4805.207140821725;4808.567228949411;4872;4178.227027999708;4747.477777444409;4831.647138801141;4854.708717476963;4968.975155124202 05:45:20 INFO - PROCESS | 6379 | |4;prototype.html;265.70639443415024;302.7729203097677;310.5310980419566;313.8697440562167;317.83313760275837;5013.799448022075;5039.949600503989;5310.362756469224;5370.925814837029;5388.973055134724;5001.349824522816;5059.873503162423;5146.536811686948;5177.818776342829;5205.661631993918;3372.6458721834224;3578.910527236814;4051.8784436466954;4053.452783874176;4066.430699702044;4003.9599604004025;4017.919641607166;4032.5967403259588;4064.878053658395;4073.5926407359325;3215.662355452679;3261.4781634938413;3867.6325749053935;4050.6961977851633;4069.9389509157386;3511.9990802621387;3937.3109705801658;4018.276710192164;4027.335489644205;4035.899102522431;3014.6834582368974;3090.860911258999;3456.395130852116;3534.964650353489;3535.381308271042;5101.387833459971;5103.693778373309;5104.846854594368;5147.279380886679;5179.922301165486;3972.404139379087;4480.529544397857;4536.364908912755;4591.51789062147;4606.60843828275;4687.906241875144;4756.500567440438;5256.869772998785;5541.33503979521;5547.611667183299;3220.5974253218346;3807.9428808567895;3843.9231215375535;3850.84596616135;3859.903502412434;4746.670932139006;4830.106430310404;5185.96280743849;5777;5855.648661080349;3788.8295026723863;3810.676092532166;3815.809209539512;3826.196498735241;3828.349180639298;3733.3653278942643;3879.689624830007;3884.6792090688737;3933.193695292458;3933.9803300983313;4339.674524410681;4485.372047913294;4510.571495707903;4514.390557274726;4552.840650577214;4609.354690343354;5539.667619942817;5566.610337276433;5576.275084239104;5584.966781145501;1231.9630411087683;1302.7589895869294;1332.7201287729492;1338.852726200117;1339.3124662924786;776.9067711874611;801.3589128697135;864.1056506515852;869.891263592051;894.3873446689039;5173.249878767558;5237.266782650432;5242.97378513105;5283.9471605284225;5293.338332708411;5030.320906677552;5715.599908006399;5730.541556675456;5734;5783.71081445926;4804.303376010529;5187;5287.629865909426;5349.565947493881;5381.789097453042;3010.1421094987822;3020.5771192033135;3045.4365942300747;3054.9613131535384;3061.8315992620173;5285.577153827685;5505.614606977553;5807.738651760681;6026;6087.604305720114;5102.770375333119;5200.985807767449;5775.249217601685;5855.736491857877;5896.941030589725;5111.974440127776;5864.413558644102;5964.850878727893;5974.492168165668;6005.519558435315;5492.642978206563;5742.913856292243;5768.682722450138;5781.364049954585;5814.30228372598;5199.7140157291715;5643.52030077448;5720.48515633595;5733;5777.62445441045;4818.807247710052;4947.48051454592;5148.2020286855595;5492.35229431161;5557.805476808292;3812.752171108869;3822.94265586022;3832.8466861325232;3869.496965394593;3877.321468743015;5073;5546.417626149197;5561.582881283839;5717.683743428718;5796.681182535001;4387.8244870204835;4969.925451118308;5501.312335958005;5659.830205093854;5714.657120572779;4923.4584195737725;5184.988927159167;5600.943990560042;5628.352739435018;5682.715864206856;4429.402030725811;4625.028743963805;4965.801367945386;5058.747062646779;5352.785888564414;5502.422245664147;5511.614187006871;5603.635763675511;5759.683217422914;5821.76712931478;4835.323054772405;5033.6660784892765;5158.277841102174;5248.795505887612;5552.250446189712 05:45:20 INFO - PROCESS | 6379 | |5;yui.html;699.3915293694484;721.7045403500713;765.731993802169;797.4099166616699;821.9342452603793;15574.610634734137;16706.582335441606;16778.664426711457;16785.664286714273;16803.32786688531;14933.850661493381;15075.095494270352;15084.245787710597;15115.546533603982;15248.771268430955;682.1711620381236;685.7462738786656;707.5118168463744;711.900333953247;848.1391387741447;689.2487188964028;690.5304393012749;819.5164852736884;857.4726543175933;863.654538184728;893.3924931046886;903.5798353765498;904.5160838951163;905.0316161706976;908.9409188402766;893.4326702543866;900.9684661036865;902.9819403611957;903.6656437118309;903.9141281578272;659.4526542969325;659.4987809264993;660.1615947746335;661.1504217081027;664.7008846019311;11767.646970590811;12228.205166664138;12238.204516706386;12246.693832654166;12252.326122063283;13664.248466334348;14594.781078283835;14746.188959607218;14818.925905370512;14894.627634309121;11640.708982275426;11723.179377443583;11769.705757356049;11784.469698863486;12257.387130643432;3855.4795102661064;3922.5489068756888;3966.920661586781;3967.841286348543;3986.54154772202;116471;121846.17230741546;122474.77525224723;122479.16281255789;122577.38711306386;10375.896241037644;10976.615818446477;11425.028872545927;11503.654890353302;11522.827157592475;22924;23122.306330809766;23156.884215578815;23163;23825.285241442783;8150.0627427845375;8204.425690201628;8212.301954333829;8213.998912647721;8229.25936665703;4390.473143222834;4419.845305414295;4431.62331201845;4726.550977657117;4779.402574678165;3639.2721455708966;3762;3763.6612704856148;3766.152615661454;3769.7361184716806;662.7713438863584;676.1379241467168;684.2678334182377;697.7976386847859;698.8043347862607;589.8672798620362;626.8968605403272;627.2347735762363;637.2830565613684;680.0988689985788;8850.822983540293;9099.81800363989;9533.570989305359;10077.720207253828;10429.791404171874;561.6545824318015;590.8404730722681;616.2543322579639;618.2334055103377;652.4780175859294;3748.437734339871;4399.38408622793;4664.385679657628;4764.38063051808;4872.342233798392;92794;105819;153408.2329588345;164006.3599363991;164788;138148;140586;145120;145933;146545;113269;115944;121877.99999999822;124366.13450798245;127324.81115049536;7896.84206315882;9130.360874738704;9147.131022552847;9167.954160229156;9276.860847087433;50042.249366260265;64043;67277.32722672711;68220.6588967052;68405.65797170982;96593;102987.48506257421;103815.92368152746;105021;106788.7192972787;12135.817962730744;12204.694882628006;12348.135630505778;12677.30274834893;12829.358532073546;13210.141340812816;13337;13375.063745538107;13459.79810302866;13577.796333054814;12310.507579696712;12499.125061245626;12504.124711270488;12551.93724031374;13079.673008174872;12220.694482638006;12406.25562466255;12536.561220357244;12984.545540906023;13200.867991320349;10958.890411095786;11301;13659.317034148451;13765.38055787512;13973.67264591919;8162.755117346489;11225.4387280634;11285.661430157108;11408.54365825391;11916.10629202796;10052.899471005196;10090.394576325443;11392;11653.359065251492;11746.941265293619 05:45:20 INFO - PROCESS | 6379 | __end_tp_report 05:45:20 INFO - PROCESS | 6379 | __start_cc_report 05:45:20 INFO - PROCESS | 6379 | _x_x_mozilla_cycle_collect,1207 05:45:20 INFO - PROCESS | 6379 | __end_cc_report 05:45:20 INFO - PROCESS | 6379 | __startTimestamp1473597920046__endTimestamp 05:45:20 INFO - PROCESS | 6379 | 05:45:20 INFO - PROCESS | 6379 | ------- Summary: start ------- 05:45:20 INFO - PROCESS | 6379 | Number of tests: 6 05:45:20 INFO - PROCESS | 6379 | 05:45:20 INFO - PROCESS | 6379 | [#0] dojo.html Cycles:165 Average:5699.26 Median:5871.00 stddev:649.89 (11.1%) stddev-sans-first:615.34 05:45:20 INFO - PROCESS | 6379 | Values: 2960.3 3213.6 3260.1 3302.0 3352.8 5522.2 5526.7 5616.5 5648.8 5673.2 5621.6 5622.0 5657.5 5719.5 5780.4 5085.5 5102.3 5110.5 5156.9 5209.6 5232.2 5276.2 5320.2 5350.7 5359.0 5209.0 5219.9 5228.4 5265.8 5275.7 5102.7 5147.9 5151.0 5196.6 5223.5 5061.8 5155.7 5161.3 5167.1 5181.1 5610.1 5612.6 5616.0 5617.9 5625.1 6037.1 6097.2 6130.9 6137.1 6200.3 6199.2 6262.8 6287.2 6303.8 6311.3 5759.7 5768.2 5769.1 5778.0 5783.7 6207.1 6220.3 6274.4 6312.5 6319.3 6089.2 6093.7 6098.3 6109.1 6133.1 6234.4 6242.0 6263.5 6271.2 6288.9 6092.0 6092.5 6138.4 6145.8 6179.0 6087.6 6124.7 6127.9 6181.1 6208.1 4855.6 4863.8 4867.9 4895.9 4919.1 4153.6 4349.7 4371.9 4376.9 4423.9 5481.0 5617.6 5621.4 5678.5 5683.3 6108.3 6189.3 6198.2 6205.9 6210.5 5618.7 5673.2 5693.8 5695.6 5704.8 5324.5 5391.9 5400.7 5402.4 5404.6 6297.8 6312.4 6312.8 6321.2 6327.3 6117.8 6127.5 6128.4 6245.7 6263.6 6198.3 6259.2 6270.2 6284.4 6304.7 6092.9 6131.6 6137.3 6156.5 6160.4 6243.6 6253.0 6256.4 6284.3 6285.4 5776.9 5882.8 5945.0 5968.0 6011.5 5929.3 5933.9 5974.4 6071.8 6103.3 5842.9 5860.9 5876.8 5911.3 5915.8 5896.2 6030.4 6092.8 6096.3 6106.3 5761.8 5813.7 5829.1 5851.3 5871.0 05:45:20 INFO - PROCESS | 6379 | 05:45:20 INFO - PROCESS | 6379 | [#1] ext.html Cycles:180 Average:73445.33 Median:41039.19 stddev:166659.77 (406.1%) stddev-sans-first:167037.29 05:45:20 INFO - PROCESS | 6379 | Values: 494.1 501.9 510.6 512.9 527.5 28656.7 30130.4 39920.6 40376.8 40820.0 42125.4 42482.8 42508.0 42569.4 42599.9 9777.2 9917.0 9950.6 9979.5 9980.2 9795.6 9899.9 9915.2 9918.8 9929.8 9877.8 9922.8 9949.1 9953.5 9979.5 9848.0 9886.0 9904.6 9919.9 9928.0 9784.6 9851.9 9861.0 9863.5 9870.2 41258.4 41578.4 41625.2 41647.8 41851.4 2841.3 3312.2 3448.9 3796.6 4014.6 30224.7 30236.2 30635.5 30923.8 31094.4 3236.6 3296.0 3320.2 3392.6 3393.9 524829.0 525854.0 531220.0 531321.0 531472.3 60966.4 61469.0 61565.1 61587.7 61718.7 65354.0 65515.7 65517.0 65625.7 65652.0 15483.7 16213.2 16442.4 16512.4 16522.8 12647.3 12702.9 12709.1 12711.8 12743.8 16335.4 16393.3 17776.6 18664.4 18931.5 6636.4 7499.9 7601.6 7717.0 7754.9 844.0 856.8 882.9 943.0 1040.4 28327.6 29437.6 29488.0 30061.2 30261.0 1031.9 1041.1 1067.2 1084.0 1150.4 14830.8 15285.7 15482.7 15660.0 15672.9 660023.0 670618.0 678227.0 682917.0 970998.0 55910.7 56653.0 56789.4 56818.0 56964.0 1154.3 1345.7 1378.4 1379.2 1380.5 29784.4 30091.0 30185.1 30298.4 30309.2 49078.0 50290.7 50296.7 50311.7 50413.5 535294.0 576604.0 580446.0 580683.0 582704.0 26351.9 26803.0 26803.3 26803.7 26853.2 44381.7 44496.6 44680.6 45159.3 46068.8 37546.4 37573.2 38149.4 38697.2 38812.4 37673.0 37735.1 38009.0 38611.8 39060.4 27736.3 31483.0 37129.1 38095.4 38116.6 25795.7 27773.6 31679.5 33300.0 33333.7 24473.0 24672.0 24740.4 25266.4 25502.5 05:45:20 INFO - PROCESS | 6379 | 05:45:20 INFO - PROCESS | 6379 | [#2] jquery.html Cycles:180 Average:32832.05 Median:2379.14 stddev:91456.84 (3844.1%) stddev-sans-first:91680.87 05:45:20 INFO - PROCESS | 6379 | Values: 345.9 347.7 357.5 369.7 403.6 13206.3 14921.9 16125.4 17388.7 20908.8 19600.9 19752.2 21004.9 21143.2 21221.6 4542.8 5634.8 5634.8 5640.0 5651.0 4586.0 5523.6 5533.1 5562.5 5585.1 5567.5 5567.7 5575.1 5576.4 5581.1 5321.0 5449.6 5525.9 5526.9 5531.2 5345.7 5349.5 5352.7 5355.5 5358.8 20381.1 23930.6 24845.4 25165.0 25262.2 2137.4 2152.6 2174.6 2343.4 2640.2 10283.7 10328.3 10536.2 11642.7 15534.7 1838.9 1839.3 1869.5 1906.3 1913.6 110172.4 120671.0 128482.7 128647.0 129356.0 11147.2 11212.4 11528.7 11548.2 11798.3 14612.3 14647.4 14650.3 14668.7 14678.6 8158.4 8413.7 8442.9 8544.2 8553.0 8277.5 8305.4 8309.3 8496.4 8501.2 4006.2 4354.7 4428.6 4523.4 4592.4 1586.8 1893.2 1909.6 1913.2 1914.2 798.9 831.7 878.6 910.0 953.2 20670.4 21446.6 21527.7 21612.1 21672.9 779.9 792.2 908.6 919.1 930.4 10401.4 11145.5 11180.4 11305.8 11349.5 487884.0 549004.0 562145.0 562673.0 567682.0 85490.0 95039.0 98254.0 125284.0 131231.7 950.4 981.6 991.1 991.7 991.7 18534.0 19132.8 19329.5 19423.4 19470.4 51793.0 51966.7 52477.0 52501.7 52658.5 73873.6 75820.6 77178.0 77333.0 77751.0 7865.1 8072.4 8109.1 8152.5 8292.4 11315.9 12379.0 12636.4 12691.8 12795.6 9405.3 10818.2 11005.8 11089.4 11185.8 9141.9 10611.4 10790.4 11103.4 11196.3 11061.1 11061.2 11303.3 11333.8 11454.0 6968.9 7901.7 7976.4 8164.3 8266.1 7596.8 7826.7 7895.3 8412.8 9388.6 05:45:20 INFO - PROCESS | 6379 | 05:45:20 INFO - PROCESS | 6379 | [#3] mootools.html Cycles:180 Average:5751.92 Median:4806.89 stddev:3303.37 (68.7%) stddev-sans-first:3297.52 05:45:20 INFO - PROCESS | 6379 | Values: 1546.1 1585.7 1737.6 1845.0 1906.5 8086.3 8388.6 8532.7 9070.4 9080.5 8214.9 8737.9 8865.7 8869.2 9011.3 2393.3 2416.5 2416.9 2422.1 2429.6 2112.6 2379.6 2410.3 2419.9 2423.8 2170.7 2197.8 2331.4 2408.5 2413.1 2384.5 2387.7 2393.0 2393.9 2398.9 2217.6 2363.5 2379.3 2382.6 2388.7 8360.7 9165.0 9167.3 9178.8 9187.1 4976.9 5122.9 5521.4 5523.3 5526.1 3527.4 3590.0 3699.7 3711.1 3723.2 945.9 1077.7 1081.7 1087.4 1101.1 10216.6 11780.1 11928.2 11963.1 11978.3 4001.5 4656.0 4866.0 4878.6 4888.6 10192.1 10240.8 10247.6 10255.4 10259.1 5515.9 5518.2 5518.7 5518.9 5523.6 4960.9 4968.5 5003.9 5040.4 5057.2 3544.5 3721.6 3906.8 3941.2 3982.3 1245.7 1252.6 1260.7 1267.1 1267.3 605.7 728.3 769.7 786.5 833.0 5356.8 5404.8 5428.8 5649.9 5662.5 809.8 882.7 915.6 926.5 953.2 3566.1 3583.5 3587.3 3694.9 3746.0 10641.2 11178.8 11183.0 11206.0 11352.0 11200.9 11201.4 11203.4 11206.8 11242.3 8240.7 8292.8 8348.7 8445.1 8449.4 5340.8 5472.2 5499.3 5511.6 5649.2 10239.4 10269.1 10305.7 10410.6 10435.3 10000.1 10391.1 10408.3 10566.0 10581.8 7444.3 7616.9 7619.8 7619.8 7624.6 8264.1 8300.6 8395.2 8397.2 8498.7 7595.4 7639.7 7667.0 7730.0 7875.3 6414.6 7377.8 7415.1 7422.1 7440.0 6988.7 7054.2 7077.5 7158.0 7168.0 4194.0 4758.1 4805.2 4808.6 4872.0 4178.2 4747.5 4831.6 4854.7 4969.0 05:45:20 INFO - PROCESS | 6379 | 05:45:20 INFO - PROCESS | 6379 | [#4] prototype.html Cycles:180 Average:4479.93 Median:5059.31 stddev:1375.12 (27.2%) stddev-sans-first:1342.11 05:45:20 INFO - PROCESS | 6379 | Values: 265.7 302.8 310.5 313.9 317.8 5013.8 5039.9 5310.4 5370.9 5389.0 5001.3 5059.9 5146.5 5177.8 5205.7 3372.6 3578.9 4051.9 4053.5 4066.4 4004.0 4017.9 4032.6 4064.9 4073.6 3215.7 3261.5 3867.6 4050.7 4069.9 3512.0 3937.3 4018.3 4027.3 4035.9 3014.7 3090.9 3456.4 3535.0 3535.4 5101.4 5103.7 5104.8 5147.3 5179.9 3972.4 4480.5 4536.4 4591.5 4606.6 4687.9 4756.5 5256.9 5541.3 5547.6 3220.6 3807.9 3843.9 3850.8 3859.9 4746.7 4830.1 5186.0 5777.0 5855.6 3788.8 3810.7 3815.8 3826.2 3828.3 3733.4 3879.7 3884.7 3933.2 3934.0 4339.7 4485.4 4510.6 4514.4 4552.8 4609.4 5539.7 5566.6 5576.3 5585.0 1232.0 1302.8 1332.7 1338.9 1339.3 776.9 801.4 864.1 869.9 894.4 5173.2 5237.3 5243.0 5283.9 5293.3 5030.3 5715.6 5730.5 5734.0 5783.7 4804.3 5187.0 5287.6 5349.6 5381.8 3010.1 3020.6 3045.4 3055.0 3061.8 5285.6 5505.6 5807.7 6026.0 6087.6 5102.8 5201.0 5775.2 5855.7 5896.9 5112.0 5864.4 5964.9 5974.5 6005.5 5492.6 5742.9 5768.7 5781.4 5814.3 5199.7 5643.5 5720.5 5733.0 5777.6 4818.8 4947.5 5148.2 5492.4 5557.8 3812.8 3822.9 3832.8 3869.5 3877.3 5073.0 5546.4 5561.6 5717.7 5796.7 4387.8 4969.9 5501.3 5659.8 5714.7 4923.5 5185.0 5600.9 5628.4 5682.7 4429.4 4625.0 4965.8 5058.7 5352.8 5502.4 5511.6 5603.6 5759.7 5821.8 4835.3 5033.7 5158.3 5248.8 5552.3 05:45:20 INFO - PROCESS | 6379 | 05:45:20 INFO - PROCESS | 6379 | [#5] yui.html Cycles:180 Average:25779.28 Median:23139.60 stddev:41982.92 (181.4%) stddev-sans-first:42058.47 05:45:20 INFO - PROCESS | 6379 | Values: 699.4 721.7 765.7 797.4 821.9 15574.6 16706.6 16778.7 16785.7 16803.3 14933.9 15075.1 15084.2 15115.5 15248.8 682.2 685.7 707.5 711.9 848.1 689.2 690.5 819.5 857.5 863.7 893.4 903.6 904.5 905.0 908.9 893.4 901.0 903.0 903.7 903.9 659.5 659.5 660.2 661.2 664.7 11767.6 12228.2 12238.2 12246.7 12252.3 13664.2 14594.8 14746.2 14818.9 14894.6 11640.7 11723.2 11769.7 11784.5 12257.4 3855.5 3922.5 3966.9 3967.8 3986.5 116471.0 121846.2 122474.8 122479.2 122577.4 10375.9 10976.6 11425.0 11503.7 11522.8 22924.0 23122.3 23156.9 23163.0 23825.3 8150.1 8204.4 8212.3 8214.0 8229.3 4390.5 4419.8 4431.6 4726.6 4779.4 3639.3 3762.0 3763.7 3766.2 3769.7 662.8 676.1 684.3 697.8 698.8 589.9 626.9 627.2 637.3 680.1 8850.8 9099.8 9533.6 10077.7 10429.8 561.7 590.8 616.3 618.2 652.5 3748.4 4399.4 4664.4 4764.4 4872.3 92794.0 105819.0 153408.2 164006.4 164788.0 138148.0 140586.0 145120.0 145933.0 146545.0 113269.0 115944.0 121878.0 124366.1 127324.8 7896.8 9130.4 9147.1 9168.0 9276.9 50042.2 64043.0 67277.3 68220.7 68405.7 96593.0 102987.5 103815.9 105021.0 106788.7 12135.8 12204.7 12348.1 12677.3 12829.4 13210.1 13337.0 13375.1 13459.8 13577.8 12310.5 12499.1 12504.1 12551.9 13079.7 12220.7 12406.3 12536.6 12984.5 13200.9 10958.9 11301.0 13659.3 13765.4 13973.7 8162.8 11225.4 11285.7 11408.5 11916.1 10052.9 10090.4 11392.0 11653.4 11746.9 05:45:20 INFO - PROCESS | 6379 | -------- Summary: end -------- 05:45:20 INFO - PROCESS | 6379 | 05:45:20 INFO - TEST-INFO | 6379: exit 0 05:45:20 INFO - TEST-OK | dromaeo_css | took 1118240ms 05:45:20 INFO - TEST-START | kraken 05:45:20 INFO - operating with platform_type : mac_ 05:45:20 INFO - Initialising browser for kraken test... 05:45:20 INFO - TEST-INFO | started process 6383 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpkPCg1B/profile http://localhost:56809/getInfo.html) 05:45:23 INFO - PROCESS | 6383 | __metrics Screen width/height:1600/1200 05:45:23 INFO - PROCESS | 6383 | colorDepth:24 05:45:23 INFO - PROCESS | 6383 | Browser inner width/height: 1024/689 05:45:23 INFO - PROCESS | 6383 | __metrics 05:45:23 INFO - PROCESS | 6383 | 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" 05:45:23 INFO - PROCESS | 6383 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:45:23 INFO - TEST-INFO | 6383: exit 0 05:45:23 INFO - Browser initialized. 05:45:23 INFO - Running cycle 1/1 for kraken test... 05:45:23 INFO - TEST-INFO | started process 6385 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpkPCg1B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:35 INFO - PROCESS | 6385 | RSS: Main: 232787968 05:45:35 INFO - PROCESS | 6385 | 05:45:38 INFO - PROCESS | 6385 | Cycle 1(1): loaded http://localhost:56809/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56809/tests/kraken/driver.html?testName=audio-beat-detection) 05:45:39 INFO - PROCESS | 6385 | RSS: Main: 293363712 05:45:39 INFO - PROCESS | 6385 | 05:45:42 INFO - PROCESS | 6385 | Cycle 1(1): loaded http://localhost:56809/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56809/tests/kraken/driver.html?testName=audio-dft) 05:45:42 INFO - PROCESS | 6385 | RSS: Main: 288714752 05:45:42 INFO - PROCESS | 6385 | 05:45:46 INFO - PROCESS | 6385 | Cycle 1(1): loaded http://localhost:56809/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56809/tests/kraken/driver.html?testName=audio-fft) 05:45:46 INFO - PROCESS | 6385 | RSS: Main: 377438208 05:45:46 INFO - PROCESS | 6385 | 05:45:48 INFO - PROCESS | 6385 | Cycle 1(1): loaded http://localhost:56809/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56809/tests/kraken/driver.html?testName=audio-oscillator) 05:45:49 INFO - PROCESS | 6385 | RSS: Main: 280391680 05:45:49 INFO - PROCESS | 6385 | 05:45:51 INFO - PROCESS | 6385 | Cycle 1(1): loaded http://localhost:56809/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56809/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:45:52 INFO - PROCESS | 6385 | RSS: Main: 282660864 05:45:52 INFO - PROCESS | 6385 | 05:45:54 INFO - PROCESS | 6385 | Cycle 1(1): loaded http://localhost:56809/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56809/tests/kraken/driver.html?testName=imaging-darkroom) 05:45:55 INFO - PROCESS | 6385 | RSS: Main: 320827392 05:45:55 INFO - PROCESS | 6385 | 05:45:58 INFO - PROCESS | 6385 | Cycle 1(1): loaded http://localhost:56809/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56809/tests/kraken/driver.html?testName=imaging-desaturate) 05:45:59 INFO - PROCESS | 6385 | RSS: Main: 320876544 05:45:59 INFO - PROCESS | 6385 | 05:46:01 INFO - PROCESS | 6385 | Cycle 1(1): loaded http://localhost:56809/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56809/tests/kraken/driver.html?testName=json-parse-financial) 05:46:02 INFO - PROCESS | 6385 | RSS: Main: 321777664 05:46:02 INFO - PROCESS | 6385 | 05:46:04 INFO - PROCESS | 6385 | Cycle 1(1): loaded http://localhost:56809/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56809/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:46:04 INFO - PROCESS | 6385 | RSS: Main: 298237952 05:46:04 INFO - PROCESS | 6385 | 05:46:06 INFO - PROCESS | 6385 | Cycle 1(1): loaded http://localhost:56809/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56809/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:46:07 INFO - PROCESS | 6385 | RSS: Main: 303927296 05:46:07 INFO - PROCESS | 6385 | 05:46:09 INFO - PROCESS | 6385 | Cycle 1(1): loaded http://localhost:56809/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56809/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:46:10 INFO - PROCESS | 6385 | RSS: Main: 306515968 05:46:10 INFO - PROCESS | 6385 | 05:46:13 INFO - PROCESS | 6385 | Cycle 1(1): loaded http://localhost:56809/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:46:13 INFO - PROCESS | 6385 | RSS: Main: 320262144 05:46:13 INFO - PROCESS | 6385 | 05:46:16 INFO - PROCESS | 6385 | Cycle 1(1): loaded http://localhost:56809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:46:17 INFO - PROCESS | 6385 | RSS: Main: 316592128 05:46:17 INFO - PROCESS | 6385 | 05:46:18 INFO - PROCESS | 6385 | Cycle 1(1): loaded http://localhost:56809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56809/tests/kraken/driver.html?testName=ai-astar) 05:46:19 INFO - PROCESS | 6385 | RSS: Main: 359809024 05:46:19 INFO - PROCESS | 6385 | 05:46:19 INFO - PROCESS | 6385 | __start_tp_report 05:46:19 INFO - PROCESS | 6385 | _x_x_mozilla_page_load 05:46:19 INFO - PROCESS | 6385 | _x_x_mozilla_page_load_details 05:46:19 INFO - PROCESS | 6385 | |i|pagename|runs| 05:46:19 INFO - PROCESS | 6385 | |0;ai-astar;114;115;118;113;113;112;112;113;113;123 05:46:19 INFO - PROCESS | 6385 | |1;audio-beat-detection;168;111;133;164;110;133;130;108;168;106 05:46:19 INFO - PROCESS | 6385 | |2;audio-dft;183;183;183;187;186;184;182;183;183;182 05:46:19 INFO - PROCESS | 6385 | |3;audio-fft;77;74;79;157;57;57;58;67;147;58 05:46:19 INFO - PROCESS | 6385 | |4;audio-oscillator;83;83;131;69;69;89;126;67;70;118 05:46:19 INFO - PROCESS | 6385 | |5;imaging-gaussian-blur;86;84;87;84;86;83;86;84;94;130 05:46:19 INFO - PROCESS | 6385 | |6;imaging-darkroom;92;93;93;92;112;148;109;95;92;92 05:46:19 INFO - PROCESS | 6385 | |7;imaging-desaturate;87;84;87;83;84;83;86;85;85;85 05:46:19 INFO - PROCESS | 6385 | |8;json-parse-financial;55;55;54;54;55;53;54;54;53;54 05:46:19 INFO - PROCESS | 6385 | |9;json-stringify-tinderbox;65;64;67;70;72;75;69;70;71;72 05:46:19 INFO - PROCESS | 6385 | |10;stanford-crypto-aes;86;87;88;85;85;83;87;83;90;90 05:46:19 INFO - PROCESS | 6385 | |11;stanford-crypto-ccm;128;146;149;151;139;140;147;162;187;151 05:46:19 INFO - PROCESS | 6385 | |12;stanford-crypto-pbkdf2;169;168;171;168;169;178;168;167;170;168 05:46:19 INFO - PROCESS | 6385 | |13;stanford-crypto-sha256-iterative;68;67;68;66;67;67;67;66;66;68 05:46:19 INFO - PROCESS | 6385 | __end_tp_report 05:46:19 INFO - PROCESS | 6385 | __start_cc_report 05:46:19 INFO - PROCESS | 6385 | _x_x_mozilla_cycle_collect,2064 05:46:19 INFO - PROCESS | 6385 | __end_cc_report 05:46:19 INFO - PROCESS | 6385 | __startTimestamp1473597979217__endTimestamp 05:46:19 INFO - PROCESS | 6385 | 05:46:19 INFO - PROCESS | 6385 | ------- Summary: start ------- 05:46:19 INFO - PROCESS | 6385 | Number of tests: 14 05:46:19 INFO - PROCESS | 6385 | 05:46:19 INFO - PROCESS | 6385 | [#0] ai-astar Cycles:10 Average:114.60 Median:113.50 stddev:3.44 (3.0%) stddev-sans-first:3.64 05:46:19 INFO - PROCESS | 6385 | Values: 114.0 115.0 118.0 113.0 113.0 112.0 112.0 113.0 113.0 123.0 05:46:19 INFO - PROCESS | 6385 | 05:46:19 INFO - PROCESS | 6385 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:133.00 stddev:25.36 (19.1%) stddev-sans-first:23.54 05:46:19 INFO - PROCESS | 6385 | Values: 168.0 111.0 133.0 164.0 110.0 133.0 130.0 108.0 168.0 106.0 05:46:19 INFO - PROCESS | 6385 | 05:46:19 INFO - PROCESS | 6385 | [#2] audio-dft Cycles:10 Average:183.60 Median:183.00 stddev:1.65 (0.9%) stddev-sans-first:1.73 05:46:19 INFO - PROCESS | 6385 | Values: 183.0 183.0 183.0 187.0 186.0 184.0 182.0 183.0 183.0 182.0 05:46:19 INFO - PROCESS | 6385 | 05:46:19 INFO - PROCESS | 6385 | [#3] audio-fft Cycles:10 Average:83.10 Median:62.50 stddev:37.36 (59.8%) stddev-sans-first:39.56 05:46:19 INFO - PROCESS | 6385 | Values: 77.0 74.0 79.0 157.0 57.0 57.0 58.0 67.0 147.0 58.0 05:46:19 INFO - PROCESS | 6385 | 05:46:19 INFO - PROCESS | 6385 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:69.50 stddev:25.10 (36.1%) stddev-sans-first:26.47 05:46:19 INFO - PROCESS | 6385 | Values: 83.0 83.0 131.0 69.0 69.0 89.0 126.0 67.0 70.0 118.0 05:46:19 INFO - PROCESS | 6385 | 05:46:19 INFO - PROCESS | 6385 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:86.00 stddev:14.25 (16.6%) stddev-sans-first:15.03 05:46:19 INFO - PROCESS | 6385 | Values: 86.0 84.0 87.0 84.0 86.0 83.0 86.0 84.0 94.0 130.0 05:46:19 INFO - PROCESS | 6385 | 05:46:19 INFO - PROCESS | 6385 | [#6] imaging-darkroom Cycles:10 Average:101.80 Median:92.00 stddev:17.87 (19.4%) stddev-sans-first:18.60 05:46:19 INFO - PROCESS | 6385 | Values: 92.0 93.0 93.0 92.0 112.0 148.0 109.0 95.0 92.0 92.0 05:46:19 INFO - PROCESS | 6385 | 05:46:19 INFO - PROCESS | 6385 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:1.45 (1.7%) stddev-sans-first:1.32 05:46:19 INFO - PROCESS | 6385 | Values: 87.0 84.0 87.0 83.0 84.0 83.0 86.0 85.0 85.0 85.0 05:46:19 INFO - PROCESS | 6385 | 05:46:19 INFO - PROCESS | 6385 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.71 05:46:19 INFO - PROCESS | 6385 | Values: 55.0 55.0 54.0 54.0 55.0 53.0 54.0 54.0 53.0 54.0 05:46:19 INFO - PROCESS | 6385 | 05:46:19 INFO - PROCESS | 6385 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.50 stddev:3.37 (4.8%) stddev-sans-first:3.16 05:46:19 INFO - PROCESS | 6385 | Values: 65.0 64.0 67.0 70.0 72.0 75.0 69.0 70.0 71.0 72.0 05:46:19 INFO - PROCESS | 6385 | 05:46:19 INFO - PROCESS | 6385 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:87.00 stddev:2.50 (2.9%) stddev-sans-first:2.65 05:46:19 INFO - PROCESS | 6385 | Values: 86.0 87.0 88.0 85.0 85.0 83.0 87.0 83.0 90.0 90.0 05:46:19 INFO - PROCESS | 6385 | 05:46:19 INFO - PROCESS | 6385 | [#11] stanford-crypto-ccm Cycles:10 Average:150.00 Median:150.00 stddev:15.80 (10.5%) stddev-sans-first:14.61 05:46:19 INFO - PROCESS | 6385 | Values: 128.0 146.0 149.0 151.0 139.0 140.0 147.0 162.0 187.0 151.0 05:46:19 INFO - PROCESS | 6385 | 05:46:19 INFO - PROCESS | 6385 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:169.00 stddev:3.17 (1.9%) stddev-sans-first:3.35 05:46:19 INFO - PROCESS | 6385 | Values: 169.0 168.0 171.0 168.0 169.0 178.0 168.0 167.0 170.0 168.0 05:46:19 INFO - PROCESS | 6385 | 05:46:19 INFO - PROCESS | 6385 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 05:46:19 INFO - PROCESS | 6385 | Values: 68.0 67.0 68.0 66.0 67.0 67.0 67.0 66.0 66.0 68.0 05:46:19 INFO - PROCESS | 6385 | -------- Summary: end -------- 05:46:19 INFO - PROCESS | 6385 | 05:46:20 INFO - TEST-INFO | 6385: exit 0 05:46:20 INFO - TEST-OK | kraken | took 59372ms 05:46:20 INFO - SUITE-END | took 1177s 05:46:20 INFO - Completed test suite (00:19:37) 05:46:20 INFO - javascript benchmark 05:46:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2960.348723280878, 3213.5661685672444, 3260.087175590834, 3302.0259023588037, 3352.7653064285496, 5522.171674248864, 5526.668399896009, 5616.466435688613, 5648.802291919784, 5673.177389278552, 5621.550275977912, 5622.0, 5657.547396208303, 5719.485246327829, 5780.421957804228, 5085.466026067265, 5102.311187989611, 5110.514501122406, 5156.896862062757, 5209.557187639055, 5232.215167724834, 5276.182191760283, 5320.228566857803, 5350.678959262456, 5359.0, 5208.990751829983, 5219.921701174486, 5228.372595288552, 5265.7893684252585, 5275.736213189325, 5102.744862756847, 5147.922781158286, 5151.0, 5196.584273258168, 5223.52988231061, 5061.848144555669, 5155.66488178271, 5161.303224064741, 5167.069927413064, 5181.145111056671, 5610.13042978339, 5612.579056570774, 5616.0, 5617.887642247132, 5625.099984002581, 6037.0870930556175, 6097.237845269341, 6130.938690613081, 6137.1012032552535, 6200.3179650238435, 6199.194104766351, 6262.78080267193, 6287.245530536319, 6303.842403939892, 6311.337309582474, 5759.6832174229985, 5768.221290125821, 5769.07694768835, 5777.971110144506, 5783.739731712083, 6207.131001659771, 6220.284667263232, 6274.372562743781, 6312.495000399957, 6319.304876463585, 6089.191684759588, 6093.695315234309, 6098.298695649968, 6109.14471973924, 6133.110698948717, 6234.438900498977, 6241.96879015602, 6263.467605253604, 6271.247450305992, 6288.874222515524, 6091.969540152271, 6092.451679348791, 6138.419052470195, 6145.801568694062, 6178.969105154445, 6087.634741915499, 6124.663143527148, 6127.89207890682, 6181.134641150243, 6208.099825525273, 4855.587275081658, 4863.781129849094, 4867.853964381004, 4895.853124406202, 4919.065377578248, 4153.584641535883, 4349.739015659071, 4371.912561748747, 4376.8905777355185, 4423.867283981485, 5480.986017586759, 5617.578681598897, 5621.381648018714, 5678.517326027251, 5683.261176047087, 6108.342071131425, 6189.257289125244, 6198.2252218472695, 6205.875882482415, 6210.534209934273, 5618.719064046782, 5673.234113394721, 5693.829185124453, 5695.629784064023, 5704.771809127671, 5324.520793128637, 5391.946080539223, 5400.729963501809, 5402.37872644643, 5404.621676482609, 6297.842553936188, 6312.368763123743, 6312.842178945563, 6321.1782468278825, 6327.335629758809, 6117.785877494444, 6127.494965205145, 6128.380904898417, 6245.7189426476825, 6263.6241825490615, 6198.287196972406, 6259.2488901332135, 6270.184875966095, 6284.371562843679, 6304.6847657617855, 6092.939070609237, 6131.601445906002, 6137.263528376623, 6156.476699480594, 6160.414760597736, 6243.594166379171, 6252.968735156295, 6256.374362563707, 6284.3087260402235, 6285.43431091204, 5776.8555786104, 5882.764689412375, 5945.0, 5967.970160149345, 6011.489023432882, 5929.258842644669, 5933.940660593339, 5974.4324289192455, 6071.7571297147615, 6103.298120716175, 5842.853928651818, 5860.94139058621, 5876.823695289148, 5911.3201981772645, 5915.792947246826, 5896.204012458264, 6030.39696030411, 6092.847678808065, 6096.29892562361, 6106.267247930276, 5761.798337058183, 5813.680247586254, 5829.067349224104, 5851.297844258716, 5871.001929671881], "value": 5654.842376252458, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.08347515358986, 501.8971110922261, 510.6170372220834, 512.8820371314596, 527.548945651468, 28656.71343286569, 30130.397392052146, 39920.60277890271, 40376.79811600938, 40820.0, 42125.36811947823, 42482.787586062106, 42508.0, 42569.36145957805, 42599.9350016249, 9777.217822574195, 9916.95041524795, 9950.552225149886, 9979.501024948724, 9980.151687106605, 9795.559199836025, 9899.90100098997, 9915.206783457306, 9918.752031199205, 9929.801403971916, 9877.753056173617, 9922.801543969117, 9949.054839790208, 9953.452560109192, 9979.50102494876, 9848.0, 9886.0, 9904.554295056667, 9919.851202231901, 9927.95036024819, 9784.608615655365, 9851.916289208182, 9861.0, 9863.506824658738, 9870.2103831694, 41258.38112428316, 41578.37632435516, 41625.1674966499, 41647.791761041306, 41851.372229416585, 2841.303880549258, 3312.205070783019, 3448.8620455181763, 3796.6393192646656, 4014.598540145991, 30224.69775302263, 30236.244093897607, 30635.540466893013, 30923.845380772953, 31094.37811243785, 3236.6116066072223, 3296.04414719731, 3320.2031512436843, 3392.6098498672723, 3393.8812141574926, 524829.0, 525854.0, 531220.0, 531321.0, 531472.3426382882, 60966.390336096956, 61469.0, 61565.07652385218, 61587.6920615403, 61718.69140654358, 65354.0, 65515.67242163854, 65517.0, 65625.67187164034, 65652.0, 15483.690326193639, 16213.189340532927, 16442.424515141913, 16512.4220652279, 16522.75215871763, 12647.304398258, 12702.87297127017, 12709.110362274552, 12711.809322860165, 12743.808842867364, 16335.410565256687, 16393.262303196385, 17776.555586110193, 18664.44006679802, 18931.526711832037, 6636.402723754885, 7499.8500029999095, 7601.555704416143, 7716.99679041721, 7754.883676744853, 843.9957800210959, 856.7876454816364, 882.911708829112, 942.9952850235705, 1040.3913710479455, 28327.57508637372, 29437.55843662347, 29488.0, 30061.248468788017, 30261.0, 1031.9164876879247, 1041.0838462153256, 1067.199600299775, 1083.978320433587, 1150.4305368842477, 14830.777538336934, 15285.694286114216, 15482.690346193012, 15660.0, 15672.92163539175, 660023.0, 670618.0, 678227.0, 682917.0, 970998.0, 55910.72044639832, 56653.0, 56789.43210567924, 56818.0, 56963.99999999917, 1154.3362566524115, 1345.724126554054, 1378.4072848675166, 1379.2069560002838, 1380.4823191303262, 29784.404311913207, 30091.0, 30185.09444716662, 30298.394032118795, 30309.242268943453, 49078.0, 50290.748546258495, 50296.74851625718, 50311.74844125756, 50413.49586504088, 535294.0, 576604.0, 580446.0, 580683.0, 582704.0, 26351.868240658674, 26803.0, 26803.329916751456, 26803.731962680904, 26853.194404167905, 44381.67419909631, 44496.555034449244, 44680.55319446894, 45159.32261016022, 46068.769656151504, 37546.436803447425, 37573.24853502969, 38149.427758583086, 38697.226055479296, 38812.41781373338, 37673.0, 37735.05662358463, 38009.00010975664, 38611.806940965114, 39060.41409378805, 27736.340229405527, 31483.0, 37129.071773205884, 38095.42856857094, 38116.61883381242, 25795.743702289663, 27773.583396249476, 31679.52480712837, 33300.00099997004, 33333.66666333305, 24473.021079156635, 24672.0, 24740.38149046288, 25266.36834079163, 25502.48995020052], "value": 19936.16067731995, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.94637831136174, 347.7166109620659, 357.4513122357182, 369.6950016236606, 403.5540727496117, 13206.339683015847, 14921.925390373046, 16125.354985800568, 17388.65222695545, 20908.790912090873, 19600.90199549004, 19752.209911603553, 21004.894975525138, 21143.15427382903, 21221.57556848866, 4542.795574199161, 5634.802781902634, 5634.802781902634, 5640.0, 5650.971745141269, 4585.9541404586025, 5523.558115350783, 5533.09108357618, 5562.527185189244, 5585.134304182858, 5567.47109024642, 5567.693776842272, 5575.0522411190195, 5576.386597474275, 5581.134924086773, 5321.0, 5449.591280653947, 5525.917111243334, 5526.889462210734, 5531.197976293415, 5345.705986170759, 5349.545288650469, 5352.732363381815, 5355.491228333302, 5358.785648574052, 20381.082851271727, 23930.64104038441, 24845.378865528324, 25165.0, 25262.242132736046, 2137.4335801012744, 2152.5587254612765, 2174.597699425611, 2343.414146463384, 2640.2475294540964, 10283.691489255334, 10328.27702060856, 10536.157107431387, 11642.708932276677, 15534.689306213813, 1838.8620853436046, 1839.2826797548967, 1869.5419622192514, 1906.3213257914117, 1913.5598812273256, 110172.4491377546, 120671.0, 128482.71517284801, 128646.99999999907, 129356.0, 11147.219694621299, 11212.383318917538, 11528.711782205344, 11548.191626586058, 11798.292102473879, 14612.342444590018, 14647.414103435956, 14650.267486625626, 14668.706625867422, 14678.559643210721, 8158.388120890957, 8413.663453461915, 8442.915570844336, 8544.2310192083, 8553.016403113597, 8277.461964972377, 8305.418620696493, 8309.25216730485, 8496.447730897471, 8501.234888860032, 4006.2187873364414, 4354.716943398669, 4428.645708343325, 4523.389342438729, 4592.448906131285, 1586.8336772472223, 1893.157544892537, 1909.6085302512952, 1913.2251438167564, 1914.1864707499258, 798.9001374828147, 831.7213733399258, 878.6353663229816, 910.0308171797014, 953.1516949914582, 20670.379888603366, 21446.57106857854, 21527.67708484374, 21612.135514579557, 21672.89163554172, 779.8947142135739, 792.2354927494995, 908.6092980018656, 919.1406035356963, 930.4417349590192, 10401.427921464392, 11145.498452569655, 11180.385078820744, 11305.773884522428, 11349.546018159346, 487884.0, 549004.0, 562145.0, 562673.0, 567682.0, 85490.0, 95039.0, 98254.01745982592, 125284.0, 131231.68768312194, 950.4439902656885, 981.5779214937503, 991.1476130527741, 991.6727479931606, 991.7074463033566, 18534.0, 19132.80867191366, 19329.51676208106, 19423.417297481097, 19470.415887523395, 51793.0, 51966.74016629893, 52476.9504609898, 52501.7374913123, 52658.473415265355, 73873.63063184649, 75820.62089689517, 77178.0, 77333.0, 77751.0, 7865.134835168242, 8072.354211662935, 8109.067457242257, 8152.510849349058, 8292.419530632798, 11315.943420282845, 12379.0, 12636.431360588611, 12691.77893868551, 12795.552155674506, 9405.341626086109, 10818.242723009314, 11005.834912476479, 11089.39008354516, 11185.832212516656, 9141.862872057058, 10611.41637209961, 10790.406527641055, 11103.444827758418, 11196.328220306808, 11061.059809916247, 11061.225714199929, 11303.265287756269, 11333.773324533628, 11454.0, 6968.895466567904, 7901.68393264263, 7976.441649084509, 8164.306033987177, 8266.090730019572, 7596.8480630388185, 7826.686932522635, 7895.328897043815, 8412.761086981434, 9388.624455021996], "value": 9221.437508319928, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1546.126438562212, 1585.6828634273147, 1737.5656085978505, 1844.9907750461246, 1906.4947788835952, 8086.312663423601, 8388.62251198696, 8532.658693652254, 9070.410423322488, 9080.455172689635, 8214.876776848352, 8737.86893196601, 8865.734027979155, 8869.157430044152, 9011.324150688692, 2393.270052633946, 2416.4804567018086, 2416.867072311022, 2422.067504010951, 2429.635554666805, 2112.5563631637374, 2379.619260918245, 2410.3010127063217, 2419.8790060496904, 2423.8303318767607, 2170.739511258651, 2197.8021978022057, 2331.4404542909665, 2408.4821763320883, 2413.1312727418117, 2384.523095380922, 2387.6776635154206, 2392.9760702392928, 2393.9162129325564, 2398.85606863587, 2217.634090375086, 2363.4564050268536, 2379.310000099969, 2382.60686986647, 2388.713354397466, 8360.665573377057, 9164.991850896396, 9167.266618670557, 9178.81642367149, 9187.08129187076, 4976.925346119811, 5122.949795291956, 5521.3926468088475, 5523.28197334344, 5526.115821468586, 3527.3650742866275, 3590.0, 3699.667029967316, 3711.1464363196346, 3723.2181241939224, 945.9195968342699, 1077.7413420778958, 1081.734974931139, 1087.3530249501614, 1101.1191047162238, 10216.591336346537, 11780.116491263103, 11928.165028448098, 11963.102767292401, 11978.281303121841, 4001.519817621846, 4655.953440465552, 4866.0, 4878.585320247818, 4888.608911287089, 10192.082712555906, 10240.795184096276, 10247.590096396061, 10255.384676919408, 10259.076683098558, 5515.917261241085, 5518.19986102013, 5518.668879867221, 5518.944810551923, 5523.585731070186, 4960.875978100504, 4968.503149685002, 5003.897583498182, 5040.420351659533, 5057.190849464068, 3544.4860495228563, 3721.5534135903863, 3906.7655940643085, 3941.231459865356, 3982.303096958021, 1245.7383949370553, 1252.6492582077033, 1260.6533203369147, 1267.113020885384, 1267.3409826889965, 605.7395320012349, 728.3481284250566, 769.6690423118113, 786.5359437931647, 832.9583520823935, 5356.839294821161, 5404.810831620953, 5428.782848686008, 5649.887002259932, 5662.490375866109, 809.7975506123469, 882.7440042387764, 915.6474757218518, 926.5413620257881, 953.1564565359706, 3566.0906468850276, 3583.498310236569, 3587.264610754789, 3694.8706795262037, 3745.962540374616, 10641.201909856636, 11178.776424471465, 11182.993530582287, 11206.047485963622, 11351.978321951065, 11200.943995280135, 11201.439928003567, 11203.383813890314, 11206.775864482664, 11242.269252498561, 8240.711575094843, 8292.751217463485, 8348.70779522726, 8445.113263107409, 8449.366297527587, 5340.813071542478, 5472.151816468454, 5499.285092937893, 5511.641743286674, 5649.152627105967, 10239.43683097407, 10269.127124194229, 10305.690829274834, 10410.635627752992, 10435.269531132748, 10000.099991000845, 10391.116755075904, 10408.323458975143, 10566.049055585034, 10581.841272380767, 7444.255574442513, 7616.9238307616215, 7619.771406857803, 7619.809504762426, 7624.58064806441, 8264.132266111972, 8300.584970751559, 8395.160483951557, 8397.160283971554, 8498.74503764888, 7595.430342724429, 7639.732609358646, 7667.0, 7729.961350193438, 7875.306809036085, 6414.550981431255, 7377.8155546111775, 7415.073115860518, 7422.109346878409, 7439.962800185965, 6988.6505674715045, 7054.224035356004, 7077.469189810682, 7158.0, 7168.032315637531, 4194.0, 4758.119747846521, 4805.207140821725, 4808.567228949411, 4872.0, 4178.227027999708, 4747.477777444409, 4831.647138801141, 4854.708717476963, 4968.975155124202], "value": 4574.408432075521, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.70639443415024, 302.7729203097677, 310.5310980419566, 313.8697440562167, 317.83313760275837, 5013.799448022075, 5039.949600503989, 5310.362756469224, 5370.925814837029, 5388.973055134724, 5001.349824522816, 5059.873503162423, 5146.536811686948, 5177.818776342829, 5205.661631993918, 3372.6458721834224, 3578.910527236814, 4051.8784436466954, 4053.452783874176, 4066.430699702044, 4003.9599604004025, 4017.919641607166, 4032.5967403259588, 4064.878053658395, 4073.5926407359325, 3215.662355452679, 3261.4781634938413, 3867.6325749053935, 4050.6961977851633, 4069.9389509157386, 3511.9990802621387, 3937.3109705801658, 4018.276710192164, 4027.335489644205, 4035.899102522431, 3014.6834582368974, 3090.860911258999, 3456.395130852116, 3534.964650353489, 3535.381308271042, 5101.387833459971, 5103.693778373309, 5104.846854594368, 5147.279380886679, 5179.922301165486, 3972.404139379087, 4480.529544397857, 4536.364908912755, 4591.51789062147, 4606.60843828275, 4687.906241875144, 4756.500567440438, 5256.869772998785, 5541.33503979521, 5547.611667183299, 3220.5974253218346, 3807.9428808567895, 3843.9231215375535, 3850.84596616135, 3859.903502412434, 4746.670932139006, 4830.106430310404, 5185.96280743849, 5777.0, 5855.648661080349, 3788.8295026723863, 3810.676092532166, 3815.809209539512, 3826.196498735241, 3828.349180639298, 3733.3653278942643, 3879.689624830007, 3884.6792090688737, 3933.193695292458, 3933.9803300983313, 4339.674524410681, 4485.372047913294, 4510.571495707903, 4514.390557274726, 4552.840650577214, 4609.354690343354, 5539.667619942817, 5566.610337276433, 5576.275084239104, 5584.966781145501, 1231.9630411087683, 1302.7589895869294, 1332.7201287729492, 1338.852726200117, 1339.3124662924786, 776.9067711874611, 801.3589128697135, 864.1056506515852, 869.891263592051, 894.3873446689039, 5173.249878767558, 5237.266782650432, 5242.97378513105, 5283.9471605284225, 5293.338332708411, 5030.320906677552, 5715.599908006399, 5730.541556675456, 5734.0, 5783.71081445926, 4804.303376010529, 5187.0, 5287.629865909426, 5349.565947493881, 5381.789097453042, 3010.1421094987822, 3020.5771192033135, 3045.4365942300747, 3054.9613131535384, 3061.8315992620173, 5285.577153827685, 5505.614606977553, 5807.738651760681, 6026.0, 6087.604305720114, 5102.770375333119, 5200.985807767449, 5775.249217601685, 5855.736491857877, 5896.941030589725, 5111.974440127776, 5864.413558644102, 5964.850878727893, 5974.492168165668, 6005.519558435315, 5492.642978206563, 5742.913856292243, 5768.682722450138, 5781.364049954585, 5814.30228372598, 5199.7140157291715, 5643.52030077448, 5720.48515633595, 5733.0, 5777.62445441045, 4818.807247710052, 4947.48051454592, 5148.2020286855595, 5492.35229431161, 5557.805476808292, 3812.752171108869, 3822.94265586022, 3832.8466861325232, 3869.496965394593, 3877.321468743015, 5073.0, 5546.417626149197, 5561.582881283839, 5717.683743428718, 5796.681182535001, 4387.8244870204835, 4969.925451118308, 5501.312335958005, 5659.830205093854, 5714.657120572779, 4923.4584195737725, 5184.988927159167, 5600.943990560042, 5628.352739435018, 5682.715864206856, 4429.402030725811, 4625.028743963805, 4965.801367945386, 5058.747062646779, 5352.785888564414, 5502.422245664147, 5511.614187006871, 5603.635763675511, 5759.683217422914, 5821.76712931478, 4835.323054772405, 5033.6660784892765, 5158.277841102174, 5248.795505887612, 5552.250446189712], "value": 4038.5528798489795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.3915293694484, 721.7045403500713, 765.731993802169, 797.4099166616699, 821.9342452603793, 15574.610634734137, 16706.582335441606, 16778.664426711457, 16785.664286714273, 16803.32786688531, 14933.850661493381, 15075.095494270352, 15084.245787710597, 15115.546533603982, 15248.771268430955, 682.1711620381236, 685.7462738786656, 707.5118168463744, 711.900333953247, 848.1391387741447, 689.2487188964028, 690.5304393012749, 819.5164852736884, 857.4726543175933, 863.654538184728, 893.3924931046886, 903.5798353765498, 904.5160838951163, 905.0316161706976, 908.9409188402766, 893.4326702543866, 900.9684661036865, 902.9819403611957, 903.6656437118309, 903.9141281578272, 659.4526542969325, 659.4987809264993, 660.1615947746335, 661.1504217081027, 664.7008846019311, 11767.646970590811, 12228.205166664138, 12238.204516706386, 12246.693832654166, 12252.326122063283, 13664.248466334348, 14594.781078283835, 14746.188959607218, 14818.925905370512, 14894.627634309121, 11640.708982275426, 11723.179377443583, 11769.705757356049, 11784.469698863486, 12257.387130643432, 3855.4795102661064, 3922.5489068756888, 3966.920661586781, 3967.841286348543, 3986.54154772202, 116471.0, 121846.17230741546, 122474.77525224723, 122479.16281255789, 122577.38711306386, 10375.896241037644, 10976.615818446477, 11425.028872545927, 11503.654890353302, 11522.827157592475, 22924.0, 23122.306330809766, 23156.884215578815, 23163.0, 23825.285241442783, 8150.0627427845375, 8204.425690201628, 8212.301954333829, 8213.998912647721, 8229.25936665703, 4390.473143222834, 4419.845305414295, 4431.62331201845, 4726.550977657117, 4779.402574678165, 3639.2721455708966, 3762.0, 3763.6612704856148, 3766.152615661454, 3769.7361184716806, 662.7713438863584, 676.1379241467168, 684.2678334182377, 697.7976386847859, 698.8043347862607, 589.8672798620362, 626.8968605403272, 627.2347735762363, 637.2830565613684, 680.0988689985788, 8850.822983540293, 9099.81800363989, 9533.570989305359, 10077.720207253828, 10429.791404171874, 561.6545824318015, 590.8404730722681, 616.2543322579639, 618.2334055103377, 652.4780175859294, 3748.437734339871, 4399.38408622793, 4664.385679657628, 4764.38063051808, 4872.342233798392, 92794.0, 105819.0, 153408.2329588345, 164006.3599363991, 164788.0, 138148.0, 140586.0, 145120.0, 145933.0, 146545.0, 113269.0, 115944.0, 121877.99999999822, 124366.13450798245, 127324.81115049536, 7896.84206315882, 9130.360874738704, 9147.131022552847, 9167.954160229156, 9276.860847087433, 50042.249366260265, 64043.0, 67277.32722672711, 68220.6588967052, 68405.65797170982, 96593.0, 102987.48506257421, 103815.92368152746, 105021.0, 106788.7192972787, 12135.817962730744, 12204.694882628006, 12348.135630505778, 12677.30274834893, 12829.358532073546, 13210.141340812816, 13337.0, 13375.063745538107, 13459.79810302866, 13577.796333054814, 12310.507579696712, 12499.125061245626, 12504.124711270488, 12551.93724031374, 13079.673008174872, 12220.694482638006, 12406.25562466255, 12536.561220357244, 12984.545540906023, 13200.867991320349, 10958.890411095786, 11301.0, 13659.317034148451, 13765.38055787512, 13973.67264591919, 8162.755117346489, 11225.4387280634, 11285.661430157108, 11408.54365825391, 11916.10629202796, 10052.899471005196, 10090.394576325443, 11392.0, 11653.359065251492, 11746.941265293619], "value": 7804.071373363038, "unit": "score"}], "name": "dromaeo_css", "value": 7288.387908412615, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 118.0, 113.0, 113.0, 112.0, 112.0, 113.0, 113.0, 123.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 111.0, 133.0, 164.0, 110.0, 133.0, 130.0, 108.0, 168.0, 106.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 183.0, 187.0, 186.0, 184.0, 182.0, 183.0, 183.0, 182.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 79.0, 157.0, 57.0, 57.0, 58.0, 67.0, 147.0, 58.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 131.0, 69.0, 69.0, 89.0, 126.0, 67.0, 70.0, 118.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 84.0, 86.0, 83.0, 86.0, 84.0, 94.0, 130.0], "value": 90.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 92.0, 112.0, 148.0, 109.0, 95.0, 92.0, 92.0], "value": 101.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 83.0, 84.0, 83.0, 86.0, 85.0, 85.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 55.0, 53.0, 54.0, 54.0, 53.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 67.0, 70.0, 72.0, 75.0, 69.0, 70.0, 71.0, 72.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 88.0, 85.0, 85.0, 83.0, 87.0, 83.0, 90.0, 90.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 146.0, 149.0, 151.0, 139.0, 140.0, 147.0, 162.0, 187.0, 151.0], "value": 150.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 171.0, 168.0, 169.0, 178.0, 168.0, 167.0, 170.0, 168.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 66.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1478.6, "alertThreshold": 2.0}]} 05:46:20 INFO - Return code: 0 05:46:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:46:20 INFO - # TBPL SUCCESS # 05:46:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:46:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:46:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:46:20 INFO - 2016-09-11 05:46:20.526 screenresolution[6389:114847] starting screenresolution argv=screenresolution get 05:46:20 INFO - 2016-09-11 05:46:20.529 screenresolution[6389:114847] Display 0: 1600x1200x32@60 05:46:20 INFO - 2016-09-11 05:46:20.535 screenresolution[6390:114850] starting screenresolution argv=screenresolution list 05:46:20 INFO - Available Modes on Display 0 05:46:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:46:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:46:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:46:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:46:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:46:20 INFO - Intel Iris: 05:46:20 INFO - Chipset Model: Intel Iris 05:46:20 INFO - Type: GPU 05:46:20 INFO - Bus: Built-In 05:46:20 INFO - VRAM (Dynamic, Max): 1536 MB 05:46:20 INFO - Vendor: Intel (0x8086) 05:46:20 INFO - Device ID: 0x0a2e 05:46:20 INFO - Revision ID: 0x0009 05:46:20 INFO - Displays: 05:46:20 INFO - Display: 05:46:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:46:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:46:20 INFO - Display Serial Number: 1600x1200 60 05:46:20 INFO - Main Display: Yes 05:46:20 INFO - Mirror: Off 05:46:20 INFO - Online: Yes 05:46:20 INFO - Rotation: Supported 05:46:20 INFO - Return code: 0 05:46:20 INFO - Running post-action listener: _resource_record_post_action 05:46:20 INFO - [mozharness: 2016-09-11 12:46:20.768923Z] Finished run-tests step (success) 05:46:20 INFO - Running post-run listener: _resource_record_post_run 05:46:20 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 1584128; Write bytes: 708260352; Read time: 22; Write time: 2116 05:46:20 INFO - TinderboxPrint: CPU usage
53.6% 05:46:20 INFO - TinderboxPrint: I/O read bytes / time
1,584,128 / 22 05:46:20 INFO - TinderboxPrint: I/O write bytes / time
708,260,352 / 2,116 05:46:20 INFO - TinderboxPrint: CPU idle
2,252.2 (46.4%) 05:46:20 INFO - TinderboxPrint: CPU system
971.3 (20.0%) 05:46:20 INFO - TinderboxPrint: CPU user
1,630.2 (33.6%) 05:46:20 INFO - TinderboxPrint: Swap in / out
408,104,960 / 0 05:46:20 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 396311040; Write bytes: 390473216; Read time: 29418; Write time: 715 05:46:20 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 1584128; Write bytes: 299088896; Read time: 22; Write time: 1362 05:46:21 INFO - Running post-run listener: _upload_blobber_files 05:46:21 INFO - Blob upload gear active. 05:46:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:46:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:46:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:46:21 INFO - (blobuploader) - INFO - Open directory for files ... 05:46:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:46:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:46:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:22 INFO - (blobuploader) - INFO - Done attempting. 05:46:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:46:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:46:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:23 INFO - (blobuploader) - INFO - Done attempting. 05:46:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:46:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:46:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:25 INFO - (blobuploader) - INFO - Done attempting. 05:46:25 INFO - (blobuploader) - INFO - Iteration through files over. 05:46:25 INFO - Return code: 0 05:46:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:46:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:46:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87b1d5f02ef221c16c001aee40aff37f832998c05c064bb998bf78cd3cd2c8caa6f23a1f749512aac9fe4faf58d99689572ee95d746e892fc8363d6f0d1bd7a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb2fafad98250c95a0b6594198477ada706b3d332da2ea10c908c6415e80effe6de509c38cc8a0940877dee64300249466655201130b0d76cdb362ccb560640", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cfd87e35054807a2086022b814001de041e4c9766ccd5d173743109479fd3fa8d9e92f2f6db33ed1cf98fa1d93371b2570b3e818149d58cd3a6c92dbb544c80"} 05:46:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:46:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:46:25 INFO - Contents: 05:46:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87b1d5f02ef221c16c001aee40aff37f832998c05c064bb998bf78cd3cd2c8caa6f23a1f749512aac9fe4faf58d99689572ee95d746e892fc8363d6f0d1bd7a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb2fafad98250c95a0b6594198477ada706b3d332da2ea10c908c6415e80effe6de509c38cc8a0940877dee64300249466655201130b0d76cdb362ccb560640", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cfd87e35054807a2086022b814001de041e4c9766ccd5d173743109479fd3fa8d9e92f2f6db33ed1cf98fa1d93371b2570b3e818149d58cd3a6c92dbb544c80"} 05:46:25 INFO - Running post-run listener: copy_logs_to_upload_dir 05:46:25 INFO - Copying logs to upload dir... 05:46:25 INFO - mkdir: /builds/slave/test/build/upload/logs 05:46:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.833232 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-11 05:46:26.078123) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-11 05:46:26.081637) ========= 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.1kwicHsD6r/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.6zwGCMXfzd/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87b1d5f02ef221c16c001aee40aff37f832998c05c064bb998bf78cd3cd2c8caa6f23a1f749512aac9fe4faf58d99689572ee95d746e892fc8363d6f0d1bd7a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb2fafad98250c95a0b6594198477ada706b3d332da2ea10c908c6415e80effe6de509c38cc8a0940877dee64300249466655201130b0d76cdb362ccb560640", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cfd87e35054807a2086022b814001de041e4c9766ccd5d173743109479fd3fa8d9e92f2f6db33ed1cf98fa1d93371b2570b3e818149d58cd3a6c92dbb544c80"} build_url:https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011167 build_url: 'https://queue.taskcluster.net/v1/task/eJTpFR5BRqSorvF3Obzc9A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/87b1d5f02ef221c16c001aee40aff37f832998c05c064bb998bf78cd3cd2c8caa6f23a1f749512aac9fe4faf58d99689572ee95d746e892fc8363d6f0d1bd7a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cb2fafad98250c95a0b6594198477ada706b3d332da2ea10c908c6415e80effe6de509c38cc8a0940877dee64300249466655201130b0d76cdb362ccb560640", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cfd87e35054807a2086022b814001de041e4c9766ccd5d173743109479fd3fa8d9e92f2f6db33ed1cf98fa1d93371b2570b3e818149d58cd3a6c92dbb544c80"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-11 05:46:26.115120) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-11 05:46:26.115462) ========= 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.1kwicHsD6r/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.6zwGCMXfzd/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.004621 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-11 05:46:26.164358) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-11 05:46:26.164756) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-11 05:46:26.165101) ========= ========= Total master_lag: 0.22 =========