builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0072 starttime: 1478564274.46 results: success (0) buildid: 20161107140320 builduid: 9d56d5a394ee4dd7871cdcc463d9cea6 revision: 86f702229e32c6119d092e86431afee576f033a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-07 16:17:54.457917) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-07 16:17:54.458380) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-07 16:17:54.458667) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-07 16:17:54.483984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 16:17:54.484393) ========= 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.zzCVye8LLu/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.IOLaueycMX/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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-11-07 16:17:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.5M=0.001s 2016-11-07 16:17:54 (14.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124849 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 16:17:54.632096) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 16:17:54.632428) ========= 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.zzCVye8LLu/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.IOLaueycMX/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.034160 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 16:17:54.687782) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-07 16:17:54.688192) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 86f702229e32c6119d092e86431afee576f033a1 --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 86f702229e32c6119d092e86431afee576f033a1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zzCVye8LLu/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.IOLaueycMX/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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-11-07 16:17:54,769 truncating revision to first 12 chars 2016-11-07 16:17:54,769 Setting DEBUG logging. 2016-11-07 16:17:54,769 attempt 1/10 2016-11-07 16:17:54,769 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/86f702229e32?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-07 16:17:56,584 unpacking tar archive at: mozilla-central-86f702229e32/testing/mozharness/ program finished with exit code 0 elapsedTime=2.075479 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-07 16:17:56.785866) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-07 16:17:56.786206) ========= script_repo_revision: 86f702229e32c6119d092e86431afee576f033a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-07 16:17:56.786602) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-07 16:17:56.786927) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-07 16:17:56.805894) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-07 16:17:56.806287) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zzCVye8LLu/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.IOLaueycMX/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 16:17:57 INFO - MultiFileLogger online at 20161107 16:17:57 in /builds/slave/test 16:17:57 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 16:17:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:17:57 INFO - {'append_to_log': False, 16:17:57 INFO - 'base_work_dir': '/builds/slave/test', 16:17:57 INFO - 'blob_upload_branch': 'Firefox', 16:17:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:17:57 INFO - 'branch': 'Firefox', 16:17:57 INFO - 'buildbot_json_path': 'buildprops.json', 16:17:57 INFO - 'config_files': ('talos/mac_config.py',), 16:17:57 INFO - 'default_actions': ('clobber', 16:17:57 INFO - 'read-buildbot-config', 16:17:57 INFO - 'download-and-extract', 16:17:57 INFO - 'populate-webroot', 16:17:57 INFO - 'create-virtualenv', 16:17:57 INFO - 'install', 16:17:57 INFO - 'run-tests'), 16:17:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:17:57 INFO - 'download_minidump_stackwalk': True, 16:17:57 INFO - 'download_symbols': 'ondemand', 16:17:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:17:57 INFO - 'tooltool.py': '/tools/tooltool.py', 16:17:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:17:57 INFO - '/tools/misc-python/virtualenv.py')}, 16:17:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:17:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:17:57 INFO - 'installer_path': 'installer.exe', 16:17:57 INFO - 'log_level': 'info', 16:17:57 INFO - 'log_name': 'talos', 16:17:57 INFO - 'log_to_console': True, 16:17:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:17:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:17:57 INFO - 'opt_config_files': (), 16:17:57 INFO - 'pip_index': False, 16:17:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:17:57 INFO - 'cmd': ('bash', 16:17:57 INFO - '-c', 16:17:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:17:57 INFO - 'enabled': True, 16:17:57 INFO - 'halt_on_failure': False, 16:17:57 INFO - 'name': 'check_screen_resolution'},), 16:17:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:17:57 INFO - 'cmd': ('bash', 16:17:57 INFO - '-c', 16:17:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:17:57 INFO - 'enabled': True, 16:17:57 INFO - 'halt_on_failure': False, 16:17:57 INFO - 'name': 'check_screen_resolution'},), 16:17:57 INFO - 'run_cmd_checks_enabled': True, 16:17:57 INFO - 'sps_profile': False, 16:17:57 INFO - 'sps_profile_interval': 0, 16:17:57 INFO - 'suite': 'dromaeojs', 16:17:57 INFO - 'system_bits': '32', 16:17:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:17:57 INFO - 'title': 't-yosemite-r7-0072', 16:17:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:17:57 INFO - 'use_talos_json': True, 16:17:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:17:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:17:57 INFO - 'work_dir': 'build'} 16:17:57 INFO - [mozharness: 2016-11-08 00:17:57.017676Z] Running clobber step. 16:17:57 INFO - Running pre-action listener: _resource_record_pre_action 16:17:57 INFO - Running main action method: clobber 16:17:57 INFO - rmtree: /builds/slave/test/build 16:17:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:17:59 INFO - Running post-action listener: _resource_record_post_action 16:17:59 INFO - [mozharness: 2016-11-08 00:17:59.427114Z] Finished clobber step (success) 16:17:59 INFO - [mozharness: 2016-11-08 00:17:59.427247Z] Running read-buildbot-config step. 16:17:59 INFO - Running pre-action listener: _resource_record_pre_action 16:17:59 INFO - Running main action method: read_buildbot_config 16:17:59 INFO - Using buildbot properties: 16:17:59 INFO - { 16:17:59 INFO - "project": "", 16:17:59 INFO - "product": "firefox", 16:17:59 INFO - "script_repo_revision": "production", 16:17:59 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 16:17:59 INFO - "repository": "", 16:17:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 16:17:59 INFO - "buildid": "20161107140320", 16:17:59 INFO - "pgo_build": "False", 16:17:59 INFO - "basedir": "/builds/slave/test", 16:17:59 INFO - "buildnumber": 27, 16:17:59 INFO - "slavename": "t-yosemite-r7-0072", 16:17:59 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:17:59 INFO - "platform": "yosemite_r7", 16:17:59 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:17:59 INFO - "branch": "mozilla-central", 16:17:59 INFO - "repo_path": "mozilla-central", 16:17:59 INFO - "revision": "86f702229e32c6119d092e86431afee576f033a1", 16:17:59 INFO - "stage_platform": "macosx64", 16:17:59 INFO - "builduid": "9d56d5a394ee4dd7871cdcc463d9cea6", 16:17:59 INFO - "slavebuilddir": "test" 16:17:59 INFO - } 16:17:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 16:17:59 INFO - Running post-action listener: _resource_record_post_action 16:17:59 INFO - [mozharness: 2016-11-08 00:17:59.430697Z] Finished read-buildbot-config step (success) 16:17:59 INFO - [mozharness: 2016-11-08 00:17:59.430850Z] Running download-and-extract step. 16:17:59 INFO - Running pre-action listener: _resource_record_pre_action 16:17:59 INFO - Running main action method: download_and_extract 16:17:59 INFO - mkdir: /builds/slave/test/build/tests 16:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:17:59 INFO - trying https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 16:17:59 INFO - Downloading https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 16:17:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 16:18:00 INFO - Downloaded 1199 bytes. 16:18:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 16:18:00 INFO - Using the following test package requirements: 16:18:00 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 16:18:00 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:18:00 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 16:18:00 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:18:00 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 16:18:00 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:18:00 INFO - u'jsshell-mac.zip'], 16:18:00 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:18:00 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 16:18:00 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 16:18:00 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:18:00 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 16:18:00 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:18:00 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 16:18:00 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:18:00 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 16:18:00 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:18:00 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 16:18:00 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:18:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 16:18:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:18:00 INFO - Fetch https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 16:18:01 INFO - Http code: 200 16:18:01 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 16:18:01 INFO - x-amz-cf-id: DsHaw7zldVr-0SfwaTfzTmo6g0b1b3VGUUF29nVpxedgTLBk98HZ5A== 16:18:01 INFO - x-amz-version-id: AX_Uii6hX82TkOS.NsCVW6wcSXmLdfEv 16:18:01 INFO - Expected file size: 16309955 16:18:01 INFO - Obtained file size: 16309955 16:18:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:18:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 16:18:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:18:08 INFO - Fetch https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 16:18:08 INFO - Http code: 200 16:18:08 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 16:18:08 INFO - x-amz-cf-id: aFaHUv1stXVOeDv_3lebISx3zZQTv13Si5w4w2tnasNmT7xGjvi77Q== 16:18:08 INFO - x-amz-version-id: AX_Uii6hX82TkOS.NsCVW6wcSXmLdfEv 16:18:09 INFO - Expected file size: 16309955 16:18:09 INFO - Obtained file size: 16309955 16:18:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 16:18:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:18:15 INFO - Fetch https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 16:18:16 INFO - Http code: 200 16:18:16 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 16:18:16 INFO - x-amz-cf-id: qWsTng_QSfBk408hM56orGqG5OO2nYAVWmwnPcpIAJCe8VOmxZHsxw== 16:18:16 INFO - x-amz-version-id: lreseVZveCZkXduGk88gzG40VGXAd0yX 16:18:17 INFO - Expected file size: 14409038 16:18:17 INFO - Obtained file size: 14409038 16:18:17 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')]} 16:18:17 INFO - trying https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:18:17 INFO - Downloading https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 16:18:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 16:18:20 INFO - Downloaded 111613333 bytes. 16:18:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:18:20 INFO - mkdir: /builds/slave/test/properties 16:18:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:18:20 INFO - Writing to file /builds/slave/test/properties/build_url 16:18:20 INFO - Contents: 16:18:20 INFO - build_url:https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:18:21 INFO - Running post-action listener: _resource_record_post_action 16:18:21 INFO - Running post-action listener: set_extra_try_arguments 16:18:21 INFO - [mozharness: 2016-11-08 00:18:21.428181Z] Finished download-and-extract step (success) 16:18:21 INFO - [mozharness: 2016-11-08 00:18:21.428295Z] Running populate-webroot step. 16:18:21 INFO - Running pre-action listener: _resource_record_pre_action 16:18:21 INFO - Running main action method: populate_webroot 16:18:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:18:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:18:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:18:21 INFO - '--tppagecycles', 16:18:21 INFO - '7'], 16:18:21 INFO - 'tests': ['tsvgm']}}, 16:18:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:18:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:18:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:18:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:18:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:18:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:18:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:21 INFO - 'talos_options': ['--disable-e10s'], 16:18:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:18:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:21 INFO - 'talos_options': ['--disable-e10s'], 16:18:21 INFO - 'tests': ['damp', 'tps']}, 16:18:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:21 INFO - 'tests': ['damp', 'tps']}, 16:18:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:18:21 INFO - 'tests': ['dromaeo_dom']}, 16:18:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:18:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:18:21 INFO - 'tests': ['basic_compositor_video']}, 16:18:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:18:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:18:21 INFO - 'tests': ['a11yr', 16:18:21 INFO - 'ts_paint', 16:18:21 INFO - 'tpaint', 16:18:21 INFO - 'sessionrestore', 16:18:21 INFO - 'sessionrestore_no_auto_restore', 16:18:21 INFO - 'tabpaint']}, 16:18:21 INFO - 'other-e10s': {'tests': ['a11yr', 16:18:21 INFO - 'ts_paint', 16:18:21 INFO - 'tpaint', 16:18:21 INFO - 'sessionrestore', 16:18:21 INFO - 'sessionrestore_no_auto_restore', 16:18:21 INFO - 'tabpaint']}, 16:18:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:18:21 INFO - 'ts_paint', 16:18:21 INFO - 'tpaint', 16:18:21 INFO - 'sessionrestore', 16:18:21 INFO - 'sessionrestore_no_auto_restore', 16:18:21 INFO - 'tabpaint']}, 16:18:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:18:21 INFO - 'ts_paint', 16:18:21 INFO - 'tpaint', 16:18:21 INFO - 'sessionrestore', 16:18:21 INFO - 'sessionrestore_no_auto_restore', 16:18:21 INFO - 'tabpaint']}, 16:18:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:18:21 INFO - 'tests': ['a11yr', 16:18:21 INFO - 'ts_paint', 16:18:21 INFO - 'tpaint', 16:18:21 INFO - 'sessionrestore', 16:18:21 INFO - 'sessionrestore_no_auto_restore', 16:18:21 INFO - 'tabpaint']}, 16:18:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:18:21 INFO - 'tests': ['a11yr', 16:18:21 INFO - 'ts_paint', 16:18:21 INFO - 'tpaint', 16:18:21 INFO - 'sessionrestore', 16:18:21 INFO - 'sessionrestore_no_auto_restore', 16:18:21 INFO - 'tabpaint']}, 16:18:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:18:21 INFO - 'tests': ['tsvgx', 16:18:21 INFO - 'tsvgr_opacity', 16:18:21 INFO - 'tart', 16:18:21 INFO - 'tscrollx', 16:18:21 INFO - 'cart']}, 16:18:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:18:21 INFO - 'tsvgr_opacity', 16:18:21 INFO - 'tart', 16:18:21 INFO - 'tscrollx', 16:18:21 INFO - 'cart']}, 16:18:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:21 INFO - 'talos_options': ['--disable-e10s'], 16:18:21 INFO - 'tests': ['tp5o']}, 16:18:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:21 INFO - 'tests': ['tp5o']}, 16:18:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:21 INFO - 'talos_options': ['--disable-e10s', 16:18:21 INFO - '--xperf_path', 16:18:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:21 INFO - 'tests': ['tp5n']}, 16:18:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:18:21 INFO - 'talos_options': ['--xperf_path', 16:18:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:18:21 INFO - 'tests': ['tp5n']}}, 16:18:21 INFO - 'talos.zip': {'path': '', 16:18:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:18:21 INFO - Running post-action listener: _resource_record_post_action 16:18:21 INFO - [mozharness: 2016-11-08 00:18:21.447037Z] Finished populate-webroot step (success) 16:18:21 INFO - [mozharness: 2016-11-08 00:18:21.447135Z] Running create-virtualenv step. 16:18:21 INFO - Running pre-action listener: _resource_record_pre_action 16:18:21 INFO - Running main action method: create_virtualenv 16:18:21 INFO - Creating virtualenv /builds/slave/test/build/venv 16:18:21 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 16:18:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:18:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:18:21 INFO - Using real prefix '/tools/python27' 16:18:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:18:22 INFO - Installing distribute.............................................................................................................................................................................................done. 16:18:25 INFO - Installing pip.................done. 16:18:25 INFO - Return code: 0 16:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:18:25 INFO - Reading from file tmpfile_stdout 16:18:25 INFO - Output received: 16:18:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:18:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:25 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 0x104199490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10410f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828adceb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fadd30>, '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 0x103dd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fa5b20>, '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.zzCVye8LLu/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.IOLaueycMX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 16:18:25 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 16:18:25 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 16:18:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zzCVye8LLu/Render', 16:18:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:25 INFO - 'HOME': '/Users/cltbld', 16:18:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:25 INFO - 'LOGNAME': 'cltbld', 16:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:25 INFO - 'MOZ_NO_REMOTE': '1', 16:18:25 INFO - 'NO_EM_RESTART': '1', 16:18:25 INFO - 'PAGER': '/bin/cat', 16:18:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:25 INFO - 'PWD': '/builds/slave/test', 16:18:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:25 INFO - 'SHELL': '/bin/bash', 16:18:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IOLaueycMX/Listeners', 16:18:25 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:18:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:25 INFO - 'USER': 'cltbld', 16:18:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:25 INFO - 'XPC_FLAGS': '0x0', 16:18:25 INFO - 'XPC_SERVICE_NAME': '0', 16:18:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:25 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 16:18:25 INFO - Cleaning up... 16:18:25 INFO - Return code: 0 16:18:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:25 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 0x104199490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10410f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828adceb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fadd30>, '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 0x103dd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fa5b20>, '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.zzCVye8LLu/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.IOLaueycMX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 16:18:25 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 16:18:25 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 16:18:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zzCVye8LLu/Render', 16:18:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:25 INFO - 'HOME': '/Users/cltbld', 16:18:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:25 INFO - 'LOGNAME': 'cltbld', 16:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:25 INFO - 'MOZ_NO_REMOTE': '1', 16:18:25 INFO - 'NO_EM_RESTART': '1', 16:18:25 INFO - 'PAGER': '/bin/cat', 16:18:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:25 INFO - 'PWD': '/builds/slave/test', 16:18:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:25 INFO - 'SHELL': '/bin/bash', 16:18:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IOLaueycMX/Listeners', 16:18:25 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:18:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:25 INFO - 'USER': 'cltbld', 16:18:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:25 INFO - 'XPC_FLAGS': '0x0', 16:18:25 INFO - 'XPC_SERVICE_NAME': '0', 16:18:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:25 INFO - Downloading/unpacking psutil>=3.1.1 16:18:25 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 16:18:25 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 16:18:25 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 16:18:25 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 16:18:25 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 16:18:25 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 16:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:18:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:18:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:18:29 INFO - Installing collected packages: psutil 16:18:29 INFO - Running setup.py install for psutil 16:18:29 INFO - building 'psutil._psutil_osx' extension 16:18:29 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 16:18:29 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 16:18:29 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 16:18:30 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 16:18:30 INFO - building 'psutil._psutil_posix' extension 16:18:30 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 16:18:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:18:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:18:30 INFO - ^ 16:18:30 INFO - 1 warning generated. 16:18:30 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 16:18:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:18:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:18:30 INFO - Successfully installed psutil 16:18:30 INFO - Cleaning up... 16:18:30 INFO - Return code: 0 16:18:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:18: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')]} 16:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18: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')]} 16:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:30 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 0x104199490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10410f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828adceb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fadd30>, '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 0x103dd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fa5b20>, '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.zzCVye8LLu/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.IOLaueycMX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 16:18:30 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 16:18:30 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 16:18:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zzCVye8LLu/Render', 16:18:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:30 INFO - 'HOME': '/Users/cltbld', 16:18:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:30 INFO - 'LOGNAME': 'cltbld', 16:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:30 INFO - 'MOZ_NO_REMOTE': '1', 16:18:30 INFO - 'NO_EM_RESTART': '1', 16:18:30 INFO - 'PAGER': '/bin/cat', 16:18:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:30 INFO - 'PWD': '/builds/slave/test', 16:18:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:30 INFO - 'SHELL': '/bin/bash', 16:18:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IOLaueycMX/Listeners', 16:18:30 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:18:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:30 INFO - 'USER': 'cltbld', 16:18:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:30 INFO - 'XPC_FLAGS': '0x0', 16:18:30 INFO - 'XPC_SERVICE_NAME': '0', 16:18:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:18:30 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 16:18:30 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 16:18:30 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 16:18:30 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 16:18:30 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 16:18:30 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 16:18:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:18:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:18:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:18:33 INFO - Installing collected packages: mozsystemmonitor 16:18:33 INFO - Running setup.py install for mozsystemmonitor 16:18:33 INFO - Successfully installed mozsystemmonitor 16:18:33 INFO - Cleaning up... 16:18:33 INFO - Return code: 0 16:18:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:18:33 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')]} 16:18:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:33 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')]} 16:18:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:33 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 0x104199490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10410f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828adceb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fadd30>, '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 0x103dd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fa5b20>, '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.zzCVye8LLu/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.IOLaueycMX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 16:18:33 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 16:18:33 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 16:18:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zzCVye8LLu/Render', 16:18:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:33 INFO - 'HOME': '/Users/cltbld', 16:18:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:33 INFO - 'LOGNAME': 'cltbld', 16:18:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:33 INFO - 'MOZ_NO_REMOTE': '1', 16:18:33 INFO - 'NO_EM_RESTART': '1', 16:18:33 INFO - 'PAGER': '/bin/cat', 16:18:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:33 INFO - 'PWD': '/builds/slave/test', 16:18:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:33 INFO - 'SHELL': '/bin/bash', 16:18:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IOLaueycMX/Listeners', 16:18:33 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:18:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:33 INFO - 'USER': 'cltbld', 16:18:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:33 INFO - 'XPC_FLAGS': '0x0', 16:18:33 INFO - 'XPC_SERVICE_NAME': '0', 16:18:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:33 INFO - Downloading/unpacking jsonschema==2.5.1 16:18:33 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 16:18:33 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 16:18:33 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 16:18:33 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 16:18:33 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 16:18:33 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 16:18:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:18:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:36 INFO - Downloading functools32-3.2.3-2.tar.gz 16:18:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:18:36 INFO - warning: no files found matching '*.txt' 16:18:36 INFO - no previously-included directories found matching 'build' 16:18:36 INFO - no previously-included directories found matching 'dist' 16:18:36 INFO - no previously-included directories found matching '.git*' 16:18:36 INFO - Installing collected packages: jsonschema, functools32 16:18:37 INFO - Running setup.py install for functools32 16:18:37 INFO - warning: no files found matching '*.txt' 16:18:37 INFO - no previously-included directories found matching 'build' 16:18:37 INFO - no previously-included directories found matching 'dist' 16:18:37 INFO - no previously-included directories found matching '.git*' 16:18:37 INFO - Successfully installed jsonschema functools32 16:18:37 INFO - Cleaning up... 16:18:37 INFO - Return code: 0 16:18:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:18:37 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')]} 16:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:37 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')]} 16:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:37 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 0x104199490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10410f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828adceb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fadd30>, '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 0x103dd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fa5b20>, '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.zzCVye8LLu/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.IOLaueycMX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 16:18:37 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 16:18:37 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 16:18:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zzCVye8LLu/Render', 16:18:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:37 INFO - 'HOME': '/Users/cltbld', 16:18:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:37 INFO - 'LOGNAME': 'cltbld', 16:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:37 INFO - 'MOZ_NO_REMOTE': '1', 16:18:37 INFO - 'NO_EM_RESTART': '1', 16:18:37 INFO - 'PAGER': '/bin/cat', 16:18:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:37 INFO - 'PWD': '/builds/slave/test', 16:18:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:37 INFO - 'SHELL': '/bin/bash', 16:18:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IOLaueycMX/Listeners', 16:18:37 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:18:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:37 INFO - 'USER': 'cltbld', 16:18:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:37 INFO - 'XPC_FLAGS': '0x0', 16:18:37 INFO - 'XPC_SERVICE_NAME': '0', 16:18:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:18:37 INFO - Cleaning up... 16:18:37 INFO - Return code: 0 16:18:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:18:37 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')]} 16:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:37 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')]} 16:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:37 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 0x104199490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10410f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828adceb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fadd30>, '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 0x103dd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fa5b20>, '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.zzCVye8LLu/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.IOLaueycMX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 16:18:37 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 16:18:37 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 16:18:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zzCVye8LLu/Render', 16:18:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:37 INFO - 'HOME': '/Users/cltbld', 16:18:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:37 INFO - 'LOGNAME': 'cltbld', 16:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:37 INFO - 'MOZ_NO_REMOTE': '1', 16:18:37 INFO - 'NO_EM_RESTART': '1', 16:18:37 INFO - 'PAGER': '/bin/cat', 16:18:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:37 INFO - 'PWD': '/builds/slave/test', 16:18:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:37 INFO - 'SHELL': '/bin/bash', 16:18:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IOLaueycMX/Listeners', 16:18:37 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:18:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:37 INFO - 'USER': 'cltbld', 16:18:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:37 INFO - 'XPC_FLAGS': '0x0', 16:18:37 INFO - 'XPC_SERVICE_NAME': '0', 16:18:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:37 INFO - Downloading/unpacking blobuploader==1.2.4 16:18:37 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 16:18:37 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 16:18:37 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 16:18:37 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 16:18:37 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 16:18:37 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 16:18:40 INFO - Downloading blobuploader-1.2.4.tar.gz 16:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:18:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:18: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 16:18: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 16:18: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 16:18: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 16:18: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 16:18: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 16:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:18:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:18:41 INFO - Downloading docopt-0.6.1.tar.gz 16:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:18:41 INFO - Installing collected packages: blobuploader, requests, docopt 16:18:41 INFO - Running setup.py install for blobuploader 16:18:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:18:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:18:41 INFO - Running setup.py install for requests 16:18:42 INFO - Running setup.py install for docopt 16:18:42 INFO - Successfully installed blobuploader requests docopt 16:18:42 INFO - Cleaning up... 16:18:42 INFO - Return code: 0 16:18:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:18: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')]} 16:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18: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')]} 16:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:42 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 0x104199490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10410f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828adceb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fadd30>, '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 0x103dd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fa5b20>, '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.zzCVye8LLu/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.IOLaueycMX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 16:18:42 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 16:18:42 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 16:18:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zzCVye8LLu/Render', 16:18:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:42 INFO - 'HOME': '/Users/cltbld', 16:18:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:42 INFO - 'LOGNAME': 'cltbld', 16:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:42 INFO - 'MOZ_NO_REMOTE': '1', 16:18:42 INFO - 'NO_EM_RESTART': '1', 16:18:42 INFO - 'PAGER': '/bin/cat', 16:18:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:42 INFO - 'PWD': '/builds/slave/test', 16:18:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:42 INFO - 'SHELL': '/bin/bash', 16:18:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IOLaueycMX/Listeners', 16:18:42 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:18:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:42 INFO - 'USER': 'cltbld', 16:18:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:42 INFO - 'XPC_FLAGS': '0x0', 16:18:42 INFO - 'XPC_SERVICE_NAME': '0', 16:18:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:18:42 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-EqbkYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:18:42 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-DhR8UU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:18:43 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-VqRhjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:18:43 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-I1MDDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:18:43 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-rHif0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:18:43 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-YE5QKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:18:43 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-s4sY8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:18:43 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-992_GB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:18:43 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-9SiA31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:18:43 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-99uI6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:18:43 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-fSW4cW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:18:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-LBIJk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:18:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Cp6WTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:18:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ZparZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-RiVruO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:18:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-qL3m_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:18:44 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-8JRv7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:18:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:18:44 INFO - Running setup.py install for manifestparser 16:18:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:18:44 INFO - Running setup.py install for mozcrash 16:18:44 INFO - Running setup.py install for mozdebug 16:18:45 INFO - Running setup.py install for mozdevice 16:18:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:18:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:18:45 INFO - Running setup.py install for mozfile 16:18:45 INFO - Running setup.py install for mozhttpd 16:18:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:18:45 INFO - Running setup.py install for mozinfo 16:18:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:18:45 INFO - Running setup.py install for mozInstall 16:18:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:18:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:18:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:18:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:18:45 INFO - Running setup.py install for mozleak 16:18:45 INFO - Running setup.py install for mozlog 16:18:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:18:46 INFO - Running setup.py install for moznetwork 16:18:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:18:46 INFO - Running setup.py install for mozprocess 16:18:46 INFO - Running setup.py install for mozprofile 16:18:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:18:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:18:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:18:46 INFO - Running setup.py install for mozrunner 16:18:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:18:46 INFO - Running setup.py install for mozscreenshot 16:18:46 INFO - Running setup.py install for moztest 16:18:47 INFO - Running setup.py install for mozversion 16:18:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:18:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:18:47 INFO - Cleaning up... 16:18:47 INFO - Return code: 0 16:18:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:18:47 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')]} 16:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:47 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')]} 16:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:47 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 0x104199490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10410f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828adceb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fadd30>, '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 0x103dd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fa5b20>, '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.zzCVye8LLu/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.IOLaueycMX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 16:18:47 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 16:18:47 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 16:18:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zzCVye8LLu/Render', 16:18:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:47 INFO - 'HOME': '/Users/cltbld', 16:18:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:47 INFO - 'LOGNAME': 'cltbld', 16:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:47 INFO - 'MOZ_NO_REMOTE': '1', 16:18:47 INFO - 'NO_EM_RESTART': '1', 16:18:47 INFO - 'PAGER': '/bin/cat', 16:18:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:47 INFO - 'PWD': '/builds/slave/test', 16:18:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:47 INFO - 'SHELL': '/bin/bash', 16:18:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IOLaueycMX/Listeners', 16:18:47 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:18:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:47 INFO - 'USER': 'cltbld', 16:18:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:47 INFO - 'XPC_FLAGS': '0x0', 16:18:47 INFO - 'XPC_SERVICE_NAME': '0', 16:18:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:18:47 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ORdlQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:18:47 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)) 16:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:18:47 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Gh0LP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:18:47 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)) 16:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:18:47 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-xM4QnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:18:47 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)) 16:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:18:47 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-8EKpRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:18:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:18:47 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-A1fdLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:18:48 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-U7X_2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:18:48 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-yWrjQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:18:48 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-N0OXpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:18:48 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-PFPOAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:18:48 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-1NaX4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:18:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:18:48 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-taMLdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:18:48 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-SiVyAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:18:48 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-L24zYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:18:48 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)) 16:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:18:48 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-y_adGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:18:49 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)) 16:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-filQ1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:18:49 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)) 16:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:18:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-V0z9Vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:18:49 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)) 16:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:18:49 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-OyEgZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:18:49 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)) 16:18:49 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)) 16:18:49 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)) 16:18:49 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)) 16:18:49 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)) 16:18:49 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)) 16:18:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:18:49 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 16:18:49 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 16:18:49 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 16:18:49 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 16:18:49 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 16:18:49 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 16:18:51 INFO - Downloading blessings-1.6.tar.gz 16:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:18:51 INFO - Installing collected packages: blessings 16:18:51 INFO - Running setup.py install for blessings 16:18:52 INFO - Successfully installed blessings 16:18:52 INFO - Cleaning up... 16:18:52 INFO - Return code: 0 16:18:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:18:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:18:52 INFO - Reading from file tmpfile_stdout 16:18:52 INFO - Current package versions: 16:18:52 INFO - blessings == 1.6 16:18:52 INFO - blobuploader == 1.2.4 16:18:52 INFO - docopt == 0.6.1 16:18:52 INFO - functools32 == 3.2.3-2 16:18:52 INFO - jsonschema == 2.5.1 16:18:52 INFO - manifestparser == 1.1 16:18:52 INFO - mozInstall == 1.12 16:18:52 INFO - mozcrash == 0.17 16:18:52 INFO - mozdebug == 0.1 16:18:52 INFO - mozdevice == 0.48 16:18:52 INFO - mozfile == 1.2 16:18:52 INFO - mozhttpd == 0.7 16:18:52 INFO - mozinfo == 0.9 16:18:52 INFO - mozleak == 0.1 16:18:52 INFO - mozlog == 3.4 16:18:52 INFO - moznetwork == 0.27 16:18:52 INFO - mozprocess == 0.23 16:18:52 INFO - mozprofile == 0.28 16:18:52 INFO - mozrunner == 6.12 16:18:52 INFO - mozscreenshot == 0.1 16:18:52 INFO - mozsystemmonitor == 0.3 16:18:52 INFO - moztest == 0.7 16:18:52 INFO - mozversion == 1.4 16:18:52 INFO - psutil == 3.1.1 16:18:52 INFO - requests == 1.2.3 16:18:52 INFO - wsgiref == 0.1.2 16:18:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:18:52 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')]} 16:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:52 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')]} 16:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:53 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 0x104199490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10410f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828adceb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fadd30>, '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 0x103dd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fa5b20>, '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.zzCVye8LLu/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.IOLaueycMX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 16:18:53 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 16:18:53 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 16:18:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zzCVye8LLu/Render', 16:18:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:53 INFO - 'HOME': '/Users/cltbld', 16:18:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:53 INFO - 'LOGNAME': 'cltbld', 16:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:53 INFO - 'MOZ_NO_REMOTE': '1', 16:18:53 INFO - 'NO_EM_RESTART': '1', 16:18:53 INFO - 'PAGER': '/bin/cat', 16:18:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:53 INFO - 'PWD': '/builds/slave/test', 16:18:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:53 INFO - 'SHELL': '/bin/bash', 16:18:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IOLaueycMX/Listeners', 16:18:53 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:18:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:53 INFO - 'USER': 'cltbld', 16:18:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:53 INFO - 'XPC_FLAGS': '0x0', 16:18:53 INFO - 'XPC_SERVICE_NAME': '0', 16:18:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:53 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)) 16:18:53 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)) 16:18:53 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)) 16:18:53 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)) 16:18:53 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)) 16:18:53 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)) 16:18:53 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)) 16:18:53 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)) 16:18:53 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)) 16:18:53 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)) 16:18:53 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)) 16:18:53 INFO - Cleaning up... 16:18:53 INFO - Return code: 0 16:18:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:18:53 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 0x104199490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10410f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828adceb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fadd30>, '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 0x103dd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fa5b20>, '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.zzCVye8LLu/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.IOLaueycMX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 16:18:53 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 16:18:53 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 16:18:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zzCVye8LLu/Render', 16:18:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:18:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:18:53 INFO - 'HOME': '/Users/cltbld', 16:18:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:18:53 INFO - 'LOGNAME': 'cltbld', 16:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:18:53 INFO - 'MOZ_NO_REMOTE': '1', 16:18:53 INFO - 'NO_EM_RESTART': '1', 16:18:53 INFO - 'PAGER': '/bin/cat', 16:18:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:18:53 INFO - 'PWD': '/builds/slave/test', 16:18:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:18:53 INFO - 'SHELL': '/bin/bash', 16:18:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IOLaueycMX/Listeners', 16:18:53 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:18:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:18:53 INFO - 'USER': 'cltbld', 16:18:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:18:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:18:53 INFO - 'XPC_FLAGS': '0x0', 16:18:53 INFO - 'XPC_SERVICE_NAME': '0', 16:18:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:18:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:18:54 INFO - Cleaning up... 16:18:54 INFO - Return code: 0 16:18:54 INFO - Running post-action listener: _resource_record_post_action 16:18:54 INFO - Running post-action listener: _start_resource_monitoring 16:18:54 INFO - Starting resource monitoring. 16:18:54 INFO - [mozharness: 2016-11-08 00:18:54.117586Z] Finished create-virtualenv step (success) 16:18:54 INFO - [mozharness: 2016-11-08 00:18:54.118545Z] Running install step. 16:18:54 INFO - Running pre-action listener: _resource_record_pre_action 16:18:54 INFO - Running main action method: install 16:18:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:18:54 INFO - Reading from file tmpfile_stdout 16:18:54 INFO - Detecting whether we're running mozinstall >=1.0... 16:18:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:18:54 INFO - Reading from file tmpfile_stdout 16:18:54 INFO - Output received: 16:18:54 INFO - Usage: mozinstall [options] installer 16:18:54 INFO - Options: 16:18:54 INFO - -h, --help show this help message and exit 16:18:54 INFO - -d DEST, --destination=DEST 16:18:54 INFO - Directory to install application into. [default: 16:18:54 INFO - "/builds/slave/test"] 16:18:54 INFO - --app=APP Application being installed. [default: firefox] 16:18:54 INFO - mkdir: /builds/slave/test/build/application 16:18:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:19:28 INFO - Reading from file tmpfile_stdout 16:19:28 INFO - Output received: 16:19:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:19:28 INFO - Running post-action listener: _resource_record_post_action 16:19:28 INFO - [mozharness: 2016-11-08 00:19:28.590575Z] Finished install step (success) 16:19:28 INFO - [mozharness: 2016-11-08 00:19:28.590743Z] Running run-tests step. 16:19:28 INFO - Running pre-action listener: _resource_record_pre_action 16:19:28 INFO - Running main action method: run_tests 16:19:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:19:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:19:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:19:28 INFO - 2016-11-07 16:19:28.605 screenresolution[1633:7455] starting screenresolution argv=screenresolution get 16:19:28 INFO - 2016-11-07 16:19:28.608 screenresolution[1633:7455] Display 0: 1600x1200x32@60 16:19:28 INFO - 2016-11-07 16:19:28.614 screenresolution[1634:7457] starting screenresolution argv=screenresolution list 16:19:28 INFO - Available Modes on Display 0 16:19:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:19:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:19:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:19:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:19:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:19:28 INFO - Intel Iris: 16:19:28 INFO - Chipset Model: Intel Iris 16:19:28 INFO - Type: GPU 16:19:28 INFO - Bus: Built-In 16:19:28 INFO - VRAM (Dynamic, Max): 1536 MB 16:19:28 INFO - Vendor: Intel (0x8086) 16:19:28 INFO - Device ID: 0x0a2e 16:19:28 INFO - Revision ID: 0x0009 16:19:28 INFO - Displays: 16:19:28 INFO - Display: 16:19:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:19:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:19:28 INFO - Display Serial Number: 1600x1200 60 16:19:28 INFO - Main Display: Yes 16:19:28 INFO - Mirror: Off 16:19:28 INFO - Online: Yes 16:19:28 INFO - Rotation: Supported 16:19:28 INFO - Return code: 0 16:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:19:28 INFO - Python 2.7.3 16:19:28 INFO - Return code: 0 16:19:28 INFO - grabbing minidump binary from tooltool 16:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:28 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 0x103fadd30>, '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 0x103dd3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103fa5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:19:28 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 16:19:28 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 16:19:28 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 16:19:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:19:28 INFO - Return code: 0 16:19:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:19:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:19:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:19:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:19:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--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 16:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0072 --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 16:19:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zzCVye8LLu/Render', 16:19:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:19:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:19:28 INFO - 'HOME': '/Users/cltbld', 16:19:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:19:28 INFO - 'LOGNAME': 'cltbld', 16:19:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:19:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:28 INFO - 'MOZ_NO_REMOTE': '1', 16:19:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:19:28 INFO - 'NO_EM_RESTART': '1', 16:19:28 INFO - 'PAGER': '/bin/cat', 16:19:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:28 INFO - 'PWD': '/builds/slave/test', 16:19:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:19:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:19:28 INFO - 'SHELL': '/bin/bash', 16:19:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IOLaueycMX/Listeners', 16:19:28 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 16:19:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:19:28 INFO - 'USER': 'cltbld', 16:19:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:19:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:28 INFO - 'XPC_FLAGS': '0x0', 16:19:28 INFO - 'XPC_SERVICE_NAME': '0', 16:19:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:19:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--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 16:19:29 INFO - mozversion application_buildid: 20161107140320 16:19:29 INFO - mozversion application_changeset: 86f702229e32c6119d092e86431afee576f033a1 16:19:29 INFO - mozversion application_display_name: Nightly 16:19:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:19:29 INFO - mozversion application_name: Firefox 16:19:29 INFO - mozversion application_remotingname: firefox 16:19:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:19:29 INFO - mozversion application_vendor: Mozilla 16:19:29 INFO - mozversion application_version: 52.0a1 16:19:29 INFO - mozversion platform_buildid: 20161107140320 16:19:29 INFO - mozversion platform_changeset: 86f702229e32c6119d092e86431afee576f033a1 16:19:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:19:29 INFO - mozversion platform_version: 52.0a1 16:19:29 INFO - using testdate: 1478564369 16:19:29 INFO - actual date: 1478564369 16:19:29 INFO - starting webserver on 'localhost:49268' 16:19:29 INFO - SUITE-START | Running 2 tests 16:19:29 INFO - TEST-START | dromaeo_css 16:19:29 INFO - operating with platform_type : mac_ 16:19:29 INFO - Initialising browser for dromaeo_css test... 16:19:29 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpIo5QLz/profile http://localhost:49268/getInfo.html) 16:19:31 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 16:19:31 INFO - PROCESS | 1644 | colorDepth:24 16:19:31 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 16:19:31 INFO - PROCESS | 1644 | __metrics 16:19:32 INFO - PROCESS | 1644 | 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" 16:19:32 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:19:32 INFO - TEST-INFO | 1644: exit 0 16:19:32 INFO - Browser initialized. 16:19:32 INFO - Running cycle 1/1 for dromaeo_css test... 16:19:32 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpIo5QLz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:19:45 INFO - PROCESS | 1646 | RSS: Main: 231452672 16:19:45 INFO - PROCESS | 1646 | 16:20:36 INFO - PROCESS | 1646 | 1478564436644 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] 16:22:47 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 16:22:51 INFO - PROCESS | 1646 | RSS: Main: 499593216 16:22:51 INFO - PROCESS | 1646 | 16:25:54 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 16:25:55 INFO - PROCESS | 1646 | RSS: Main: 373043200 16:25:55 INFO - PROCESS | 1646 | 16:28:57 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 16:28:58 INFO - PROCESS | 1646 | RSS: Main: 349011968 16:28:58 INFO - PROCESS | 1646 | 16:32:00 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 16:32:01 INFO - PROCESS | 1646 | RSS: Main: 348291072 16:32:01 INFO - PROCESS | 1646 | 16:35:04 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 16:35:05 INFO - PROCESS | 1646 | RSS: Main: 345534464 16:35:05 INFO - PROCESS | 1646 | 16:38:08 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 16:38:09 INFO - PROCESS | 1646 | RSS: Main: 520974336 16:38:09 INFO - PROCESS | 1646 | 16:38:09 INFO - PROCESS | 1646 | __start_tp_report 16:38:09 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 16:38:09 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 16:38:09 INFO - PROCESS | 1646 | |i|pagename|runs| 16:38:09 INFO - PROCESS | 1646 | |0;dojo.html;3197.944678256176;3278.7540934429926;3291.3417316536693;3325.5177999190105;3326.3679900818843;5511.255980442639;5557.749901254443;5608.495235428821;5666.518345940595;5675.687837168959;5590.804321848736;5605.103183490643;5681.091025435931;5693.459121383472;5705.857353566153;5062.721550314731;5074.517920797518;5079.23811428285;5079.466656001122;5145.202493613496;5199.376074871021;5243.187305967562;5256.999999999981;5257.763400646961;5287.68273903567;5062.594992400599;5208.2968799212;5221.686698798047;5230.816921407752;5318.016167009116;5120.462351453119;5157.6647517911215;5167.7932882684645;5180.300659410969;5187.896242075138;5071.974640126813;5122.590192784568;5133.153029750124;5143.228515722634;5154.433012368637;5586.162075688639;5589.692566908819;5592.468715472024;5595.692236926968;5603.355614104389;6054.96972515139;6105.133478386146;6106.97642067191;6120.111926550715;6125.509959203253;6161.691915404212;6166.81499555014;6212.068189771525;6214.25428948529;6233.2208473940755;5720.48515633595;5748.425157484302;5755.740991655385;5765.135229715576;5770.682612456313;6117.401149625483;6178.258608966863;6187.84530386735;6195.504359651217;6203.534734894901;5970.701464926737;5981.551383646244;6089.995150800157;6104.4200800923845;6121.70690522557;6191.102290167901;6192.256929168529;6193.566450348522;6195.101710251988;6196.442320191204;6069.878602427927;6138.324784273726;6144.201253837062;6144.324124346318;6168;5972.910406343908;6029.969850150809;6043.7280322385595;6056.303525094582;6113.877722445526;4800.087983283165;4890.657653964188;4917.58200552957;4924.236743304794;4927.43334516528;4368.388425620416;4392.253316936129;4398.406215160976;4418.513963464016;4434.135343607965;5701.914471282934;5720.942790572124;5755.913661295084;5758.654480731169;5770.221020162225;6103.450689437972;6128.197586012551;6134.559047376611;6150.969245153835;6230.56386052981;5721.885562288814;5757.453041961007;5762.481376676035;5788.247527821356;5827;5373.516383525502;5373.946260537423;5376.112941364631;5376.166694162411;5377.919331210035;6155.72299246535;6169.84575385619;6256.217972753406;6278.466330361788;6305.432511074026;6150.630962142286;6160.322364539987;6176.227971503562;6194.101855231056;6275.184226050585;6280.9685951569945;6285.340039295991;6296.338884417253;6296.716647750771;6298.716557755004;6079.939200607937;6082.2701275847185;6085.361037091218;6110.633361998294;6154.815355539341;6035.969820150871;6104.962156433506;6118.694065296806;6130.0006981778415;6134.7427470591965;5977;5993.790217342372;5996.280446346466;6008.188894499187;6014.0678194879865;4933.925991110208;5968.253968253968;5975.671338076448;5984.670843103671;5987.31145918225;5664.603477756517;5847.532197424111;5851.122331650116;5861.032929566573;5866.090755932837;5940.376260492586;5970.850728731816;5971.313298970674;5972.790952316648;5975.820725378246;4813.855584332336;5802.506786923159;5803.39064398249;5804.6807425592;5813.738381772915 16:38:09 INFO - PROCESS | 1646 | |1;ext.html;459.80228501744244;460.25898303730986;496.24075164997555;521.8225803226902;534.3427584071592;29363.825446982122;31232.84383578082;39564.406533902016;39590.406143907865;40989.795051024776;35962.2807543849;36862.63137368632;40151.79544613659;40548.98627534306;40626;8233.711820086299;9053.50205738684;9219.170274675278;9235.030321816213;9236.67671631493;7093.89359159613;8413;8420.621072051772;8451.95774021129;10920.781584368307;10900.836487452694;11030.834537481904;11083.778324433506;11095.83356249657;11165.995060444558;9413.435193888321;10984.395858227794;11076.778464430747;11081.556737730481;11103.278286911325;8238.670453181865;8476.66093356265;10667.786644267071;10868.347899125998;10960;37143;39032.07259455524;39099.218015639526;39187.412188817194;39650.0087497812;3269.623993240784;3398.5921689397182;3783.5838057813617;3864.8592200662333;3931.9017024574327;28482.430351392857;29491.67287472069;29963.250918727208;30017.099487015425;30045;2973.3012742005612;3141.701538353853;3240.4815229563155;3271.2312606537444;3313.801171929692;464904;466152;469846.650766744;471085;472044.63977680233;54623.45376546263;54918.62703432446;55001.72499137479;55045.44954550483;55118.62203444946;61708;61746.9126543671;61904;61924.38075619186;61969.690151549854;15495.767563486557;15708.293126809092;15743.055416675035;15749.212539372986;15785.921070394805;12098.213616114925;12138;12165.087618428654;12166.81749773754;12188.634340969786;15482.458113965957;15835.970661906938;17477.321583074136;18102;19436.22255109808;7927.484713493604;8011.799705007422;8041.155678653774;8075.183083806097;8122.350211983027;836.7908022994252;922.689780511675;933.8879334479906;1004.1966426858484;1067.9038886500252;27617.861910690317;28642.570361444596;28749.28126796847;29309.26726831846;29517;989.4904124375952;1005.1556692378438;1007.2294694558668;1059.2003037706481;1059.6291298045621;11794.623155853395;13172.080579791094;14716.705665886622;14969.727573156404;15145.697086058217;575912;634185.6325747011;636992;637280;638096;55296.17055744167;55682;55768.721156393956;55775.442245577025;55845;1250.9186902851286;1287.0604458745167;1315.302889468583;1365.0785719639205;1365.6449323176244;27984.58023129614;28040;28043.859780700965;28668.99658511942;28804.71195288104;47749.76125119352;48012.27981580209;48177.75911120422;48265.517344826105;48273.75863120662;581047;585052;585098;585526;585900;33083.50374744333;33220.833895830365;33793.49309760307;38507;39311.87225341298;41679.58320416757;41855.37216941687;42538.36192457178;43084.56915430931;43381.78309108434;35779;36017.459738103425;36130.27739445249;36648;36676.81661591675;35442.291154177285;36232.818835906706;36413.13224805366;36700.44949325816;36747.816260918524;34713.82643086869;34846.65153348434;35538.82230588831;35600;36064;25909.740902591486;30096.548551771302;31621.20946976344;31904.521432178073;32192.49305097335;17621.823781762017;20124.79875201229;23720.644190336814;24335;24447.51104977926 16:38:09 INFO - PROCESS | 1646 | |2;jquery.html;343.0737010072804;355.3727670661283;366.7542746359937;371.6933529837884;396.20956192396176;14620.049696769702;14867.03364281321;15716.449924252667;19477.026148692545;20241.797582024174;19096.045197740128;19806.41548676106;19908;19988.800111998877;20170.59658806823;5596.4123767004385;5948.851278718045;5950.821475355746;5963.642181469104;5966.284045914496;4971.925421118686;5377.8117765878205;5828.737706803204;5885.7939972100985;5912.7930522431725;5573.888522229553;5809.477147056764;5850.063989761639;5850.73671684773;5851.7074146292725;5700.401457846929;5836.153757705109;5839.270091238595;5842.152887831241;5844.736986835603;4860.441049279308;5054.646174767768;5113.872153196163;5116.130257856174;5119.56483698886;25156.874215628988;25294.620580691306;25321.87339063293;25534.233972980655;25712.614310785353;2071.492484341331;2176.673498975151;2192.440927563477;2949.292169879235;3028.3489049854165;9600.711978640651;9735.65925192622;10012.29913906027;10189.858683322798;10341.896581034243;1630.991845040779;1636.3372834002248;1650.3316156956453;1740.677974574695;1764.5235786337616;116410.41794790972;124998.12502812465;129954;130296;130318.40701505366;10735.194860385502;10749.78500429987;11377.772444551063;11383.601573944872;11652.30086194814;14087.71824563503;14098.083624564575;14102.576922692335;14108.012439129163;14114.435422583187;7696.692132314756;7980.680772769024;8200.835983280302;8283.58582070894;8423.452475589067;8113.310368618733;8139.796505087302;8151.714689985822;8297.045839728387;8347.958260208781;3633.8364773585254;4424;4428.3800267962515;4434.84478043267;4522.3442600823355;1536.6312085099719;1675.4387280261005;1856.5822689894665;1905.2188602673116;1945.1344151852572;678.2877978122951;772.7218201447474;912.8721978922956;934.9158575728217;1015.5937624950079;20033.899830500755;20597;20641.277555285793;20642.58714825725;20663;899.7660608241904;919.6965001549472;922.5156792683895;936.2369668719972;951.7715748220377;10047.458164488635;10660.20048496366;10915.126789856951;10915.580725246165;10950.780984380268;559269;571592;571664;580785;587131;133446.33276833553;134378;134578.32710836382;136867.31566342103;137435;951.8905325887473;962.7159987803615;993.0852946601747;994.9403035817729;995.26326560153;17708.91145544264;18679.90660046691;19380.8061919379;19391.806081939;19672.90163549173;51725;53249.733751331;55508.72245638746;56501;58035.2589422318;57869.710651446476;78799;79057;85302;87943.12056879605;6632.336766323329;6934.757283495053;7222.205557388788;7248.420126389981;8141;10724.785504290026;11312.547498099984;12558.183718058297;12845.100842941278;13020.958323333922;10709.678709638723;10741.516631751434;11087.501062452371;11140.387278699749;11191.496382662963;10463.319884207502;10606.681799546026;10820.837687434852;11066.557337706723;11273.661790146309;11070.059044980944;11130.888691112985;11245.044171245536;11262.605808796652;11610.593629222936;7230.385417239593;7296.489245752959;7316.707331706672;7341.816454588678;7409.073865766779;8071.838563228585;9219.86170207434;9635.614575417185;11069.948354906272;11173.273737207055 16:38:09 INFO - PROCESS | 1646 | |3;mootools.html;1359.320339830085;1451.1945870042125;1598.8161361443438;1754.350890170637;1828.1590468384543;7845.92154078459;8231.176882311765;8275.66897324107;8322.791930201747;8339.29116025137;7356.448266380016;7470.3650189733935;7502.737404190854;7598.164201937782;8179;2059.6292667319876;2087.6951905059336;2092.6233278010027;2216.933491995235;2293.036924491709;2313.410080429488;2323.0939933425975;2326.523062772136;2327.7788610082016;2332.615118505453;2245.528439027806;2273.102124660758;2282.669012993115;2287.2337766848127;2294.27730264966;2250.61739504283;2252.4368907773055;2272.227442669484;2273.4089136824377;2281.634938409863;2247.381969958258;2304.2050492580033;2306.308107567723;2312.5028118954506;2315.6989591353185;8145.5927203639585;8148.470349427268;8198.139195384518;8198.508089514648;8222.38332125087;5006.224035274502;5124.308218390507;5125.82059627915;5128.538431541179;5136.383633963911;3149.6692847251165;3308.7022168004996;3354.295597924439;3477.426224672926;3495.388307046282;1006.8842083160457;1049.58541376156;1075.3601607043797;1086.7609125992349;1092.202692034811;10527.315724477961;10701.304415212986;10724.302920310232;10749.086327662159;10812.67561973142;4338.262495375794;4484.354231003724;4578.427696537933;4599.103174880866;4618.7298492914715;9253.398529095588;9260.21288190498;9280.953595232115;9289.72130836076;9335.766605834908;5120.590352771769;5122.667026643257;5130.743462826844;5137.383513978347;5137.614678899097;4602.401687780567;4659.8136074557315;4687.67186296956;4717;4731.668783185213;3476.088151516706;3562.928741425157;3567.7859328440377;3699.574548926908;3791.905202369908;1064.1271362402229;1189.1259923955886;1217.531250468576;1222.7371115210271;1227.2391117507202;780.8477346917297;792.944493885434;818.7093581778383;866.6350448634403;886.3928209176735;5317.216321967599;5403.162509810985;5617.943820561742;5737.254156959569;5745;833.8874251976027;850.7745447456429;853.3301358433599;901.9143181397757;905.7418635688797;3685.7419980601635;3740.5137332146646;3741.6219338518667;3778.0554861284677;3805.257974694963;9524.190443812353;10059.346142500714;10059.849102263472;10109.696709098738;10164.542595583216;10000.249981251436;10009.099181073738;10032.498375081217;10044.347117437343;10058.497075146213;6477.417032467007;7711.575863327459;7761.495502792301;7768.728094516665;7823.804404889924;5159.742012899415;5322.893542129058;5409.729513524387;5463.262459567907;5486.3815174522815;9181.954090229507;9183.908160918305;9210.493422861538;9337.159655630754;9374.765630859283;9277.814443711222;9387.342885997914;9394.013628568902;9412.95293523528;9489.57296921654;6992.860142797217;7025.402840758593;7082.256363081802;7103.538270012433;7111.82220444493;6978.616176110363;7526.209747976383;7674.6162691864065;7726.497777644435;7767.961160194162;6580.407763301326;6639.668016599054;7002.579845209304;7029;7042.929570704227;6796.72813087471;6928.1339832520935;6965.15439276811;6987.930120698931;7045.295470452914;6615.338466153346;6622.867542649216;6683.63240021784;6689.5986240825705;6713.462922966053;4749.620030397629;4802.975985120192;4807.423109226916;4857.53853383928;4925.310456536159;4782.832600858953;4827.541383568555;4834.398259020462;4872.269159626085;4921.212605983025 16:38:09 INFO - PROCESS | 1646 | |4;prototype.html;292.6195945271148;294.8820471811275;303.7949384165688;307.71536328895763;309.4383693596121;3962.177398396741;4475.5076941536445;4700.623950083994;4857.2714092886;5289.1174310001;4361.890952726176;5120.180771076629;5208.505192006763;5269.286317546457;5319.430767923463;3017.411604737066;3958.901027474322;4019.537753158395;4058.6753059755297;4083.5099788025477;3458.170039190589;3580.9641903581023;3751.9437208441896;4084.7140700151003;4088.550259471456;3183.8856400259956;3636.690881275095;4000.799960002003;4023.195360927826;4049.5950404959563;3817.3701339278987;3977.031369472101;3987.601239876018;3994.999999999971;4000.879973600797;3164.3829453256626;3263.526788615661;3489.581250249986;3505.404081306159;3505.509228707983;4853.635977301717;5118.564921981636;5148.9485105149215;5156.355455568054;5182.186234817784;3953.6639385651965;4038.303912356788;4587.3348364486965;4594.563516465931;4601.010782681739;5562.527185189264;5564.4991950724225;5574.470425309589;5581;5611;3556.3598552260582;3771.7925514096714;3810.8475660973527;3827.6029249324074;3831.027021084144;5334.5732341412595;5833.912491312633;5851.005329094064;5859.501942334907;5861.20873682056;3295.538624592559;3537.46937959303;3781.8487260509273;3864.5073927317285;3875.8643447479203;3032.6360836699737;3467;3928.3518219493462;3952.806192563155;3958.802059896994;4545.545405481069;4564.740453475551;4578.733526904204;4584.4498660161;4603.286490593963;5593.412691667398;5612.986714499153;5629.380768115504;5649.265595472562;5650.067738823131;1017.8015287019108;1224.5224362498632;1254.3163975633302;1265.6329664397222;1279.7248591552861;718.9539220434256;766.3983772738374;786.4966421490251;802.924081730484;887.671561522241;4124.680102367273;4443.400140980991;4907.950920490821;4957.553820156203;4978.8755281118265;4589.609883159968;5029.471905449948;5156.891268377317;5175.818846340435;5431.429699881455;4096.959030409717;4123.876283711494;4671.789769460383;4965.255211718271;5028.572571331405;2556.654851595048;2648.9933825146704;2660.561007433752;2692.8788204530842;2802.0805748062644;4761.452717725317;4798.136335459581;5492.038893193675;5577.553795696334;5583.175524765548;4483.825344707814;4914.329128096464;5505.550030236506;5536.501714845684;5560.610757246954;4739.573438390561;4989.60083193351;5250.317458730493;5575.553955683536;5614.831555053355;5029.823956161516;5324.2962252080515;5389.787297857951;5417.918731219113;5421.647592906448;4874.829380971649;5127.512886275797;5263.867998540862;5289.47105289468;5329;4758.952410475851;4940.505949405175;5276.683398996072;5474.069408200695;5604.495595396434;3207.615965156782;3446.3624229516618;3561.038519599642;3612.27754449106;3632.763870348419;4588.655850811269;5086.542211200862;5330.706811125426;5371.435999220182;5387.75755091014;4625.392194088617;4626.745528995937;5206.739663016759;5214.176886380159;5227.503387178212;4329.913401732011;4568.451785785727;4637.420322459692;5162.457941916045;5187.792488300577;4674.252119660838;4674.509176536415;5150.4762666294;5172.353455818023;5396.192275587722;5481.397046324981;5555.527780138734;5562.579013906499;5659.236003139524;5672.801451949327;4906.460289368095;5479;5504.724763761876;5505.201745746925;5506.339239291311 16:38:09 INFO - PROCESS | 1646 | |5;yui.html;668.4151367553391;672.6972862212006;683.53861143728;721.2390927571416;728.19534414472;13573.2534710591;14123.646908827284;14140.646483837922;14141.292935353242;14467;12597.496100156006;12703.047271454654;12715.364231788397;12722.809157862617;12723.681907952307;632.5382470796321;653.6829637625748;792.0930534537979;810.9148539403351;817.5912043978011;813.5647428625687;822.7943014246439;834.2741814621288;835.1815221083342;836.2014276366056;872.8734333521636;874.637025634361;874.995625021874;876.7238319929234;878.0780180810156;670.0819876768809;688.9207741109736;866.874303226035;872.1627237851638;872.1975782280317;619.5198720991223;634.7968650031992;638.0907207229726;642.0433554004546;642.9003504456816;13209;13250.271235082068;13569.98225133119;13582.524611638546;13585.86414135856;11713.414329283502;11794.469248883821;12011.519539218421;12091.334976576285;12330.32183229922;11693.649190524298;11995.940020299842;12160.574379896661;12222.694432639166;12576.245425274512;4359.128174365108;4380.364847097185;4394.143142087294;4572.719638501192;4585.770711464414;87156;88193;88370.67443988346;89652.5517372409;90832;9982;10197.286189966631;10263.692089237335;10547.947260263649;10715.410652414037;19515.121819518157;19796.90101549483;19840.305589304306;19859.106340214727;19890.403287901096;7288.344049035612;7377.741779037708;7479;7515.511491753018;7565.356944659766;3576.3204991051616;4120.196561670506;4197.18154959786;4202.894927626834;4203.306454434984;3253.5445037694267;3299.950500742491;3301.4552598820924;3317.7345812334956;3355.681210285019;615.2033117113259;621.4562258024229;625.6371304643296;636.312782195228;637.8373514753708;564.1481363141686;589.9174115623816;594.7531774313697;600.8047384600022;624.96875156242;8776;8864.512451815212;9107.590158442887;9647.662331818494;9793.90206097944;508.9033083714157;594.5392320951297;614.8739508400768;684.3327755438507;688.6728803818146;4033.435319055276;4372.540883207217;4401;4469.195544801967;4504.932426013547;69359.65320173367;83126;107648;109084.4545777266;112944;95910.52044739731;96126.55810162853;97218.51390743001;97663;99682;53913.92172156535;55516;70145.64927175331;82859.17140828635;85733.57133214294;9091.181793638605;9505.524723763923;9554.56547957213;9562;9629.807403852024;37536.87389378323;50577.49422505875;52527.21209181789;54968.45031549793;55041.72479137579;68914.96627550691;70411.64794175996;72711.27288727257;72774;79384;11593.942030289794;11782.82325765097;11852.466639001093;12380.752384952431;12386.690332741753;13271.469141234242;13329.475789757347;13618.727625447635;13694.38375273135;14248.290205175444;10502.159827213958;12553.811692824798;12725.61823145307;12878.484860605471;13216;12429.875701242872;12537.310447925087;12727;12744.235345879277;13132.540361087698;12194.451249693608;12278;12423;12445.937770311091;12775.251672854954;9867.309288350034;10158.695239142837;10287.897121028695;10311.175105991653;10800.675979720621;9814.509274536387;10565.996230358103;10785.137189025016;11000.669979900616;11180 16:38:09 INFO - PROCESS | 1646 | __end_tp_report 16:38:09 INFO - PROCESS | 1646 | __start_cc_report 16:38:09 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,3521 16:38:09 INFO - PROCESS | 1646 | __end_cc_report 16:38:09 INFO - PROCESS | 1646 | __startTimestamp1478565489127__endTimestamp 16:38:09 INFO - PROCESS | 1646 | 16:38:09 INFO - PROCESS | 1646 | ------- Summary: start ------- 16:38:09 INFO - PROCESS | 1646 | Number of tests: 6 16:38:09 INFO - PROCESS | 1646 | 16:38:09 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5667.82 Median:5847.53 stddev:629.52 (10.8%) stddev-sans-first:600.89 16:38:09 INFO - PROCESS | 1646 | Values: 3197.9 3278.8 3291.3 3325.5 3326.4 5511.3 5557.7 5608.5 5666.5 5675.7 5590.8 5605.1 5681.1 5693.5 5705.9 5062.7 5074.5 5079.2 5079.5 5145.2 5199.4 5243.2 5257.0 5257.8 5287.7 5062.6 5208.3 5221.7 5230.8 5318.0 5120.5 5157.7 5167.8 5180.3 5187.9 5072.0 5122.6 5133.2 5143.2 5154.4 5586.2 5589.7 5592.5 5595.7 5603.4 6055.0 6105.1 6107.0 6120.1 6125.5 6161.7 6166.8 6212.1 6214.3 6233.2 5720.5 5748.4 5755.7 5765.1 5770.7 6117.4 6178.3 6187.8 6195.5 6203.5 5970.7 5981.6 6090.0 6104.4 6121.7 6191.1 6192.3 6193.6 6195.1 6196.4 6069.9 6138.3 6144.2 6144.3 6168.0 5972.9 6030.0 6043.7 6056.3 6113.9 4800.1 4890.7 4917.6 4924.2 4927.4 4368.4 4392.3 4398.4 4418.5 4434.1 5701.9 5720.9 5755.9 5758.7 5770.2 6103.5 6128.2 6134.6 6151.0 6230.6 5721.9 5757.5 5762.5 5788.2 5827.0 5373.5 5373.9 5376.1 5376.2 5377.9 6155.7 6169.8 6256.2 6278.5 6305.4 6150.6 6160.3 6176.2 6194.1 6275.2 6281.0 6285.3 6296.3 6296.7 6298.7 6079.9 6082.3 6085.4 6110.6 6154.8 6036.0 6105.0 6118.7 6130.0 6134.7 5977.0 5993.8 5996.3 6008.2 6014.1 4933.9 5968.3 5975.7 5984.7 5987.3 5664.6 5847.5 5851.1 5861.0 5866.1 5940.4 5970.9 5971.3 5972.8 5975.8 4813.9 5802.5 5803.4 5804.7 5813.7 16:38:09 INFO - PROCESS | 1646 | 16:38:09 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:68452.23 Median:36181.55 stddev:150634.65 (416.3%) stddev-sans-first:150970.72 16:38:09 INFO - PROCESS | 1646 | Values: 459.8 460.3 496.2 521.8 534.3 29363.8 31232.8 39564.4 39590.4 40989.8 35962.3 36862.6 40151.8 40549.0 40626.0 8233.7 9053.5 9219.2 9235.0 9236.7 7093.9 8413.0 8420.6 8452.0 10920.8 10900.8 11030.8 11083.8 11095.8 11166.0 9413.4 10984.4 11076.8 11081.6 11103.3 8238.7 8476.7 10667.8 10868.3 10960.0 37143.0 39032.1 39099.2 39187.4 39650.0 3269.6 3398.6 3783.6 3864.9 3931.9 28482.4 29491.7 29963.3 30017.1 30045.0 2973.3 3141.7 3240.5 3271.2 3313.8 464904.0 466152.0 469846.7 471085.0 472044.6 54623.5 54918.6 55001.7 55045.4 55118.6 61708.0 61746.9 61904.0 61924.4 61969.7 15495.8 15708.3 15743.1 15749.2 15785.9 12098.2 12138.0 12165.1 12166.8 12188.6 15482.5 15836.0 17477.3 18102.0 19436.2 7927.5 8011.8 8041.2 8075.2 8122.4 836.8 922.7 933.9 1004.2 1067.9 27617.9 28642.6 28749.3 29309.3 29517.0 989.5 1005.2 1007.2 1059.2 1059.6 11794.6 13172.1 14716.7 14969.7 15145.7 575912.0 634185.6 636992.0 637280.0 638096.0 55296.2 55682.0 55768.7 55775.4 55845.0 1250.9 1287.1 1315.3 1365.1 1365.6 27984.6 28040.0 28043.9 28669.0 28804.7 47749.8 48012.3 48177.8 48265.5 48273.8 581047.0 585052.0 585098.0 585526.0 585900.0 33083.5 33220.8 33793.5 38507.0 39311.9 41679.6 41855.4 42538.4 43084.6 43381.8 35779.0 36017.5 36130.3 36648.0 36676.8 35442.3 36232.8 36413.1 36700.4 36747.8 34713.8 34846.7 35538.8 35600.0 36064.0 25909.7 30096.5 31621.2 31904.5 32192.5 17621.8 20124.8 23720.6 24335.0 24447.5 16:38:09 INFO - PROCESS | 1646 | 16:38:09 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:34545.69 Median:1685.71 stddev:96577.73 (5729.2%) stddev-sans-first:96814.51 16:38:09 INFO - PROCESS | 1646 | Values: 343.1 355.4 366.8 371.7 396.2 14620.0 14867.0 15716.4 19477.0 20241.8 19096.0 19806.4 19908.0 19988.8 20170.6 5596.4 5948.9 5950.8 5963.6 5966.3 4971.9 5377.8 5828.7 5885.8 5912.8 5573.9 5809.5 5850.1 5850.7 5851.7 5700.4 5836.2 5839.3 5842.2 5844.7 4860.4 5054.6 5113.9 5116.1 5119.6 25156.9 25294.6 25321.9 25534.2 25712.6 2071.5 2176.7 2192.4 2949.3 3028.3 9600.7 9735.7 10012.3 10189.9 10341.9 1631.0 1636.3 1650.3 1740.7 1764.5 116410.4 124998.1 129954.0 130296.0 130318.4 10735.2 10749.8 11377.8 11383.6 11652.3 14087.7 14098.1 14102.6 14108.0 14114.4 7696.7 7980.7 8200.8 8283.6 8423.5 8113.3 8139.8 8151.7 8297.0 8348.0 3633.8 4424.0 4428.4 4434.8 4522.3 1536.6 1675.4 1856.6 1905.2 1945.1 678.3 772.7 912.9 934.9 1015.6 20033.9 20597.0 20641.3 20642.6 20663.0 899.8 919.7 922.5 936.2 951.8 10047.5 10660.2 10915.1 10915.6 10950.8 559269.0 571592.0 571664.0 580785.0 587131.0 133446.3 134378.0 134578.3 136867.3 137435.0 951.9 962.7 993.1 994.9 995.3 17708.9 18679.9 19380.8 19391.8 19672.9 51725.0 53249.7 55508.7 56501.0 58035.3 57869.7 78799.0 79057.0 85302.0 87943.1 6632.3 6934.8 7222.2 7248.4 8141.0 10724.8 11312.5 12558.2 12845.1 13021.0 10709.7 10741.5 11087.5 11140.4 11191.5 10463.3 10606.7 10820.8 11066.6 11273.7 11070.1 11130.9 11245.0 11262.6 11610.6 7230.4 7296.5 7316.7 7341.8 7409.1 8071.8 9219.9 9635.6 11069.9 11173.3 16:38:09 INFO - PROCESS | 1646 | 16:38:09 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5357.28 Median:5121.63 stddev:2939.88 (57.4%) stddev-sans-first:2932.78 16:38:09 INFO - PROCESS | 1646 | Values: 1359.3 1451.2 1598.8 1754.4 1828.2 7845.9 8231.2 8275.7 8322.8 8339.3 7356.4 7470.4 7502.7 7598.2 8179.0 2059.6 2087.7 2092.6 2216.9 2293.0 2313.4 2323.1 2326.5 2327.8 2332.6 2245.5 2273.1 2282.7 2287.2 2294.3 2250.6 2252.4 2272.2 2273.4 2281.6 2247.4 2304.2 2306.3 2312.5 2315.7 8145.6 8148.5 8198.1 8198.5 8222.4 5006.2 5124.3 5125.8 5128.5 5136.4 3149.7 3308.7 3354.3 3477.4 3495.4 1006.9 1049.6 1075.4 1086.8 1092.2 10527.3 10701.3 10724.3 10749.1 10812.7 4338.3 4484.4 4578.4 4599.1 4618.7 9253.4 9260.2 9281.0 9289.7 9335.8 5120.6 5122.7 5130.7 5137.4 5137.6 4602.4 4659.8 4687.7 4717.0 4731.7 3476.1 3562.9 3567.8 3699.6 3791.9 1064.1 1189.1 1217.5 1222.7 1227.2 780.8 792.9 818.7 866.6 886.4 5317.2 5403.2 5617.9 5737.3 5745.0 833.9 850.8 853.3 901.9 905.7 3685.7 3740.5 3741.6 3778.1 3805.3 9524.2 10059.3 10059.8 10109.7 10164.5 10000.2 10009.1 10032.5 10044.3 10058.5 6477.4 7711.6 7761.5 7768.7 7823.8 5159.7 5322.9 5409.7 5463.3 5486.4 9182.0 9183.9 9210.5 9337.2 9374.8 9277.8 9387.3 9394.0 9413.0 9489.6 6992.9 7025.4 7082.3 7103.5 7111.8 6978.6 7526.2 7674.6 7726.5 7768.0 6580.4 6639.7 7002.6 7029.0 7042.9 6796.7 6928.1 6965.2 6987.9 7045.3 6615.3 6622.9 6683.6 6689.6 6713.5 4749.6 4803.0 4807.4 4857.5 4925.3 4782.8 4827.5 4834.4 4872.3 4921.2 16:38:09 INFO - PROCESS | 1646 | 16:38:09 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4322.30 Median:4760.20 stddev:1337.62 (28.1%) stddev-sans-first:1306.73 16:38:09 INFO - PROCESS | 1646 | Values: 292.6 294.9 303.8 307.7 309.4 3962.2 4475.5 4700.6 4857.3 5289.1 4361.9 5120.2 5208.5 5269.3 5319.4 3017.4 3958.9 4019.5 4058.7 4083.5 3458.2 3581.0 3751.9 4084.7 4088.6 3183.9 3636.7 4000.8 4023.2 4049.6 3817.4 3977.0 3987.6 3995.0 4000.9 3164.4 3263.5 3489.6 3505.4 3505.5 4853.6 5118.6 5148.9 5156.4 5182.2 3953.7 4038.3 4587.3 4594.6 4601.0 5562.5 5564.5 5574.5 5581.0 5611.0 3556.4 3771.8 3810.8 3827.6 3831.0 5334.6 5833.9 5851.0 5859.5 5861.2 3295.5 3537.5 3781.8 3864.5 3875.9 3032.6 3467.0 3928.4 3952.8 3958.8 4545.5 4564.7 4578.7 4584.4 4603.3 5593.4 5613.0 5629.4 5649.3 5650.1 1017.8 1224.5 1254.3 1265.6 1279.7 719.0 766.4 786.5 802.9 887.7 4124.7 4443.4 4908.0 4957.6 4978.9 4589.6 5029.5 5156.9 5175.8 5431.4 4097.0 4123.9 4671.8 4965.3 5028.6 2556.7 2649.0 2660.6 2692.9 2802.1 4761.5 4798.1 5492.0 5577.6 5583.2 4483.8 4914.3 5505.6 5536.5 5560.6 4739.6 4989.6 5250.3 5575.6 5614.8 5029.8 5324.3 5389.8 5417.9 5421.6 4874.8 5127.5 5263.9 5289.5 5329.0 4759.0 4940.5 5276.7 5474.1 5604.5 3207.6 3446.4 3561.0 3612.3 3632.8 4588.7 5086.5 5330.7 5371.4 5387.8 4625.4 4626.7 5206.7 5214.2 5227.5 4329.9 4568.5 4637.4 5162.5 5187.8 4674.3 4674.5 5150.5 5172.4 5396.2 5481.4 5555.5 5562.6 5659.2 5672.8 4906.5 5479.0 5504.7 5505.2 5506.3 16:38:09 INFO - PROCESS | 1646 | 16:38:09 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:19513.85 Median:27581.63 stddev:28364.20 (102.8%) stddev-sans-first:28408.47 16:38:09 INFO - PROCESS | 1646 | Values: 668.4 672.7 683.5 721.2 728.2 13573.3 14123.6 14140.6 14141.3 14467.0 12597.5 12703.0 12715.4 12722.8 12723.7 632.5 653.7 792.1 810.9 817.6 813.6 822.8 834.3 835.2 836.2 872.9 874.6 875.0 876.7 878.1 670.1 688.9 866.9 872.2 872.2 619.5 634.8 638.1 642.0 642.9 13209.0 13250.3 13570.0 13582.5 13585.9 11713.4 11794.5 12011.5 12091.3 12330.3 11693.6 11995.9 12160.6 12222.7 12576.2 4359.1 4380.4 4394.1 4572.7 4585.8 87156.0 88193.0 88370.7 89652.6 90832.0 9982.0 10197.3 10263.7 10547.9 10715.4 19515.1 19796.9 19840.3 19859.1 19890.4 7288.3 7377.7 7479.0 7515.5 7565.4 3576.3 4120.2 4197.2 4202.9 4203.3 3253.5 3300.0 3301.5 3317.7 3355.7 615.2 621.5 625.6 636.3 637.8 564.1 589.9 594.8 600.8 625.0 8776.0 8864.5 9107.6 9647.7 9793.9 508.9 594.5 614.9 684.3 688.7 4033.4 4372.5 4401.0 4469.2 4504.9 69359.7 83126.0 107648.0 109084.5 112944.0 95910.5 96126.6 97218.5 97663.0 99682.0 53913.9 55516.0 70145.6 82859.2 85733.6 9091.2 9505.5 9554.6 9562.0 9629.8 37536.9 50577.5 52527.2 54968.5 55041.7 68915.0 70411.6 72711.3 72774.0 79384.0 11593.9 11782.8 11852.5 12380.8 12386.7 13271.5 13329.5 13618.7 13694.4 14248.3 10502.2 12553.8 12725.6 12878.5 13216.0 12429.9 12537.3 12727.0 12744.2 13132.5 12194.5 12278.0 12423.0 12445.9 12775.3 9867.3 10158.7 10287.9 10311.2 10800.7 9814.5 10566.0 10785.1 11000.7 11180.0 16:38:09 INFO - PROCESS | 1646 | -------- Summary: end -------- 16:38:09 INFO - PROCESS | 1646 | 16:38:09 INFO - TEST-INFO | 1646: exit 0 16:38:09 INFO - TEST-OK | dromaeo_css | took 1120607ms 16:38:09 INFO - TEST-START | kraken 16:38:09 INFO - operating with platform_type : mac_ 16:38:09 INFO - Initialising browser for kraken test... 16:38:09 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpBEZwyD/profile http://localhost:49268/getInfo.html) 16:38:12 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 16:38:12 INFO - PROCESS | 1657 | colorDepth:24 16:38:12 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 16:38:12 INFO - PROCESS | 1657 | __metrics 16:38:12 INFO - PROCESS | 1657 | 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" 16:38:12 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:38:13 INFO - TEST-INFO | 1657: exit 0 16:38:13 INFO - Browser initialized. 16:38:13 INFO - Running cycle 1/1 for kraken test... 16:38:13 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpBEZwyD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:25 INFO - PROCESS | 1658 | RSS: Main: 239312896 16:38:25 INFO - PROCESS | 1658 | 16:38:28 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 16:38:28 INFO - PROCESS | 1658 | RSS: Main: 291799040 16:38:28 INFO - PROCESS | 1658 | 16:38:31 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 16:38:32 INFO - PROCESS | 1658 | RSS: Main: 291319808 16:38:32 INFO - PROCESS | 1658 | 16:38:35 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 16:38:36 INFO - PROCESS | 1658 | RSS: Main: 382926848 16:38:36 INFO - PROCESS | 1658 | 16:38:38 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 16:38:38 INFO - PROCESS | 1658 | RSS: Main: 285491200 16:38:38 INFO - PROCESS | 1658 | 16:38:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:38:41 INFO - PROCESS | 1658 | RSS: Main: 287453184 16:38:41 INFO - PROCESS | 1658 | 16:38:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 16:38:44 INFO - PROCESS | 1658 | RSS: Main: 325607424 16:38:44 INFO - PROCESS | 1658 | 16:38:47 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 16:38:48 INFO - PROCESS | 1658 | RSS: Main: 326160384 16:38:48 INFO - PROCESS | 1658 | 16:38:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 16:38:51 INFO - PROCESS | 1658 | RSS: Main: 324808704 16:38:51 INFO - PROCESS | 1658 | 16:38:53 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:38:54 INFO - PROCESS | 1658 | RSS: Main: 302374912 16:38:54 INFO - PROCESS | 1658 | 16:38:56 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:38:56 INFO - PROCESS | 1658 | RSS: Main: 302546944 16:38:56 INFO - PROCESS | 1658 | 16:38:58 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:38:59 INFO - PROCESS | 1658 | RSS: Main: 308953088 16:38:59 INFO - PROCESS | 1658 | 16:39:02 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:39:03 INFO - PROCESS | 1658 | RSS: Main: 323207168 16:39:03 INFO - PROCESS | 1658 | 16:39:06 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:39:07 INFO - PROCESS | 1658 | RSS: Main: 317255680 16:39:07 INFO - PROCESS | 1658 | 16:39:08 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 16:39:09 INFO - PROCESS | 1658 | RSS: Main: 360759296 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - PROCESS | 1658 | __start_tp_report 16:39:09 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 16:39:09 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 16:39:09 INFO - PROCESS | 1658 | |i|pagename|runs| 16:39:09 INFO - PROCESS | 1658 | |0;ai-astar;121;168;145;113;112;112;111;120;170;152 16:39:09 INFO - PROCESS | 1658 | |1;audio-beat-detection;142;112;112;149;115;116;125;112;139;107 16:39:09 INFO - PROCESS | 1658 | |2;audio-dft;182;185;183;185;189;213;187;184;181;175 16:39:09 INFO - PROCESS | 1658 | |3;audio-fft;76;59;59;88;62;58;58;58;84;58 16:39:09 INFO - PROCESS | 1658 | |4;audio-oscillator;82;71;93;69;68;68;90;66;98;109 16:39:09 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;87;85;86;124;87;83;87;88;135;84 16:39:09 INFO - PROCESS | 1658 | |6;imaging-darkroom;92;93;93;94;92;92;93;93;92;92 16:39:09 INFO - PROCESS | 1658 | |7;imaging-desaturate;83;82;79;80;81;81;83;84;82;81 16:39:09 INFO - PROCESS | 1658 | |8;json-parse-financial;55;54;55;53;55;54;53;54;73;79 16:39:09 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;63;71;70;74;72;74;78;98;99;85 16:39:09 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;87;87;86;90;91;91;86;85;85;88 16:39:09 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;150;148;148;147;144;148;148;152;220;152 16:39:09 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;174;177;183;223;162;224;234;175;173;175 16:39:09 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;68;68;68;66;79;87;85;72;67;67 16:39:09 INFO - PROCESS | 1658 | __end_tp_report 16:39:09 INFO - PROCESS | 1658 | __start_cc_report 16:39:09 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2095 16:39:09 INFO - PROCESS | 1658 | __end_cc_report 16:39:09 INFO - PROCESS | 1658 | __startTimestamp1478565549110__endTimestamp 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - PROCESS | 1658 | ------- Summary: start ------- 16:39:09 INFO - PROCESS | 1658 | Number of tests: 14 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:132.40 Median:133.00 stddev:23.98 (18.0%) stddev-sans-first:25.07 16:39:09 INFO - PROCESS | 1658 | Values: 121.0 168.0 145.0 113.0 112.0 112.0 111.0 120.0 170.0 152.0 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:122.90 Median:120.50 stddev:15.01 (12.5%) stddev-sans-first:14.25 16:39:09 INFO - PROCESS | 1658 | Values: 142.0 112.0 112.0 149.0 115.0 116.0 125.0 112.0 139.0 107.0 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:186.40 Median:185.00 stddev:10.08 (5.4%) stddev-sans-first:10.56 16:39:09 INFO - PROCESS | 1658 | Values: 182.0 185.0 183.0 185.0 189.0 213.0 187.0 184.0 181.0 175.0 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.50 stddev:11.92 (19.7%) stddev-sans-first:12.08 16:39:09 INFO - PROCESS | 1658 | Values: 76.0 59.0 59.0 88.0 62.0 58.0 58.0 58.0 84.0 58.0 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:81.40 Median:76.50 stddev:15.29 (20.0%) stddev-sans-first:16.22 16:39:09 INFO - PROCESS | 1658 | Values: 82.0 71.0 93.0 69.0 68.0 68.0 90.0 66.0 98.0 109.0 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:94.60 Median:86.50 stddev:18.64 (21.5%) stddev-sans-first:19.56 16:39:09 INFO - PROCESS | 1658 | Values: 87.0 85.0 86.0 124.0 87.0 83.0 87.0 88.0 135.0 84.0 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:93.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 16:39:09 INFO - PROCESS | 1658 | Values: 92.0 93.0 93.0 94.0 92.0 92.0 93.0 93.0 92.0 92.0 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:81.60 Median:82.00 stddev:1.51 (1.8%) stddev-sans-first:1.51 16:39:09 INFO - PROCESS | 1658 | Values: 83.0 82.0 79.0 80.0 81.0 81.0 83.0 84.0 82.0 81.0 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:55.00 stddev:9.36 (17.0%) stddev-sans-first:9.84 16:39:09 INFO - PROCESS | 1658 | Values: 55.0 54.0 55.0 53.0 55.0 54.0 53.0 54.0 73.0 79.0 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:78.40 Median:76.00 stddev:11.99 (15.8%) stddev-sans-first:11.35 16:39:09 INFO - PROCESS | 1658 | Values: 63.0 71.0 70.0 74.0 72.0 74.0 78.0 98.0 99.0 85.0 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:87.50 stddev:2.32 (2.7%) stddev-sans-first:2.45 16:39:09 INFO - PROCESS | 1658 | Values: 87.0 87.0 86.0 90.0 91.0 91.0 86.0 85.0 85.0 88.0 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:155.70 Median:149.00 stddev:22.72 (15.2%) stddev-sans-first:24.00 16:39:09 INFO - PROCESS | 1658 | Values: 150.0 148.0 148.0 147.0 144.0 148.0 148.0 152.0 220.0 152.0 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.00 Median:180.00 stddev:26.20 (14.6%) stddev-sans-first:27.14 16:39:09 INFO - PROCESS | 1658 | Values: 174.0 177.0 183.0 223.0 162.0 224.0 234.0 175.0 173.0 175.0 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:70.00 stddev:7.97 (11.4%) stddev-sans-first:8.27 16:39:09 INFO - PROCESS | 1658 | Values: 68.0 68.0 68.0 66.0 79.0 87.0 85.0 72.0 67.0 67.0 16:39:09 INFO - PROCESS | 1658 | -------- Summary: end -------- 16:39:09 INFO - PROCESS | 1658 | 16:39:09 INFO - TEST-INFO | 1658: exit 0 16:39:10 INFO - TEST-OK | kraken | took 60227ms 16:39:10 INFO - SUITE-END | took 1180s 16:39:10 INFO - Completed test suite (00:19:41) 16:39:10 INFO - javascript benchmark 16:39:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3197.944678256176, 3278.7540934429926, 3291.3417316536693, 3325.5177999190105, 3326.3679900818843, 5511.255980442639, 5557.749901254443, 5608.495235428821, 5666.518345940595, 5675.687837168959, 5590.804321848736, 5605.103183490643, 5681.091025435931, 5693.459121383472, 5705.857353566153, 5062.721550314731, 5074.517920797518, 5079.23811428285, 5079.466656001122, 5145.202493613496, 5199.376074871021, 5243.187305967562, 5256.999999999981, 5257.763400646961, 5287.68273903567, 5062.594992400599, 5208.2968799212, 5221.686698798047, 5230.816921407752, 5318.016167009116, 5120.462351453119, 5157.6647517911215, 5167.7932882684645, 5180.300659410969, 5187.896242075138, 5071.974640126813, 5122.590192784568, 5133.153029750124, 5143.228515722634, 5154.433012368637, 5586.162075688639, 5589.692566908819, 5592.468715472024, 5595.692236926968, 5603.355614104389, 6054.96972515139, 6105.133478386146, 6106.97642067191, 6120.111926550715, 6125.509959203253, 6161.691915404212, 6166.81499555014, 6212.068189771525, 6214.25428948529, 6233.2208473940755, 5720.48515633595, 5748.425157484302, 5755.740991655385, 5765.135229715576, 5770.682612456313, 6117.401149625483, 6178.258608966863, 6187.84530386735, 6195.504359651217, 6203.534734894901, 5970.701464926737, 5981.551383646244, 6089.995150800157, 6104.4200800923845, 6121.70690522557, 6191.102290167901, 6192.256929168529, 6193.566450348522, 6195.101710251988, 6196.442320191204, 6069.878602427927, 6138.324784273726, 6144.201253837062, 6144.324124346318, 6168.0, 5972.910406343908, 6029.969850150809, 6043.7280322385595, 6056.303525094582, 6113.877722445526, 4800.087983283165, 4890.657653964188, 4917.58200552957, 4924.236743304794, 4927.43334516528, 4368.388425620416, 4392.253316936129, 4398.406215160976, 4418.513963464016, 4434.135343607965, 5701.914471282934, 5720.942790572124, 5755.913661295084, 5758.654480731169, 5770.221020162225, 6103.450689437972, 6128.197586012551, 6134.559047376611, 6150.969245153835, 6230.56386052981, 5721.885562288814, 5757.453041961007, 5762.481376676035, 5788.247527821356, 5827.0, 5373.516383525502, 5373.946260537423, 5376.112941364631, 5376.166694162411, 5377.919331210035, 6155.72299246535, 6169.84575385619, 6256.217972753406, 6278.466330361788, 6305.432511074026, 6150.630962142286, 6160.322364539987, 6176.227971503562, 6194.101855231056, 6275.184226050585, 6280.9685951569945, 6285.340039295991, 6296.338884417253, 6296.716647750771, 6298.716557755004, 6079.939200607937, 6082.2701275847185, 6085.361037091218, 6110.633361998294, 6154.815355539341, 6035.969820150871, 6104.962156433506, 6118.694065296806, 6130.0006981778415, 6134.7427470591965, 5977.0, 5993.790217342372, 5996.280446346466, 6008.188894499187, 6014.0678194879865, 4933.925991110208, 5968.253968253968, 5975.671338076448, 5984.670843103671, 5987.31145918225, 5664.603477756517, 5847.532197424111, 5851.122331650116, 5861.032929566573, 5866.090755932837, 5940.376260492586, 5970.850728731816, 5971.313298970674, 5972.790952316648, 5975.820725378246, 4813.855584332336, 5802.506786923159, 5803.39064398249, 5804.6807425592, 5813.738381772915], "value": 5627.265096499042, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.80228501744244, 460.25898303730986, 496.24075164997555, 521.8225803226902, 534.3427584071592, 29363.825446982122, 31232.84383578082, 39564.406533902016, 39590.406143907865, 40989.795051024776, 35962.2807543849, 36862.63137368632, 40151.79544613659, 40548.98627534306, 40626.0, 8233.711820086299, 9053.50205738684, 9219.170274675278, 9235.030321816213, 9236.67671631493, 7093.89359159613, 8413.0, 8420.621072051772, 8451.95774021129, 10920.781584368307, 10900.836487452694, 11030.834537481904, 11083.778324433506, 11095.83356249657, 11165.995060444558, 9413.435193888321, 10984.395858227794, 11076.778464430747, 11081.556737730481, 11103.278286911325, 8238.670453181865, 8476.66093356265, 10667.786644267071, 10868.347899125998, 10960.0, 37143.0, 39032.07259455524, 39099.218015639526, 39187.412188817194, 39650.0087497812, 3269.623993240784, 3398.5921689397182, 3783.5838057813617, 3864.8592200662333, 3931.9017024574327, 28482.430351392857, 29491.67287472069, 29963.250918727208, 30017.099487015425, 30045.0, 2973.3012742005612, 3141.701538353853, 3240.4815229563155, 3271.2312606537444, 3313.801171929692, 464904.0, 466152.0, 469846.650766744, 471085.0, 472044.63977680233, 54623.45376546263, 54918.62703432446, 55001.72499137479, 55045.44954550483, 55118.62203444946, 61708.0, 61746.9126543671, 61904.0, 61924.38075619186, 61969.690151549854, 15495.767563486557, 15708.293126809092, 15743.055416675035, 15749.212539372986, 15785.921070394805, 12098.213616114925, 12138.0, 12165.087618428654, 12166.81749773754, 12188.634340969786, 15482.458113965957, 15835.970661906938, 17477.321583074136, 18102.0, 19436.22255109808, 7927.484713493604, 8011.799705007422, 8041.155678653774, 8075.183083806097, 8122.350211983027, 836.7908022994252, 922.689780511675, 933.8879334479906, 1004.1966426858484, 1067.9038886500252, 27617.861910690317, 28642.570361444596, 28749.28126796847, 29309.26726831846, 29517.0, 989.4904124375952, 1005.1556692378438, 1007.2294694558668, 1059.2003037706481, 1059.6291298045621, 11794.623155853395, 13172.080579791094, 14716.705665886622, 14969.727573156404, 15145.697086058217, 575912.0, 634185.6325747011, 636992.0, 637280.0, 638096.0, 55296.17055744167, 55682.0, 55768.721156393956, 55775.442245577025, 55845.0, 1250.9186902851286, 1287.0604458745167, 1315.302889468583, 1365.0785719639205, 1365.6449323176244, 27984.58023129614, 28040.0, 28043.859780700965, 28668.99658511942, 28804.71195288104, 47749.76125119352, 48012.27981580209, 48177.75911120422, 48265.517344826105, 48273.75863120662, 581047.0, 585052.0, 585098.0, 585526.0, 585900.0, 33083.50374744333, 33220.833895830365, 33793.49309760307, 38507.0, 39311.87225341298, 41679.58320416757, 41855.37216941687, 42538.36192457178, 43084.56915430931, 43381.78309108434, 35779.0, 36017.459738103425, 36130.27739445249, 36648.0, 36676.81661591675, 35442.291154177285, 36232.818835906706, 36413.13224805366, 36700.44949325816, 36747.816260918524, 34713.82643086869, 34846.65153348434, 35538.82230588831, 35600.0, 36064.0, 25909.740902591486, 30096.548551771302, 31621.20946976344, 31904.521432178073, 32192.49305097335, 17621.823781762017, 20124.79875201229, 23720.644190336814, 24335.0, 24447.51104977926], "value": 19425.310428091798, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.0737010072804, 355.3727670661283, 366.7542746359937, 371.6933529837884, 396.20956192396176, 14620.049696769702, 14867.03364281321, 15716.449924252667, 19477.026148692545, 20241.797582024174, 19096.045197740128, 19806.41548676106, 19908.0, 19988.800111998877, 20170.59658806823, 5596.4123767004385, 5948.851278718045, 5950.821475355746, 5963.642181469104, 5966.284045914496, 4971.925421118686, 5377.8117765878205, 5828.737706803204, 5885.7939972100985, 5912.7930522431725, 5573.888522229553, 5809.477147056764, 5850.063989761639, 5850.73671684773, 5851.7074146292725, 5700.401457846929, 5836.153757705109, 5839.270091238595, 5842.152887831241, 5844.736986835603, 4860.441049279308, 5054.646174767768, 5113.872153196163, 5116.130257856174, 5119.56483698886, 25156.874215628988, 25294.620580691306, 25321.87339063293, 25534.233972980655, 25712.614310785353, 2071.492484341331, 2176.673498975151, 2192.440927563477, 2949.292169879235, 3028.3489049854165, 9600.711978640651, 9735.65925192622, 10012.29913906027, 10189.858683322798, 10341.896581034243, 1630.991845040779, 1636.3372834002248, 1650.3316156956453, 1740.677974574695, 1764.5235786337616, 116410.41794790972, 124998.12502812465, 129954.0, 130296.0, 130318.40701505366, 10735.194860385502, 10749.78500429987, 11377.772444551063, 11383.601573944872, 11652.30086194814, 14087.71824563503, 14098.083624564575, 14102.576922692335, 14108.012439129163, 14114.435422583187, 7696.692132314756, 7980.680772769024, 8200.835983280302, 8283.58582070894, 8423.452475589067, 8113.310368618733, 8139.796505087302, 8151.714689985822, 8297.045839728387, 8347.958260208781, 3633.8364773585254, 4424.0, 4428.3800267962515, 4434.84478043267, 4522.3442600823355, 1536.6312085099719, 1675.4387280261005, 1856.5822689894665, 1905.2188602673116, 1945.1344151852572, 678.2877978122951, 772.7218201447474, 912.8721978922956, 934.9158575728217, 1015.5937624950079, 20033.899830500755, 20597.0, 20641.277555285793, 20642.58714825725, 20663.0, 899.7660608241904, 919.6965001549472, 922.5156792683895, 936.2369668719972, 951.7715748220377, 10047.458164488635, 10660.20048496366, 10915.126789856951, 10915.580725246165, 10950.780984380268, 559269.0, 571592.0, 571664.0, 580785.0, 587131.0, 133446.33276833553, 134378.0, 134578.32710836382, 136867.31566342103, 137435.0, 951.8905325887473, 962.7159987803615, 993.0852946601747, 994.9403035817729, 995.26326560153, 17708.91145544264, 18679.90660046691, 19380.8061919379, 19391.806081939, 19672.90163549173, 51725.0, 53249.733751331, 55508.72245638746, 56501.0, 58035.2589422318, 57869.710651446476, 78799.0, 79057.0, 85302.0, 87943.12056879605, 6632.336766323329, 6934.757283495053, 7222.205557388788, 7248.420126389981, 8141.0, 10724.785504290026, 11312.547498099984, 12558.183718058297, 12845.100842941278, 13020.958323333922, 10709.678709638723, 10741.516631751434, 11087.501062452371, 11140.387278699749, 11191.496382662963, 10463.319884207502, 10606.681799546026, 10820.837687434852, 11066.557337706723, 11273.661790146309, 11070.059044980944, 11130.888691112985, 11245.044171245536, 11262.605808796652, 11610.593629222936, 7230.385417239593, 7296.489245752959, 7316.707331706672, 7341.816454588678, 7409.073865766779, 8071.838563228585, 9219.86170207434, 9635.614575417185, 11069.948354906272, 11173.273737207055], "value": 9281.994521116208, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.320339830085, 1451.1945870042125, 1598.8161361443438, 1754.350890170637, 1828.1590468384543, 7845.92154078459, 8231.176882311765, 8275.66897324107, 8322.791930201747, 8339.29116025137, 7356.448266380016, 7470.3650189733935, 7502.737404190854, 7598.164201937782, 8179.0, 2059.6292667319876, 2087.6951905059336, 2092.6233278010027, 2216.933491995235, 2293.036924491709, 2313.410080429488, 2323.0939933425975, 2326.523062772136, 2327.7788610082016, 2332.615118505453, 2245.528439027806, 2273.102124660758, 2282.669012993115, 2287.2337766848127, 2294.27730264966, 2250.61739504283, 2252.4368907773055, 2272.227442669484, 2273.4089136824377, 2281.634938409863, 2247.381969958258, 2304.2050492580033, 2306.308107567723, 2312.5028118954506, 2315.6989591353185, 8145.5927203639585, 8148.470349427268, 8198.139195384518, 8198.508089514648, 8222.38332125087, 5006.224035274502, 5124.308218390507, 5125.82059627915, 5128.538431541179, 5136.383633963911, 3149.6692847251165, 3308.7022168004996, 3354.295597924439, 3477.426224672926, 3495.388307046282, 1006.8842083160457, 1049.58541376156, 1075.3601607043797, 1086.7609125992349, 1092.202692034811, 10527.315724477961, 10701.304415212986, 10724.302920310232, 10749.086327662159, 10812.67561973142, 4338.262495375794, 4484.354231003724, 4578.427696537933, 4599.103174880866, 4618.7298492914715, 9253.398529095588, 9260.21288190498, 9280.953595232115, 9289.72130836076, 9335.766605834908, 5120.590352771769, 5122.667026643257, 5130.743462826844, 5137.383513978347, 5137.614678899097, 4602.401687780567, 4659.8136074557315, 4687.67186296956, 4717.0, 4731.668783185213, 3476.088151516706, 3562.928741425157, 3567.7859328440377, 3699.574548926908, 3791.905202369908, 1064.1271362402229, 1189.1259923955886, 1217.531250468576, 1222.7371115210271, 1227.2391117507202, 780.8477346917297, 792.944493885434, 818.7093581778383, 866.6350448634403, 886.3928209176735, 5317.216321967599, 5403.162509810985, 5617.943820561742, 5737.254156959569, 5745.0, 833.8874251976027, 850.7745447456429, 853.3301358433599, 901.9143181397757, 905.7418635688797, 3685.7419980601635, 3740.5137332146646, 3741.6219338518667, 3778.0554861284677, 3805.257974694963, 9524.190443812353, 10059.346142500714, 10059.849102263472, 10109.696709098738, 10164.542595583216, 10000.249981251436, 10009.099181073738, 10032.498375081217, 10044.347117437343, 10058.497075146213, 6477.417032467007, 7711.575863327459, 7761.495502792301, 7768.728094516665, 7823.804404889924, 5159.742012899415, 5322.893542129058, 5409.729513524387, 5463.262459567907, 5486.3815174522815, 9181.954090229507, 9183.908160918305, 9210.493422861538, 9337.159655630754, 9374.765630859283, 9277.814443711222, 9387.342885997914, 9394.013628568902, 9412.95293523528, 9489.57296921654, 6992.860142797217, 7025.402840758593, 7082.256363081802, 7103.538270012433, 7111.82220444493, 6978.616176110363, 7526.209747976383, 7674.6162691864065, 7726.497777644435, 7767.961160194162, 6580.407763301326, 6639.668016599054, 7002.579845209304, 7029.0, 7042.929570704227, 6796.72813087471, 6928.1339832520935, 6965.15439276811, 6987.930120698931, 7045.295470452914, 6615.338466153346, 6622.867542649216, 6683.63240021784, 6689.5986240825705, 6713.462922966053, 4749.620030397629, 4802.975985120192, 4807.423109226916, 4857.53853383928, 4925.310456536159, 4782.832600858953, 4827.541383568555, 4834.398259020462, 4872.269159626085, 4921.212605983025], "value": 4334.865242599662, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.6195945271148, 294.8820471811275, 303.7949384165688, 307.71536328895763, 309.4383693596121, 3962.177398396741, 4475.5076941536445, 4700.623950083994, 4857.2714092886, 5289.1174310001, 4361.890952726176, 5120.180771076629, 5208.505192006763, 5269.286317546457, 5319.430767923463, 3017.411604737066, 3958.901027474322, 4019.537753158395, 4058.6753059755297, 4083.5099788025477, 3458.170039190589, 3580.9641903581023, 3751.9437208441896, 4084.7140700151003, 4088.550259471456, 3183.8856400259956, 3636.690881275095, 4000.799960002003, 4023.195360927826, 4049.5950404959563, 3817.3701339278987, 3977.031369472101, 3987.601239876018, 3994.999999999971, 4000.879973600797, 3164.3829453256626, 3263.526788615661, 3489.581250249986, 3505.404081306159, 3505.509228707983, 4853.635977301717, 5118.564921981636, 5148.9485105149215, 5156.355455568054, 5182.186234817784, 3953.6639385651965, 4038.303912356788, 4587.3348364486965, 4594.563516465931, 4601.010782681739, 5562.527185189264, 5564.4991950724225, 5574.470425309589, 5581.0, 5611.0, 3556.3598552260582, 3771.7925514096714, 3810.8475660973527, 3827.6029249324074, 3831.027021084144, 5334.5732341412595, 5833.912491312633, 5851.005329094064, 5859.501942334907, 5861.20873682056, 3295.538624592559, 3537.46937959303, 3781.8487260509273, 3864.5073927317285, 3875.8643447479203, 3032.6360836699737, 3467.0, 3928.3518219493462, 3952.806192563155, 3958.802059896994, 4545.545405481069, 4564.740453475551, 4578.733526904204, 4584.4498660161, 4603.286490593963, 5593.412691667398, 5612.986714499153, 5629.380768115504, 5649.265595472562, 5650.067738823131, 1017.8015287019108, 1224.5224362498632, 1254.3163975633302, 1265.6329664397222, 1279.7248591552861, 718.9539220434256, 766.3983772738374, 786.4966421490251, 802.924081730484, 887.671561522241, 4124.680102367273, 4443.400140980991, 4907.950920490821, 4957.553820156203, 4978.8755281118265, 4589.609883159968, 5029.471905449948, 5156.891268377317, 5175.818846340435, 5431.429699881455, 4096.959030409717, 4123.876283711494, 4671.789769460383, 4965.255211718271, 5028.572571331405, 2556.654851595048, 2648.9933825146704, 2660.561007433752, 2692.8788204530842, 2802.0805748062644, 4761.452717725317, 4798.136335459581, 5492.038893193675, 5577.553795696334, 5583.175524765548, 4483.825344707814, 4914.329128096464, 5505.550030236506, 5536.501714845684, 5560.610757246954, 4739.573438390561, 4989.60083193351, 5250.317458730493, 5575.553955683536, 5614.831555053355, 5029.823956161516, 5324.2962252080515, 5389.787297857951, 5417.918731219113, 5421.647592906448, 4874.829380971649, 5127.512886275797, 5263.867998540862, 5289.47105289468, 5329.0, 4758.952410475851, 4940.505949405175, 5276.683398996072, 5474.069408200695, 5604.495595396434, 3207.615965156782, 3446.3624229516618, 3561.038519599642, 3612.27754449106, 3632.763870348419, 4588.655850811269, 5086.542211200862, 5330.706811125426, 5371.435999220182, 5387.75755091014, 4625.392194088617, 4626.745528995937, 5206.739663016759, 5214.176886380159, 5227.503387178212, 4329.913401732011, 4568.451785785727, 4637.420322459692, 5162.457941916045, 5187.792488300577, 4674.252119660838, 4674.509176536415, 5150.4762666294, 5172.353455818023, 5396.192275587722, 5481.397046324981, 5555.527780138734, 5562.579013906499, 5659.236003139524, 5672.801451949327, 4906.460289368095, 5479.0, 5504.724763761876, 5505.201745746925, 5506.339239291311], "value": 3893.298491850364, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.4151367553391, 672.6972862212006, 683.53861143728, 721.2390927571416, 728.19534414472, 13573.2534710591, 14123.646908827284, 14140.646483837922, 14141.292935353242, 14467.0, 12597.496100156006, 12703.047271454654, 12715.364231788397, 12722.809157862617, 12723.681907952307, 632.5382470796321, 653.6829637625748, 792.0930534537979, 810.9148539403351, 817.5912043978011, 813.5647428625687, 822.7943014246439, 834.2741814621288, 835.1815221083342, 836.2014276366056, 872.8734333521636, 874.637025634361, 874.995625021874, 876.7238319929234, 878.0780180810156, 670.0819876768809, 688.9207741109736, 866.874303226035, 872.1627237851638, 872.1975782280317, 619.5198720991223, 634.7968650031992, 638.0907207229726, 642.0433554004546, 642.9003504456816, 13209.0, 13250.271235082068, 13569.98225133119, 13582.524611638546, 13585.86414135856, 11713.414329283502, 11794.469248883821, 12011.519539218421, 12091.334976576285, 12330.32183229922, 11693.649190524298, 11995.940020299842, 12160.574379896661, 12222.694432639166, 12576.245425274512, 4359.128174365108, 4380.364847097185, 4394.143142087294, 4572.719638501192, 4585.770711464414, 87156.0, 88193.0, 88370.67443988346, 89652.5517372409, 90832.0, 9982.0, 10197.286189966631, 10263.692089237335, 10547.947260263649, 10715.410652414037, 19515.121819518157, 19796.90101549483, 19840.305589304306, 19859.106340214727, 19890.403287901096, 7288.344049035612, 7377.741779037708, 7479.0, 7515.511491753018, 7565.356944659766, 3576.3204991051616, 4120.196561670506, 4197.18154959786, 4202.894927626834, 4203.306454434984, 3253.5445037694267, 3299.950500742491, 3301.4552598820924, 3317.7345812334956, 3355.681210285019, 615.2033117113259, 621.4562258024229, 625.6371304643296, 636.312782195228, 637.8373514753708, 564.1481363141686, 589.9174115623816, 594.7531774313697, 600.8047384600022, 624.96875156242, 8776.0, 8864.512451815212, 9107.590158442887, 9647.662331818494, 9793.90206097944, 508.9033083714157, 594.5392320951297, 614.8739508400768, 684.3327755438507, 688.6728803818146, 4033.435319055276, 4372.540883207217, 4401.0, 4469.195544801967, 4504.932426013547, 69359.65320173367, 83126.0, 107648.0, 109084.4545777266, 112944.0, 95910.52044739731, 96126.55810162853, 97218.51390743001, 97663.0, 99682.0, 53913.92172156535, 55516.0, 70145.64927175331, 82859.17140828635, 85733.57133214294, 9091.181793638605, 9505.524723763923, 9554.56547957213, 9562.0, 9629.807403852024, 37536.87389378323, 50577.49422505875, 52527.21209181789, 54968.45031549793, 55041.72479137579, 68914.96627550691, 70411.64794175996, 72711.27288727257, 72774.0, 79384.0, 11593.942030289794, 11782.82325765097, 11852.466639001093, 12380.752384952431, 12386.690332741753, 13271.469141234242, 13329.475789757347, 13618.727625447635, 13694.38375273135, 14248.290205175444, 10502.159827213958, 12553.811692824798, 12725.61823145307, 12878.484860605471, 13216.0, 12429.875701242872, 12537.310447925087, 12727.0, 12744.235345879277, 13132.540361087698, 12194.451249693608, 12278.0, 12423.0, 12445.937770311091, 12775.251672854954, 9867.309288350034, 10158.695239142837, 10287.897121028695, 10311.175105991653, 10800.675979720621, 9814.509274536387, 10565.996230358103, 10785.137189025016, 11000.669979900616, 11180.0], "value": 7078.747225435224, "unit": "score"}], "name": "dromaeo_css", "value": 7035.056010077276, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 168.0, 145.0, 113.0, 112.0, 112.0, 111.0, 120.0, 170.0, 152.0], "value": 132.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 112.0, 112.0, 149.0, 115.0, 116.0, 125.0, 112.0, 139.0, 107.0], "value": 122.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 183.0, 185.0, 189.0, 213.0, 187.0, 184.0, 181.0, 175.0], "value": 186.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 59.0, 59.0, 88.0, 62.0, 58.0, 58.0, 58.0, 84.0, 58.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 71.0, 93.0, 69.0, 68.0, 68.0, 90.0, 66.0, 98.0, 109.0], "value": 81.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 124.0, 87.0, 83.0, 87.0, 88.0, 135.0, 84.0], "value": 94.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 94.0, 92.0, 92.0, 93.0, 93.0, 92.0, 92.0], "value": 92.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 79.0, 80.0, 81.0, 81.0, 83.0, 84.0, 82.0, 81.0], "value": 81.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 53.0, 55.0, 54.0, 53.0, 54.0, 73.0, 79.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 70.0, 74.0, 72.0, 74.0, 78.0, 98.0, 99.0, 85.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 90.0, 91.0, 91.0, 86.0, 85.0, 85.0, 88.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 148.0, 147.0, 144.0, 148.0, 148.0, 152.0, 220.0, 152.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 177.0, 183.0, 223.0, 162.0, 224.0, 234.0, 175.0, 173.0, 175.0], "value": 190.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 66.0, 79.0, 87.0, 85.0, 72.0, 67.0, 67.0], "value": 72.7, "unit": "score"}], "name": "kraken", "value": 1500.8000000000002, "alertThreshold": 2.0}]} 16:39:10 INFO - Return code: 0 16:39:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:39:10 INFO - # TBPL SUCCESS # 16:39:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:39:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:39:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:39:10 INFO - 2016-11-07 16:39:10.457 screenresolution[1662:9787] starting screenresolution argv=screenresolution get 16:39:10 INFO - 2016-11-07 16:39:10.460 screenresolution[1662:9787] Display 0: 1600x1200x32@60 16:39:10 INFO - 2016-11-07 16:39:10.466 screenresolution[1663:9790] starting screenresolution argv=screenresolution list 16:39:10 INFO - Available Modes on Display 0 16:39:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:39:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:39:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:39:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:39:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:39:10 INFO - Intel Iris: 16:39:10 INFO - Chipset Model: Intel Iris 16:39:10 INFO - Type: GPU 16:39:10 INFO - Bus: Built-In 16:39:10 INFO - VRAM (Dynamic, Max): 1536 MB 16:39:10 INFO - Vendor: Intel (0x8086) 16:39:10 INFO - Device ID: 0x0a2e 16:39:10 INFO - Revision ID: 0x0009 16:39:10 INFO - Displays: 16:39:10 INFO - Display: 16:39:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:39:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:39:10 INFO - Display Serial Number: 1600x1200 60 16:39:10 INFO - Main Display: Yes 16:39:10 INFO - Mirror: Off 16:39:10 INFO - Online: Yes 16:39:10 INFO - Rotation: Supported 16:39:10 INFO - Return code: 0 16:39:10 INFO - Running post-action listener: _resource_record_post_action 16:39:10 INFO - [mozharness: 2016-11-08 00:39:10.700926Z] Finished run-tests step (success) 16:39:10 INFO - Running post-run listener: _resource_record_post_run 16:39:10 INFO - Total resource usage - Wall time: 1216s; CPU: 54.0%; Read bytes: 38798336; Write bytes: 705964032; Read time: 380; Write time: 2032 16:39:10 INFO - TinderboxPrint: CPU usage
53.6% 16:39:10 INFO - TinderboxPrint: I/O read bytes / time
38,798,336 / 380 16:39:10 INFO - TinderboxPrint: I/O write bytes / time
705,964,032 / 2,032 16:39:10 INFO - TinderboxPrint: CPU idle
2,257.6 (46.4%) 16:39:10 INFO - TinderboxPrint: CPU system
972.0 (20.0%) 16:39:10 INFO - TinderboxPrint: CPU user
1,636.2 (33.6%) 16:39:10 INFO - TinderboxPrint: Swap in / out
441,905,152 / 0 16:39:10 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 396802560; Write bytes: 391480832; Read time: 29538; Write time: 729 16:39:10 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 36783104; Write bytes: 298459648; Read time: 355; Write time: 1266 16:39:11 INFO - Running post-run listener: _upload_blobber_files 16:39:11 INFO - Blob upload gear active. 16:39:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:39:11 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 16:39:11 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'] 16:39:11 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 16:39:11 INFO - (blobuploader) - INFO - Open directory for files ... 16:39:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:39:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:39:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:12 INFO - (blobuploader) - INFO - Done attempting. 16:39:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:39:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:39:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:13 INFO - (blobuploader) - INFO - Done attempting. 16:39:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:39:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:39:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:39:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:39:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:39:15 INFO - (blobuploader) - INFO - Done attempting. 16:39:15 INFO - (blobuploader) - INFO - Iteration through files over. 16:39:15 INFO - Return code: 0 16:39:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:39:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:39:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83db88b561af496de1741df4a837411988acb533d400bdf16e4d1aef0ffaabb63bdd9d5c9424d9ef54ed67e44647266bcda661734756e90edd0db29f577ee90c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7aae1b71e1e28693c8da4b431876df4af7518ef548df2945d91611540c43b55bd572ea91e3781e1179a0242e14be15e86848b3650608635cfe4728d5c35dbb09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f2108e056440f6035f86987cd401bb0cd0fcceb89860113a5a6241daa40a6f3e888a940f40906fd29f7a36b8222da371cde9876988efafa8ae9bab3b7a89431"} 16:39:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:39:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:39:15 INFO - Contents: 16:39:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83db88b561af496de1741df4a837411988acb533d400bdf16e4d1aef0ffaabb63bdd9d5c9424d9ef54ed67e44647266bcda661734756e90edd0db29f577ee90c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7aae1b71e1e28693c8da4b431876df4af7518ef548df2945d91611540c43b55bd572ea91e3781e1179a0242e14be15e86848b3650608635cfe4728d5c35dbb09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f2108e056440f6035f86987cd401bb0cd0fcceb89860113a5a6241daa40a6f3e888a940f40906fd29f7a36b8222da371cde9876988efafa8ae9bab3b7a89431"} 16:39:15 INFO - Running post-run listener: copy_logs_to_upload_dir 16:39:15 INFO - Copying logs to upload dir... 16:39:15 INFO - mkdir: /builds/slave/test/build/upload/logs 16:39:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.892359 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-07 16:39:15.746922) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-07 16:39:15.750843) ========= 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.zzCVye8LLu/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.IOLaueycMX/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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/83db88b561af496de1741df4a837411988acb533d400bdf16e4d1aef0ffaabb63bdd9d5c9424d9ef54ed67e44647266bcda661734756e90edd0db29f577ee90c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7aae1b71e1e28693c8da4b431876df4af7518ef548df2945d91611540c43b55bd572ea91e3781e1179a0242e14be15e86848b3650608635cfe4728d5c35dbb09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f2108e056440f6035f86987cd401bb0cd0fcceb89860113a5a6241daa40a6f3e888a940f40906fd29f7a36b8222da371cde9876988efafa8ae9bab3b7a89431"} build_url:https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011065 build_url: 'https://queue.taskcluster.net/v1/task/ePrADVYjQRiDjL4I6CryZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83db88b561af496de1741df4a837411988acb533d400bdf16e4d1aef0ffaabb63bdd9d5c9424d9ef54ed67e44647266bcda661734756e90edd0db29f577ee90c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7aae1b71e1e28693c8da4b431876df4af7518ef548df2945d91611540c43b55bd572ea91e3781e1179a0242e14be15e86848b3650608635cfe4728d5c35dbb09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f2108e056440f6035f86987cd401bb0cd0fcceb89860113a5a6241daa40a6f3e888a940f40906fd29f7a36b8222da371cde9876988efafa8ae9bab3b7a89431"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-07 16:39:15.784177) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 16:39:15.784515) ========= 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.zzCVye8LLu/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.IOLaueycMX/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.005144 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 16:39:15.833637) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-07 16:39:15.833976) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-07 16:39:15.834332) ========= ========= Total master_lag: 0.18 =========