builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0171 starttime: 1485969998.69 results: success (0) buildid: 20170201075009 builduid: a01cb9dc5a3e477aa752e3637331c867 revision: d13a909fc8a10c8a691f4fc386b290a995d18f32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 09:26:38.688340) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 09:26:38.688761) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 09:26:38.689040) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 09:26:38.715253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:26:38.715572) ========= 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.SEhsj4Innu/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.Kw0Ab6SZIW/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-01 09:26:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 39.6M=0s 2017-02-01 09:26:38 (39.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119900 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:26:38.861452) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:26:38.861769) ========= 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.SEhsj4Innu/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.Kw0Ab6SZIW/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.020716 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:26:38.911232) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:26:38.911567) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d13a909fc8a10c8a691f4fc386b290a995d18f32 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d13a909fc8a10c8a691f4fc386b290a995d18f32 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SEhsj4Innu/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.Kw0Ab6SZIW/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-01 09:26:39,000 truncating revision to first 12 chars 2017-02-01 09:26:39,000 Setting DEBUG logging. 2017-02-01 09:26:39,000 attempt 1/10 2017-02-01 09:26:39,000 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d13a909fc8a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-01 09:26:39,653 unpacking tar archive at: mozilla-beta-d13a909fc8a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.904666 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:26:39.842175) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 09:26:39.845521) ========= script_repo_revision: d13a909fc8a10c8a691f4fc386b290a995d18f32 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 09:26:39.845897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 09:26:39.846161) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 09:26:39.865729) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-01 09:26:39.865999) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SEhsj4Innu/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.Kw0Ab6SZIW/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 09:26:40 INFO - MultiFileLogger online at 20170201 09:26:40 in /builds/slave/test 09:26:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:26:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:26:40 INFO - {'append_to_log': False, 09:26:40 INFO - 'base_work_dir': '/builds/slave/test', 09:26:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:26:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:26:40 INFO - 'branch': 'Mozilla-Beta', 09:26:40 INFO - 'buildbot_json_path': 'buildprops.json', 09:26:40 INFO - 'config_files': ('talos/mac_config.py',), 09:26:40 INFO - 'default_actions': ('clobber', 09:26:40 INFO - 'read-buildbot-config', 09:26:40 INFO - 'download-and-extract', 09:26:40 INFO - 'populate-webroot', 09:26:40 INFO - 'create-virtualenv', 09:26:40 INFO - 'install', 09:26:40 INFO - 'run-tests'), 09:26:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:26:40 INFO - 'download_minidump_stackwalk': True, 09:26:40 INFO - 'download_symbols': 'ondemand', 09:26:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:26:40 INFO - 'tooltool.py': '/tools/tooltool.py', 09:26:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:26:40 INFO - '/tools/misc-python/virtualenv.py')}, 09:26:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:26:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:26:40 INFO - 'installer_path': 'installer.exe', 09:26:40 INFO - 'log_level': 'info', 09:26:40 INFO - 'log_name': 'talos', 09:26:40 INFO - 'log_to_console': True, 09:26:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:26:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:26:40 INFO - 'opt_config_files': (), 09:26:40 INFO - 'pip_index': False, 09:26:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:26:40 INFO - 'cmd': ('bash', 09:26:40 INFO - '-c', 09:26:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:26:40 INFO - 'enabled': True, 09:26:40 INFO - 'halt_on_failure': False, 09:26:40 INFO - 'name': 'check_screen_resolution'},), 09:26:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:26:40 INFO - 'cmd': ('bash', 09:26:40 INFO - '-c', 09:26:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:26:40 INFO - 'enabled': True, 09:26:40 INFO - 'halt_on_failure': False, 09:26:40 INFO - 'name': 'check_screen_resolution'},), 09:26:40 INFO - 'run_cmd_checks_enabled': True, 09:26:40 INFO - 'sps_profile': False, 09:26:40 INFO - 'sps_profile_interval': 0, 09:26:40 INFO - 'suite': 'dromaeojs', 09:26:40 INFO - 'system_bits': '32', 09:26:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:26:40 INFO - 'title': 't-yosemite-r7-0171', 09:26:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:26:40 INFO - 'use_talos_json': True, 09:26:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:26:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:26:40 INFO - 'work_dir': 'build'} 09:26:40 INFO - [mozharness: 2017-02-01 17:26:40.096195Z] Running clobber step. 09:26:40 INFO - Running pre-action listener: _resource_record_pre_action 09:26:40 INFO - Running main action method: clobber 09:26:40 INFO - rmtree: /builds/slave/test/build 09:26:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:26:41 INFO - Running post-action listener: _resource_record_post_action 09:26:41 INFO - [mozharness: 2017-02-01 17:26:41.845608Z] Finished clobber step (success) 09:26:41 INFO - [mozharness: 2017-02-01 17:26:41.845741Z] Running read-buildbot-config step. 09:26:41 INFO - Running pre-action listener: _resource_record_pre_action 09:26:41 INFO - Running main action method: read_buildbot_config 09:26:41 INFO - Using buildbot properties: 09:26:41 INFO - { 09:26:41 INFO - "project": "", 09:26:41 INFO - "product": "firefox", 09:26:41 INFO - "script_repo_revision": "production", 09:26:41 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:26:41 INFO - "repository": "", 09:26:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:26:41 INFO - "buildid": "20170201075009", 09:26:41 INFO - "pgo_build": "False", 09:26:41 INFO - "basedir": "/builds/slave/test", 09:26:41 INFO - "buildnumber": 28, 09:26:41 INFO - "slavename": "t-yosemite-r7-0171", 09:26:41 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:26:41 INFO - "platform": "yosemite_r7", 09:26:41 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:26:41 INFO - "branch": "mozilla-beta", 09:26:41 INFO - "repo_path": "releases/mozilla-beta", 09:26:41 INFO - "revision": "d13a909fc8a10c8a691f4fc386b290a995d18f32", 09:26:41 INFO - "stage_platform": "macosx64", 09:26:41 INFO - "builduid": "a01cb9dc5a3e477aa752e3637331c867", 09:26:41 INFO - "slavebuilddir": "test" 09:26:41 INFO - } 09:26:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 09:26:41 INFO - Running post-action listener: _resource_record_post_action 09:26:41 INFO - [mozharness: 2017-02-01 17:26:41.848944Z] Finished read-buildbot-config step (success) 09:26:41 INFO - [mozharness: 2017-02-01 17:26:41.849080Z] Running download-and-extract step. 09:26:41 INFO - Running pre-action listener: _resource_record_pre_action 09:26:41 INFO - Running main action method: download_and_extract 09:26:41 INFO - mkdir: /builds/slave/test/build/tests 09:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:41 INFO - trying https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 09:26:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:26:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 09:26:42 INFO - Downloaded 1165 bytes. 09:26:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:26:42 INFO - Using the following test package requirements: 09:26:42 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:26:42 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:26:42 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 09:26:42 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:26:42 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 09:26:42 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:26:42 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:26:42 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 09:26:42 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:26:42 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:26:42 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 09:26:42 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:26:42 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 09:26:42 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:26:42 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 09:26:42 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:26:42 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 09:26:42 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 09:26:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:26:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:26:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:26:43 INFO - Http code: 200 09:26:43 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 09:26:43 INFO - x-amz-cf-id: sdCQjKZNlT2rDLwDJvogBSnm17MwugKMzhO0TpY1W-G_pj1hGOA-vw== 09:26:43 INFO - x-amz-version-id: ogyzjyfBX1w6yzW01BKgHIEFO6djzrRd 09:26:43 INFO - Expected file size: 16090502 09:26:43 INFO - Obtained file size: 16090502 09:26:50 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:26:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:26:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:26:50 INFO - Fetch https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:26:50 INFO - Http code: 200 09:26:50 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 09:26:50 INFO - x-amz-cf-id: nZkL-vpBTNowogkUolAQHO_8OdtBayUoWgCBJ3ho3sfLg9lGdHAjYg== 09:26:50 INFO - x-amz-version-id: ogyzjyfBX1w6yzW01BKgHIEFO6djzrRd 09:26:51 INFO - Expected file size: 16090502 09:26:51 INFO - Obtained file size: 16090502 09:26:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 09:26:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 09:26:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 09:26:58 INFO - Http code: 200 09:26:58 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 09:26:58 INFO - x-amz-cf-id: h3hCQ0PdP9G6cNL8UliSq96cNCr1Y3YWAEy6QppoczTpW0-pNdzW1g== 09:26:58 INFO - x-amz-version-id: Y0eWnaIphU3RuG6aS_En3_y57Wrh.weX 09:26:58 INFO - Expected file size: 14403005 09:26:58 INFO - Obtained file size: 14403005 09:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:26:58 INFO - trying https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:26:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 09:26:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 09:27:01 INFO - Downloaded 82134410 bytes. 09:27:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:27:01 INFO - mkdir: /builds/slave/test/properties 09:27:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:27:01 INFO - Writing to file /builds/slave/test/properties/build_url 09:27:01 INFO - Contents: 09:27:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:27:01 INFO - Running post-action listener: _resource_record_post_action 09:27:01 INFO - Running post-action listener: set_extra_try_arguments 09:27:01 INFO - [mozharness: 2017-02-01 17:27:01.754680Z] Finished download-and-extract step (success) 09:27:01 INFO - [mozharness: 2017-02-01 17:27:01.754796Z] Running populate-webroot step. 09:27:01 INFO - Running pre-action listener: _resource_record_pre_action 09:27:01 INFO - Running main action method: populate_webroot 09:27:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:27:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:27:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:27:01 INFO - '--tppagecycles', 09:27:01 INFO - '7'], 09:27:01 INFO - 'tests': ['tsvgm']}}, 09:27:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:27:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:27:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:27:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:27:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:27:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:27:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:27:01 INFO - 'talos_options': ['--disable-e10s'], 09:27:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:27:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:27:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:27:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:27:01 INFO - 'talos_options': ['--disable-e10s'], 09:27:01 INFO - 'tests': ['damp', 'tps']}, 09:27:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:27:01 INFO - 'tests': ['damp', 'tps']}, 09:27:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:27:01 INFO - 'tests': ['dromaeo_dom']}, 09:27:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:27:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:27:01 INFO - 'tests': ['basic_compositor_video']}, 09:27:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:27:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:27:01 INFO - 'tests': ['a11yr', 09:27:01 INFO - 'ts_paint', 09:27:01 INFO - 'tpaint', 09:27:01 INFO - 'sessionrestore', 09:27:01 INFO - 'sessionrestore_no_auto_restore', 09:27:01 INFO - 'tabpaint']}, 09:27:01 INFO - 'other-e10s': {'tests': ['a11yr', 09:27:01 INFO - 'ts_paint', 09:27:01 INFO - 'tpaint', 09:27:01 INFO - 'sessionrestore', 09:27:01 INFO - 'sessionrestore_no_auto_restore', 09:27:01 INFO - 'tabpaint']}, 09:27:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:27:01 INFO - 'ts_paint', 09:27:01 INFO - 'tpaint', 09:27:01 INFO - 'sessionrestore', 09:27:01 INFO - 'sessionrestore_no_auto_restore', 09:27:01 INFO - 'tabpaint']}, 09:27:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:27:01 INFO - 'ts_paint', 09:27:01 INFO - 'tpaint', 09:27:01 INFO - 'sessionrestore', 09:27:01 INFO - 'sessionrestore_no_auto_restore', 09:27:01 INFO - 'tabpaint']}, 09:27:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:27:01 INFO - 'tests': ['a11yr', 09:27:01 INFO - 'ts_paint', 09:27:01 INFO - 'tpaint', 09:27:01 INFO - 'sessionrestore', 09:27:01 INFO - 'sessionrestore_no_auto_restore', 09:27:01 INFO - 'tabpaint']}, 09:27:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:27:01 INFO - 'tests': ['a11yr', 09:27:01 INFO - 'ts_paint', 09:27:01 INFO - 'tpaint', 09:27:01 INFO - 'sessionrestore', 09:27:01 INFO - 'sessionrestore_no_auto_restore', 09:27:01 INFO - 'tabpaint']}, 09:27:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:27:01 INFO - 'tests': ['tsvgx', 09:27:01 INFO - 'tsvgr_opacity', 09:27:01 INFO - 'tart', 09:27:01 INFO - 'tscrollx', 09:27:01 INFO - 'cart']}, 09:27:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:27:01 INFO - 'tsvgr_opacity', 09:27:01 INFO - 'tart', 09:27:01 INFO - 'tscrollx', 09:27:01 INFO - 'cart']}, 09:27:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:27:01 INFO - 'talos_options': ['--disable-e10s'], 09:27:01 INFO - 'tests': ['tp5o']}, 09:27:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:27:01 INFO - 'tests': ['tp5o']}, 09:27:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:27:01 INFO - 'talos_options': ['--disable-e10s', 09:27:01 INFO - '--xperf_path', 09:27:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:27:01 INFO - 'tests': ['tp5n']}, 09:27:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:27:01 INFO - 'talos_options': ['--xperf_path', 09:27:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:27:01 INFO - 'tests': ['tp5n']}}, 09:27:01 INFO - 'talos.zip': {'path': '', 09:27:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:27:01 INFO - Running post-action listener: _resource_record_post_action 09:27:01 INFO - [mozharness: 2017-02-01 17:27:01.773571Z] Finished populate-webroot step (success) 09:27:01 INFO - [mozharness: 2017-02-01 17:27:01.773679Z] Running create-virtualenv step. 09:27:01 INFO - Running pre-action listener: _resource_record_pre_action 09:27:01 INFO - Running main action method: create_virtualenv 09:27:01 INFO - Creating virtualenv /builds/slave/test/build/venv 09:27:01 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 09:27:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:27:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:27:01 INFO - Using real prefix '/tools/python27' 09:27:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:27:02 INFO - Installing distribute.............................................................................................................................................................................................done. 09:27:05 INFO - Installing pip.................done. 09:27:05 INFO - Return code: 0 09:27:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:27:05 INFO - Reading from file tmpfile_stdout 09:27:05 INFO - Output received: 09:27:05 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) 09:27:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:27:05 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')]} 09:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:05 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')]} 09:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:05 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 0x10a1b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a12e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c495cb9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109e32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.SEhsj4Innu/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.Kw0Ab6SZIW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 09:27:05 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 09:27:05 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 09:27:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SEhsj4Innu/Render', 09:27:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:05 INFO - 'HOME': '/Users/cltbld', 09:27:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:05 INFO - 'LOGNAME': 'cltbld', 09:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:05 INFO - 'MOZ_NO_REMOTE': '1', 09:27:05 INFO - 'NO_EM_RESTART': '1', 09:27:05 INFO - 'PAGER': '/bin/cat', 09:27:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:05 INFO - 'PWD': '/builds/slave/test', 09:27:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:05 INFO - 'SHELL': '/bin/bash', 09:27:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kw0Ab6SZIW/Listeners', 09:27:05 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:27:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:05 INFO - 'USER': 'cltbld', 09:27:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:05 INFO - 'XPC_FLAGS': '0x0', 09:27:05 INFO - 'XPC_SERVICE_NAME': '0', 09:27:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:05 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 09:27:05 INFO - Cleaning up... 09:27:05 INFO - Return code: 0 09:27:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:27:05 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')]} 09:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:05 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')]} 09:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:05 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 0x10a1b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a12e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c495cb9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109e32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.SEhsj4Innu/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.Kw0Ab6SZIW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 09:27:05 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 09:27:05 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 09:27:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SEhsj4Innu/Render', 09:27:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:05 INFO - 'HOME': '/Users/cltbld', 09:27:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:05 INFO - 'LOGNAME': 'cltbld', 09:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:05 INFO - 'MOZ_NO_REMOTE': '1', 09:27:05 INFO - 'NO_EM_RESTART': '1', 09:27:05 INFO - 'PAGER': '/bin/cat', 09:27:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:05 INFO - 'PWD': '/builds/slave/test', 09:27:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:05 INFO - 'SHELL': '/bin/bash', 09:27:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kw0Ab6SZIW/Listeners', 09:27:05 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:27:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:05 INFO - 'USER': 'cltbld', 09:27:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:05 INFO - 'XPC_FLAGS': '0x0', 09:27:05 INFO - 'XPC_SERVICE_NAME': '0', 09:27:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:06 INFO - Downloading/unpacking psutil>=3.1.1 09:27:06 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 09:27:06 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 09:27:06 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 09:27:06 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 09:27:06 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 09:27:06 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 09:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:27:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:27:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:27:09 INFO - Installing collected packages: psutil 09:27:09 INFO - Running setup.py install for psutil 09:27:09 INFO - building 'psutil._psutil_osx' extension 09:27:09 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 09:27:10 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 09:27:10 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 09:27:10 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 09:27:10 INFO - building 'psutil._psutil_posix' extension 09:27:10 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 09:27:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:27:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:27:10 INFO - ^ 09:27:10 INFO - 1 warning generated. 09:27:10 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 09:27:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:27:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:27:10 INFO - Successfully installed psutil 09:27:10 INFO - Cleaning up... 09:27:10 INFO - Return code: 0 09:27:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:27:10 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')]} 09:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:10 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')]} 09:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:10 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 0x10a1b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a12e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c495cb9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109e32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.SEhsj4Innu/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.Kw0Ab6SZIW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 09:27:10 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 09:27:10 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 09:27:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SEhsj4Innu/Render', 09:27:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:10 INFO - 'HOME': '/Users/cltbld', 09:27:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:10 INFO - 'LOGNAME': 'cltbld', 09:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:10 INFO - 'MOZ_NO_REMOTE': '1', 09:27:10 INFO - 'NO_EM_RESTART': '1', 09:27:10 INFO - 'PAGER': '/bin/cat', 09:27:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:10 INFO - 'PWD': '/builds/slave/test', 09:27:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:10 INFO - 'SHELL': '/bin/bash', 09:27:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kw0Ab6SZIW/Listeners', 09:27:10 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:27:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:10 INFO - 'USER': 'cltbld', 09:27:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:10 INFO - 'XPC_FLAGS': '0x0', 09:27:10 INFO - 'XPC_SERVICE_NAME': '0', 09:27:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:27:10 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 09:27:10 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 09:27:10 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 09:27:10 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 09:27:10 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 09:27:10 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 09:27:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:27:13 INFO - Installing collected packages: mozsystemmonitor 09:27:13 INFO - Running setup.py install for mozsystemmonitor 09:27:13 INFO - Successfully installed mozsystemmonitor 09:27:13 INFO - Cleaning up... 09:27:13 INFO - Return code: 0 09:27:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:27:13 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')]} 09:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:13 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')]} 09:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:13 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 0x10a1b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a12e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c495cb9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109e32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.SEhsj4Innu/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.Kw0Ab6SZIW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 09:27:13 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 09:27:13 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 09:27:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SEhsj4Innu/Render', 09:27:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:13 INFO - 'HOME': '/Users/cltbld', 09:27:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:13 INFO - 'LOGNAME': 'cltbld', 09:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:13 INFO - 'MOZ_NO_REMOTE': '1', 09:27:13 INFO - 'NO_EM_RESTART': '1', 09:27:13 INFO - 'PAGER': '/bin/cat', 09:27:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:13 INFO - 'PWD': '/builds/slave/test', 09:27:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:13 INFO - 'SHELL': '/bin/bash', 09:27:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kw0Ab6SZIW/Listeners', 09:27:13 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:27:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:13 INFO - 'USER': 'cltbld', 09:27:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:13 INFO - 'XPC_FLAGS': '0x0', 09:27:13 INFO - 'XPC_SERVICE_NAME': '0', 09:27:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:14 INFO - Downloading/unpacking jsonschema==2.5.1 09:27:14 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 09:27:14 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 09:27:14 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 09:27:14 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 09:27:14 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 09:27:14 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 09:27:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:27:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:27:16 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 09:27:16 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 09:27:16 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 09:27:16 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 09:27:16 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 09:27:16 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 09:27:17 INFO - Downloading functools32-3.2.3-2.tar.gz 09:27:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:27:17 INFO - warning: no files found matching '*.txt' 09:27:17 INFO - no previously-included directories found matching 'build' 09:27:17 INFO - no previously-included directories found matching 'dist' 09:27:17 INFO - no previously-included directories found matching '.git*' 09:27:17 INFO - Installing collected packages: jsonschema, functools32 09:27:17 INFO - Running setup.py install for functools32 09:27:17 INFO - warning: no files found matching '*.txt' 09:27:17 INFO - no previously-included directories found matching 'build' 09:27:17 INFO - no previously-included directories found matching 'dist' 09:27:17 INFO - no previously-included directories found matching '.git*' 09:27:17 INFO - Successfully installed jsonschema functools32 09:27:17 INFO - Cleaning up... 09:27:17 INFO - Return code: 0 09:27:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:27: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')]} 09:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27: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')]} 09:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:17 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 0x10a1b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a12e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c495cb9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109e32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.SEhsj4Innu/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.Kw0Ab6SZIW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 09:27:17 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 09:27:17 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 09:27:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SEhsj4Innu/Render', 09:27:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:17 INFO - 'HOME': '/Users/cltbld', 09:27:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:17 INFO - 'LOGNAME': 'cltbld', 09:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:17 INFO - 'MOZ_NO_REMOTE': '1', 09:27:17 INFO - 'NO_EM_RESTART': '1', 09:27:17 INFO - 'PAGER': '/bin/cat', 09:27:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:17 INFO - 'PWD': '/builds/slave/test', 09:27:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:17 INFO - 'SHELL': '/bin/bash', 09:27:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kw0Ab6SZIW/Listeners', 09:27:17 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:27:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:17 INFO - 'USER': 'cltbld', 09:27:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:17 INFO - 'XPC_FLAGS': '0x0', 09:27:17 INFO - 'XPC_SERVICE_NAME': '0', 09:27:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:27:17 INFO - Cleaning up... 09:27:17 INFO - Return code: 0 09:27:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:27: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')]} 09:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27: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')]} 09:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:17 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 0x10a1b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a12e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c495cb9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109e32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.SEhsj4Innu/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.Kw0Ab6SZIW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 09:27:17 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 09:27:17 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 09:27:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SEhsj4Innu/Render', 09:27:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:17 INFO - 'HOME': '/Users/cltbld', 09:27:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:17 INFO - 'LOGNAME': 'cltbld', 09:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:17 INFO - 'MOZ_NO_REMOTE': '1', 09:27:17 INFO - 'NO_EM_RESTART': '1', 09:27:17 INFO - 'PAGER': '/bin/cat', 09:27:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:17 INFO - 'PWD': '/builds/slave/test', 09:27:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:17 INFO - 'SHELL': '/bin/bash', 09:27:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kw0Ab6SZIW/Listeners', 09:27:17 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:27:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:17 INFO - 'USER': 'cltbld', 09:27:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:17 INFO - 'XPC_FLAGS': '0x0', 09:27:17 INFO - 'XPC_SERVICE_NAME': '0', 09:27:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:18 INFO - Downloading/unpacking blobuploader==1.2.4 09:27:18 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 09:27:18 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 09:27:18 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 09:27:18 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 09:27:18 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 09:27:18 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 09:27:20 INFO - Downloading blobuploader-1.2.4.tar.gz 09:27:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:27:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:27:20 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 09:27:20 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 09:27:20 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 09:27:20 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 09:27:20 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 09:27:20 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 09:27:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:27:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:27:21 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 09:27:21 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 09:27:21 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 09:27:21 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 09:27:21 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 09:27:21 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 09:27:22 INFO - Downloading docopt-0.6.1.tar.gz 09:27:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:27:22 INFO - Installing collected packages: blobuploader, requests, docopt 09:27:22 INFO - Running setup.py install for blobuploader 09:27:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:27:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:27:22 INFO - Running setup.py install for requests 09:27:22 INFO - Running setup.py install for docopt 09:27:22 INFO - Successfully installed blobuploader requests docopt 09:27:22 INFO - Cleaning up... 09:27:23 INFO - Return code: 0 09:27:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:23 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 0x10a1b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a12e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c495cb9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109e32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.SEhsj4Innu/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.Kw0Ab6SZIW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 09:27:23 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 09:27:23 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 09:27:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SEhsj4Innu/Render', 09:27:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:23 INFO - 'HOME': '/Users/cltbld', 09:27:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:23 INFO - 'LOGNAME': 'cltbld', 09:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:23 INFO - 'MOZ_NO_REMOTE': '1', 09:27:23 INFO - 'NO_EM_RESTART': '1', 09:27:23 INFO - 'PAGER': '/bin/cat', 09:27:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:23 INFO - 'PWD': '/builds/slave/test', 09:27:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:23 INFO - 'SHELL': '/bin/bash', 09:27:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kw0Ab6SZIW/Listeners', 09:27:23 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:27:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:23 INFO - 'USER': 'cltbld', 09:27:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:23 INFO - 'XPC_FLAGS': '0x0', 09:27:23 INFO - 'XPC_SERVICE_NAME': '0', 09:27:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:27:23 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-2dPNdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:27:23 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-HmEKsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:27:23 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-MntBly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:27:23 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-dQLmjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:27:23 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-pXZDJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:27:23 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-v6ohFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:27:23 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-D2gjZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:27:23 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-LEE6dH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:27:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-OqCN4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:27:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-uoxns6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:27:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-O478EQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:27:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-6pI4kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:27:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-ivgyLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:27:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-59deiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-QrRScl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:27:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-G_RAnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:27:24 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-EoEEnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:27:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:27:24 INFO - Running setup.py install for manifestparser 09:27:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:27:25 INFO - Running setup.py install for mozcrash 09:27:25 INFO - Running setup.py install for mozdebug 09:27:25 INFO - Running setup.py install for mozdevice 09:27:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:27:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:27:25 INFO - Running setup.py install for mozfile 09:27:25 INFO - Running setup.py install for mozhttpd 09:27:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:27:25 INFO - Running setup.py install for mozinfo 09:27:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:27:25 INFO - Running setup.py install for mozInstall 09:27:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:27:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:27:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:27:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:27:26 INFO - Running setup.py install for mozleak 09:27:26 INFO - Running setup.py install for mozlog 09:27:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:27:26 INFO - Running setup.py install for moznetwork 09:27:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:27:26 INFO - Running setup.py install for mozprocess 09:27:26 INFO - Running setup.py install for mozprofile 09:27:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:27:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:27:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:27:26 INFO - Running setup.py install for mozrunner 09:27:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:27:27 INFO - Running setup.py install for mozscreenshot 09:27:27 INFO - Running setup.py install for moztest 09:27:27 INFO - Running setup.py install for mozversion 09:27:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:27:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:27:27 INFO - Cleaning up... 09:27:27 INFO - Return code: 0 09:27:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:27 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 0x10a1b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a12e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c495cb9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109e32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.SEhsj4Innu/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.Kw0Ab6SZIW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 09:27:27 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 09:27:27 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 09:27:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SEhsj4Innu/Render', 09:27:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:27 INFO - 'HOME': '/Users/cltbld', 09:27:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:27 INFO - 'LOGNAME': 'cltbld', 09:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:27 INFO - 'MOZ_NO_REMOTE': '1', 09:27:27 INFO - 'NO_EM_RESTART': '1', 09:27:27 INFO - 'PAGER': '/bin/cat', 09:27:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:27 INFO - 'PWD': '/builds/slave/test', 09:27:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:27 INFO - 'SHELL': '/bin/bash', 09:27:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kw0Ab6SZIW/Listeners', 09:27:27 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:27:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:27 INFO - 'USER': 'cltbld', 09:27:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:27 INFO - 'XPC_FLAGS': '0x0', 09:27:27 INFO - 'XPC_SERVICE_NAME': '0', 09:27:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:27:27 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-BA8KCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:27:27 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)) 09:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:27:27 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-E5rVsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:27:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:27:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-kr_Gra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:27:28 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)) 09:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:27:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-Z0QXUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:27:28 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)) 09:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:27:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-0sZIoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:27:28 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)) 09:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:27:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-4iewtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:27:28 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)) 09:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:27:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-rdI8He-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:27:28 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)) 09:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:27:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-x7T6D3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:27:28 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)) 09:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:27:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-C1s2MC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:27:28 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)) 09:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:27:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-ULbPoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:27:28 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)) 09:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:27:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-CrC2UY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:27:28 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)) 09:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:27:28 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-GqKuZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:27:29 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)) 09:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:27:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-zZlYhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:27:29 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)) 09:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:27:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-osZO34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-WIEQRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:27:29 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)) 09:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:27:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-JIH2cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:27:29 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-54ztHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:27:29 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)) 09:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:27:29 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)) 09:27:29 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)) 09:27:29 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)) 09:27:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:27:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:27:32 INFO - Downloading blessings-1.6.tar.gz 09:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:27:32 INFO - Installing collected packages: blessings 09:27:32 INFO - Running setup.py install for blessings 09:27:32 INFO - Successfully installed blessings 09:27:32 INFO - Cleaning up... 09:27:32 INFO - Return code: 0 09:27:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:27:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:27:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:27:32 INFO - Reading from file tmpfile_stdout 09:27:32 INFO - Current package versions: 09:27:32 INFO - blessings == 1.6 09:27:32 INFO - blobuploader == 1.2.4 09:27:32 INFO - docopt == 0.6.1 09:27:32 INFO - functools32 == 3.2.3-2 09:27:32 INFO - jsonschema == 2.5.1 09:27:32 INFO - manifestparser == 1.1 09:27:32 INFO - mozInstall == 1.12 09:27:32 INFO - mozcrash == 1.0 09:27:32 INFO - mozdebug == 0.1 09:27:32 INFO - mozdevice == 0.48 09:27:32 INFO - mozfile == 1.2 09:27:32 INFO - mozhttpd == 0.7 09:27:32 INFO - mozinfo == 0.9 09:27:32 INFO - mozleak == 0.1 09:27:32 INFO - mozlog == 3.4 09:27:32 INFO - moznetwork == 0.27 09:27:32 INFO - mozprocess == 0.23 09:27:32 INFO - mozprofile == 0.28 09:27:32 INFO - mozrunner == 6.13 09:27:32 INFO - mozscreenshot == 0.1 09:27:32 INFO - mozsystemmonitor == 0.3 09:27:32 INFO - moztest == 0.8 09:27:32 INFO - mozversion == 1.4 09:27:32 INFO - psutil == 3.1.1 09:27:32 INFO - requests == 1.2.3 09:27:32 INFO - wsgiref == 0.1.2 09:27:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27: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')]} 09:27:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:33 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 0x10a1b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a12e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c495cb9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109e32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.SEhsj4Innu/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.Kw0Ab6SZIW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 09:27:33 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 09:27:33 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 09:27:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SEhsj4Innu/Render', 09:27:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:33 INFO - 'HOME': '/Users/cltbld', 09:27:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:33 INFO - 'LOGNAME': 'cltbld', 09:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:33 INFO - 'MOZ_NO_REMOTE': '1', 09:27:33 INFO - 'NO_EM_RESTART': '1', 09:27:33 INFO - 'PAGER': '/bin/cat', 09:27:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:33 INFO - 'PWD': '/builds/slave/test', 09:27:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:33 INFO - 'SHELL': '/bin/bash', 09:27:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kw0Ab6SZIW/Listeners', 09:27:33 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:27:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:33 INFO - 'USER': 'cltbld', 09:27:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:33 INFO - 'XPC_FLAGS': '0x0', 09:27:33 INFO - 'XPC_SERVICE_NAME': '0', 09:27:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:33 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)) 09:27:33 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)) 09:27:33 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)) 09:27:33 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)) 09:27:33 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)) 09:27:33 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)) 09:27:33 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)) 09:27:33 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)) 09:27:33 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)) 09:27:33 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)) 09:27:33 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)) 09:27:33 INFO - Cleaning up... 09:27:33 INFO - Return code: 0 09:27:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:27: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')]} 09:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:27:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27: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')]} 09:27:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:27:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:27:34 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 0x10a1b8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a12e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c495cb9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109fccd30>, '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 0x109e32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, '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.SEhsj4Innu/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.Kw0Ab6SZIW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 09:27:34 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 09:27:34 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 09:27:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SEhsj4Innu/Render', 09:27:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:34 INFO - 'HOME': '/Users/cltbld', 09:27:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:34 INFO - 'LOGNAME': 'cltbld', 09:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:34 INFO - 'MOZ_NO_REMOTE': '1', 09:27:34 INFO - 'NO_EM_RESTART': '1', 09:27:34 INFO - 'PAGER': '/bin/cat', 09:27:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:34 INFO - 'PWD': '/builds/slave/test', 09:27:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:34 INFO - 'SHELL': '/bin/bash', 09:27:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kw0Ab6SZIW/Listeners', 09:27:34 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:27:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:34 INFO - 'USER': 'cltbld', 09:27:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:34 INFO - 'XPC_FLAGS': '0x0', 09:27:34 INFO - 'XPC_SERVICE_NAME': '0', 09:27:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:27:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:27:34 INFO - Cleaning up... 09:27:34 INFO - Return code: 0 09:27:34 INFO - Running post-action listener: _resource_record_post_action 09:27:34 INFO - Running post-action listener: _start_resource_monitoring 09:27:34 INFO - Starting resource monitoring. 09:27:34 INFO - [mozharness: 2017-02-01 17:27:34.636729Z] Finished create-virtualenv step (success) 09:27:34 INFO - [mozharness: 2017-02-01 17:27:34.637760Z] Running install step. 09:27:34 INFO - Running pre-action listener: _resource_record_pre_action 09:27:34 INFO - Running main action method: install 09:27:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:27:34 INFO - Reading from file tmpfile_stdout 09:27:34 INFO - Detecting whether we're running mozinstall >=1.0... 09:27:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:27:34 INFO - Reading from file tmpfile_stdout 09:27:34 INFO - Output received: 09:27:34 INFO - Usage: mozinstall [options] installer 09:27:34 INFO - Options: 09:27:34 INFO - -h, --help show this help message and exit 09:27:34 INFO - -d DEST, --destination=DEST 09:27:34 INFO - Directory to install application into. [default: 09:27:34 INFO - "/builds/slave/test"] 09:27:34 INFO - --app=APP Application being installed. [default: firefox] 09:27:34 INFO - mkdir: /builds/slave/test/build/application 09:27:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:27:56 INFO - Reading from file tmpfile_stdout 09:27:56 INFO - Output received: 09:27:56 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:27:56 INFO - Running post-action listener: _resource_record_post_action 09:27:56 INFO - [mozharness: 2017-02-01 17:27:56.446828Z] Finished install step (success) 09:27:56 INFO - [mozharness: 2017-02-01 17:27:56.446982Z] Running run-tests step. 09:27:56 INFO - Running pre-action listener: _resource_record_pre_action 09:27:56 INFO - Running main action method: run_tests 09:27:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:27:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:27:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:27:56 INFO - 2017-02-01 09:27:56.461 screenresolution[1907:14960] starting screenresolution argv=screenresolution get 09:27:56 INFO - 2017-02-01 09:27:56.464 screenresolution[1907:14960] Display 0: 1600x1200x32@60 09:27:56 INFO - 2017-02-01 09:27:56.469 screenresolution[1908:14962] starting screenresolution argv=screenresolution list 09:27:56 INFO - Available Modes on Display 0 09:27:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:27:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:27:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:27:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:27:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:27:56 INFO - Intel Iris: 09:27:56 INFO - Chipset Model: Intel Iris 09:27:56 INFO - Type: GPU 09:27:56 INFO - Bus: Built-In 09:27:56 INFO - VRAM (Dynamic, Max): 1536 MB 09:27:56 INFO - Vendor: Intel (0x8086) 09:27:56 INFO - Device ID: 0x0a2e 09:27:56 INFO - Revision ID: 0x0009 09:27:56 INFO - Displays: 09:27:56 INFO - Display: 09:27:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:27:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:27:56 INFO - Display Serial Number: 1600x1200 60 09:27:56 INFO - Main Display: Yes 09:27:56 INFO - Mirror: Off 09:27:56 INFO - Online: Yes 09:27:56 INFO - Rotation: Supported 09:27:56 INFO - Return code: 0 09:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:27:56 INFO - Python 2.7.3 09:27:56 INFO - Return code: 0 09:27:56 INFO - grabbing minidump binary from tooltool 09:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:27:56 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 0x109fccd30>, '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 0x109e32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109fc4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:27:56 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 09:27:56 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 09:27:56 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 09:27:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:27:56 INFO - Return code: 0 09:27:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:27:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:27:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:27:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:27:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0171', '--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 09:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0171 --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 09:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SEhsj4Innu/Render', 09:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:56 INFO - 'HOME': '/Users/cltbld', 09:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:56 INFO - 'LOGNAME': 'cltbld', 09:27:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:27:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:56 INFO - 'MOZ_NO_REMOTE': '1', 09:27:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:27:56 INFO - 'NO_EM_RESTART': '1', 09:27:56 INFO - 'PAGER': '/bin/cat', 09:27:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:56 INFO - 'PWD': '/builds/slave/test', 09:27:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:56 INFO - 'SHELL': '/bin/bash', 09:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Kw0Ab6SZIW/Listeners', 09:27:56 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 09:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:56 INFO - 'USER': 'cltbld', 09:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:56 INFO - 'XPC_FLAGS': '0x0', 09:27:56 INFO - 'XPC_SERVICE_NAME': '0', 09:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0171', '--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 09:27:57 INFO - mozversion application_buildid: 20170201075009 09:27:57 INFO - mozversion application_changeset: d13a909fc8a10c8a691f4fc386b290a995d18f32 09:27:57 INFO - mozversion application_display_name: Firefox 09:27:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:27:57 INFO - mozversion application_name: Firefox 09:27:57 INFO - mozversion application_remotingname: firefox 09:27:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:27:57 INFO - mozversion application_vendor: Mozilla 09:27:57 INFO - mozversion application_version: 52.0 09:27:57 INFO - mozversion platform_buildid: 20170201075009 09:27:57 INFO - mozversion platform_changeset: d13a909fc8a10c8a691f4fc386b290a995d18f32 09:27:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:27:57 INFO - mozversion platform_version: 52.0 09:27:57 INFO - using testdate: 1485970077 09:27:57 INFO - actual date: 1485970077 09:27:57 INFO - starting webserver on 'localhost:52815' 09:27:57 INFO - SUITE-START | Running 2 tests 09:27:57 INFO - TEST-START | dromaeo_css 09:27:57 INFO - operating with platform_type : mac_ 09:27:57 INFO - Initialising browser for dromaeo_css test... 09:27:57 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpLOFvyI/profile http://localhost:52815/getInfo.html) 09:27:59 INFO - PROCESS | 1918 | __metrics Screen width/height:1600/1200 09:27:59 INFO - PROCESS | 1918 | colorDepth:24 09:27:59 INFO - PROCESS | 1918 | Browser inner width/height: 1024/689 09:27:59 INFO - PROCESS | 1918 | __metrics 09:28:00 INFO - PROCESS | 1918 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:28:00 INFO - PROCESS | 1918 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:28:00 INFO - TEST-INFO | 1918: exit 0 09:28:00 INFO - Browser initialized. 09:28:00 INFO - Running cycle 1/1 for dromaeo_css test... 09:28:00 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpLOFvyI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:28:12 INFO - PROCESS | 1922 | RSS: Main: 168009728 09:28:12 INFO - PROCESS | 1922 | 09:31:16 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:52815/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52815/tests/dromaeo/cssquery-ext.html) 09:31:18 INFO - PROCESS | 1922 | RSS: Main: 358625280 09:31:18 INFO - PROCESS | 1922 | 09:34:21 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:52815/tests/dromaeo/cssquery-ext.html (next: http://localhost:52815/tests/dromaeo/cssquery-jquery.html) 09:34:21 INFO - PROCESS | 1922 | RSS: Main: 297091072 09:34:21 INFO - PROCESS | 1922 | 09:37:23 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:52815/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52815/tests/dromaeo/cssquery-mootools.html) 09:37:24 INFO - PROCESS | 1922 | RSS: Main: 284655616 09:37:24 INFO - PROCESS | 1922 | 09:40:26 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:52815/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52815/tests/dromaeo/cssquery-prototype.html) 09:40:27 INFO - PROCESS | 1922 | RSS: Main: 269459456 09:40:27 INFO - PROCESS | 1922 | 09:43:30 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:52815/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52815/tests/dromaeo/cssquery-yui.html) 09:43:31 INFO - PROCESS | 1922 | RSS: Main: 256610304 09:43:31 INFO - PROCESS | 1922 | 09:46:34 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:52815/tests/dromaeo/cssquery-yui.html (next: http://localhost:52815/tests/dromaeo/cssquery-dojo.html) 09:46:34 INFO - PROCESS | 1922 | RSS: Main: 344973312 09:46:34 INFO - PROCESS | 1922 | 09:46:34 INFO - PROCESS | 1922 | __start_tp_report 09:46:34 INFO - PROCESS | 1922 | _x_x_mozilla_page_load 09:46:34 INFO - PROCESS | 1922 | _x_x_mozilla_page_load_details 09:46:34 INFO - PROCESS | 1922 | |i|pagename|runs| 09:46:34 INFO - PROCESS | 1922 | |0;dojo.html;2935.5890175375453;3439.6560343965602;3459.2562599041203;3477.8608855645775;3529.699975502082;4061.7562946223247;5844.941550584504;5860.912086318709;5900.055991041434;5900.675462849542;5775.104858746901;5860.208871802305;5862.355140934505;5870.765169393219;5872;5251.86870328241;5278.049951008817;5282.867928301804;5298.1522956327;5339.946600534003;5230.084735171349;5244.213367994793;5253.159494480884;5294.708791016493;5374.5700343972385;5346.358436987567;5352.00987817255;5356.491133342326;5356.839294821161;5360.035193665139;5273.815416460425;5312.787488500456;5398.676079435247;5408.323959505062;5409.9459005409835;5246.554042906358;5327.360716713981;5337.332833395825;5353.197020446964;5378.408375078739;5689.487946084831;5737.254156959569;5759.625624334405;5950.553708471882;5965.522758179335;6206.720697568575;6217.3471785462325;6256.562040657156;6264.906026409608;6269.059641053833;6260.843478913018;6271.43557079865;6311.274203466614;6328.588641738273;6329.841753956188;5864.912026319608;5910.852228694274;6051.122587224916;6060.939390606126;6085.421884920926;6255.874882502325;6258.092576576371;6263;6276.372362763687;6394.936050639434;6267.749290028439;6271.749130034747;6286.057091436322;6291.465225455796;6307.3377295383325;6145.784897528565;6306.873862522815;6313.210848643919;6313.968430157912;6334.081558174131;6158.353372895782;6165.260168779685;6244.781432649836;6254.249490061222;6271.592346497463;6282.151909492251;6282.937170628326;6287.842803929847;6296.937030629727;6312.715927783261;5045.697258164449;5082.1360368737405;5097.286379906816;5126.128558145124;5129.512696293921;4456.977715111404;4485.372047913294;4500;4529.818807247739;4544.272916333437;5931.406859314034;5995.130706047686;6008.819735407945;6020.518358531307;6051.850148471776;6269.122322874801;6281.623102613858;6294.748210071637;6297.590656607306;6332.8416789579705;5630.40880707528;5757.8560535986935;5928.703564821828;5937.732802023919;5977.22296101504;5489.478499542537;5518.972405137949;5536.640118392372;5542.7782888684005;5550.333959924835;6288.717007734755;6295.276043255084;6299.30707622152;6301.936980630135;6321.8735625288155;6232.532560057924;6254.499640028877;6279.780207692709;6298.527610429144;6302.054691796267;6438.90341644885;6443.581167224115;6443.838904027437;6445.484361250995;6477;6176.413240742122;6230.7819226326865;6349.07938348946;6367.745290188341;6368.617882927039;6288.119663247057;6329.525285603506;6341.302456729663;6342.302346741947;6347.873042539216;6170.136180934583;6190.597611155261;6255.280642725963;6269;6306.527010474141;5309.65487243328;6300.243970723543;6314.494840412664;6336.809895703136;6339.270983836917;6169.691515424301;6186.752529898754;6225.719842607003;6228.314885362697;6232.626042437287;6124.564025909317;6167.568270221221;6190.81427557174;6201.534884883562;6308.873822523616;6144.310314663325;6179.0422484514975;6188.566800323934;6199.132121503083;6212.06818977157 09:46:34 INFO - PROCESS | 1922 | |1;ext.html;460.4750584333862;468.91325104855605;521.9008388406204;527.2486706443317;550.6971165858777;25058.624120638204;33155.66844331562;33190.66809331909;33192.834035829845;33286;33784.49323260153;34391.65608343916;34451;42120.78939605306;43229;9537.1893389062;9711.854322185172;9720.416774993488;9725.221982241404;9728.221742260603;9576;9690.079442452956;9698.127168554829;9700.466474343908;9703.660371886985;8945.01604823469;9095.408798428081;9678.37090589113;9751.219902407825;11605.361705106216;11496.310221386744;11822.527098916076;11850.822237666442;11860.110491713156;11867.52529898803;11695.35675537845;11781.057515398748;11785.351805650685;11786.58746943853;11791.11566632506;40331;40534;40560.594394055974;40611;40764.38853417201;3292.773062556747;3366.309906469168;3480.3561341151717;3579.391503444421;3754.7371683982133;25916.833742481635;29275.70724292751;29668.406631867456;30560.54159187614;30786.692133078606;2881.8991335303162;3258.7393008559256;3267.8529466174077;3274.492453669685;3285.4250506161325;487631;490168;491628.54185728845;492296;492457.9999999964;34384.140396490286;34620;34650.13374665603;61226;61855.381446185864;35359.40882660286;35626.93119206428;35715.285694285965;35735;35788.46317305243;15009.024413413312;15153.848461515243;15170.393184272505;15182.013169143971;15197.924010380098;12736.108472407028;12840.357982100857;12858.871411285767;12867;12880.162789418659;7897.289243968071;7899.921000790034;7925.445218834741;7962.960185199037;7998.880016799752;3141.607299087614;3167.445697003015;3170.873165073371;3213.1485156433564;3224.3873664003763;955.617752898846;1007.7531004903846;1040.1003132290514;1054.5254635413942;1061.2465149743614;29479.841027820046;30240.69759302423;30374.69625303763;30544.847275763925;31080;1045.3048722599538;1073.0825144501496;1113.0539041814393;1130.282270758058;1144.862616486027;15681.05913645185;15834;15893.284802183929;16022.67954640924;16169;597302;707359;709033;710111;711269;59395.40604593899;59885.401145987984;59984.40015599875;60076;60252.698736506034;1262.444524409257;1305.8824705776526;1365.9590212293647;1379.7378498085332;1413.922234277104;30002.849985750803;31194.68805311918;31360.529592055682;31459.100189261793;31963.680363196072;48903.021939561724;49715;49723.75138124286;49758.75120624374;49770.502294976584;517575.412122937;524395;524783;820435;842172;26895.78968946363;27029.72970270272;27304.317392064564;27308.726912731414;27598.862005690647;46028.8492787683;46492.767536163454;46626.53373466222;46906.82732931704;47042;38764;38944.61055389523;39563.80218099006;39712;40618.79690601646;39117;39261;39431.21137577175;40388.394174086825;40713.59286407098;38574;38581.8425447237;39126;39412.60587394089;39512;29258.098223615296;33381.83309083536;34632.13419664528;35271.294574108884;35300;25160.37099072538;25573.87213063923;25944;26044.34889127787;26104.73895261099 09:46:34 INFO - PROCESS | 1922 | |2;jquery.html;384.70570013939334;386.7679392364582;389.3595036165506;398.243337658449;416.6458510266274;14453.78319325211;20324.796752032475;21135.47161320964;21637;21663.916804159788;16348.346066157339;18085.09574521275;20721.378358649265;20755.68866467004;20758.27346042889;5718.142278658193;6062.4543791058795;6063.120847477136;6071.848203794918;6081.422264884851;5767.336756273019;5923.229980102602;6004.309504406983;6005.00917348637;6012.75948962041;5920.911186332209;5948.107783832438;5953.196318497013;5958.493528050121;5958.702064896738;5696;5893.970530147343;5959.970200148993;5969.104634304846;5975.193348897887;4781.497942716034;5011.972545628174;5145.408278047998;5245.527902488756;5265.894682106375;25979.090731824483;26481.205563833115;26876;27086.45827083467;27161.04936327239;2369.5497855407416;2423.87880605969;2523.1169090818066;2769.141566114511;2869.1553318553238;15707.057576545443;16134;16229;16859.66280674392;16872.90326128798;1907.6661584222707;1986.1161783006569;1994.3817416600755;2004.5990801839691;2007.5884443689008;113937;116860;117229.99999999914;117351;118828;9401.623935042659;10886.564537418573;11186.944065279622;11259.662210133709;11693.239939403911;14284.857151428352;14373;14376.784348234785;14388.640283992983;14400.567982960529;7837.7648670539975;8258.018075661797;8265.669373225124;8375.916240837636;8610.784730381665;8117.756467305991;8295.211954864399;8840.778980525538;8890.4665720057;8967.192952634165;5930.932432162166;6811.318868113248;6954.200266969363;6978.546394484444;6996.510244282851;1460.9481173555023;1811.5923917118807;1865.990670046641;1866.8133186681223;1888.5845114074882;814.3078383374203;956.8804498736495;1002.4336250018862;1036.362636978268;1037.2894567221476;22022.669659955114;22497.325080247618;22721.772782272295;22839.31482055541;22927.7707222929;961.8028304197622;983.5475681186591;1014.1227837920294;1040.0587468341164;1104.138771758014;11901;12039.699007524881;12186.756264874653;12218.816717749241;12232.81650775239;519157;520485;521795;572548;625724;82957.58521207355;99036.01927961544;99752.50371244438;118019;135243.99999999802;974.5663179884883;983.3362480325894;1001.8497225416246;1048.4600430778155;1049.454283772434;19236.557258205412;19745.506362340482;19881.30415435453;20012.49968750793;20097.59804803925;38993.27047106675;39501.802490987364;52352.95294094173;55281;55817;69402.2649433748;74107.25892741003;75823.62088189524;80203.19796801958;81877.77183342374;7267.527610705287;7326.194118647051;7508.737194198176;7751;7945.920540794518;11393.373364465035;12652.240865548096;12769.489220431078;13118.540851070167;13135.868641313464;9383.953080234554;11129.888701112885;11205.943970280423;11435.428228588371;11452.312861228353;10844.566217351217;10977.066949309397;11068.335899846035;11297;11427.60003399877;11262.099032077578;11274.661760147208;11389.715257118638;11415.169660678643;11664.708382290512;6190.81427557174;7322.1579518356075;7490.962545187239;7536.547807131589;7757.961210193913;8594.699185528476;10835.241533092609;10981.83527247076;11085.667429977113;11588.47851846652 09:46:34 INFO - PROCESS | 1922 | |3;mootools.html;1492.8208614966206;1538;1689.771880796093;1807.9728804067934;1854.7959724430302;7954;7998.200179981999;8369.246767790897;8381.413301068927;8381.748547543568;6811.216710078343;7699.615019249043;7704.075510938681;8067.878981815277;8222.794430139249;2349.1190803448662;2389.940251493718;2390.784829365357;2391.6651668766385;2400.31590996566;2373.679553260305;2413.987930060347;2414.396400899775;2415.3961509622595;2417.419819243378;2356.752540983198;2365.195833416638;2387.6537902004197;2388.95222095558;2393.258089992108;2346.6128088865316;2346.9061237550563;2373.8813059346962;2374.79814215791;2377.9048838046456;2366.514864452783;2367.6448532720055;2387.1167667962964;2393.557191919483;2398;8284.8343033139;8477.406581539295;8498.830023399498;8499.277561407287;8499.787505312355;5060.291559181717;5223.686578805284;5227.60792940531;5231.032259032053;5232.476752324776;3394.8472318745467;3438.0889064397957;3475.7045651119433;3493.982530087333;3515.1212196950764;1015.629295307215;1018.6842078955548;1023.3757407981126;1026.2918586175515;1051.4281149681199;10749.946250268698;10880.564777408894;10884.564617415293;10890.455477226185;10930.234883558154;4471.530489298641;4599.563041511051;4675.532446755297;4686.062787442525;4740.857774266778;9488.240940724725;9499.952500237592;9504.097110774464;9527.142557169887;9530.046995300554;5264.31563896691;5264.52619264268;5265.868353291122;5268.157094864803;5275.050490911596;4321.58944900234;4372.846950356722;4747.477777444478;4817.253325734517;4863.124637565202;3791.75353602015;3824.2351529694174;3885.4948856648457;3929.174873276587;3963.246983073207;1203.2299328429813;1213.8118591618313;1215.1615385384057;1216.689744115245;1224.2287358963795;802.835418739157;863.7236084453041;893.7140115163215;897.9057198994011;904.8552231642906;5466.316710411199;5474.91787623186;5490.341159060858;5576.191452239403;5857.121431785181;443.3195045604981;451.26669162610756;455.69696152059174;455.6992385025867;457.54702844184015;3835.0987517933263;3839.9808000959815;3899.0447340401784;3905.5703872573995;3932.744371615836;8581.828363432822;9719.493478510842;9822.705318840446;10065.993400660022;10156.441395723159;8943.23982461485;10000.699979000641;10189.949050254701;10199.796004079877;10207.285490015627;7804.882926756103;7846.843063138819;7900.8543761154315;7983.401244906655;7994.120646728855;5490.972545137409;5494.917576236279;5664.660120392789;5708.714564271853;5791.247137872049;9270.933842608187;9334;9367.625294988124;9438.764030899283;9504.144626983605;9467;9571.234301256021;9583.616655333708;9584.28117891175;9635.277354198603;5977.671228082323;6540.901886471802;6740.325967403221;7138.39323657495;7209.963950180216;7868.6065696713795;8028.31759300466;8042.356611470951;8060.919390806017;8061.113277539584;6045.727942242697;7196.460265480215;7205.495615306878;7229.602371869387;7338.96330518344;6873.312668733287;6959.868059373201;7050.400715939202;7067.116610423697;7075;6708.02733603615;6709.563878347892;6797.694103765243;6803.829904252433;6808.080909077409;4844.588210002189;4882.60939124862;4888.926666100083;4915.311856340187;4930.778114984906;4784.545468180518;4806.206975848946;4896.853094407031;4995.325631039763;4996.650234483552 09:46:34 INFO - PROCESS | 1922 | |4;prototype.html;265.83119718978446;311.6384993407646;317.4920127795527;323.3484528674721;325.60926887734723;4560.429946256718;4860.954894697639;5308.071087559681;5378.838634840956;5416.837494875155;4396.736195828253;4500.942278564535;4874.366332376786;5065.745743144303;5314.787408503656;3522.4990256917617;3802.1255111324413;4034.293998550242;4087.6321131098193;4089.6484521400166;3518.1204698825295;3851.9184652278204;3919.8440857528244;4022.939655905164;4055.614716601918;3327.8169700666454;4008.5590585035625;4014.799260037001;4046.2109888571595;4083.4487344208596;3604.4953706480983;3750.1374683822737;3990.880273591768;4028.6231123636903;4035.435039094529;3364.747643926715;3511.7892926424242;3516.384632689295;3517.402041652925;3548.3919319300294;4290.957090429087;4579.28276896164;4990.550850423443;5143.431253467691;5194.584433245369;4607.285870690049;4619.983603607201;4656.301554766812;4659.138059459011;4662.3239630253765;4572.719638501225;5248.632595718302;5638.154276858463;5638.857234251;5664.433556644344;3156.731677807389;3894.3184942635207;3900.843966241347;3918.098837267416;3922.8430862765454;4982.380726263978;5903.49820265278;6027.819165425044;6033;6044.129038706579;3303.091649796277;3917.981324855558;3960.346542820402;3965.1276719121747;3966.3257246268204;3352.865885364558;3859.2281543691374;4034.253663072341;4047.817848196838;4055.830130879965;4191.874243772691;4548.2722764358205;4570.337301091323;4618.930716039262;4687.531246875354;4667.806131118369;4675.696079754805;5361.785528578813;5609.27079479665;5668.858278543069;1169.9590514331958;1208.567847101188;1229.373019759911;1240.7034648792035;1268.1440027981075;808.2200676347236;831.501099340391;839.5592314035058;868.4181598329135;889.5196593839383;4041.6766658667234;4658.790354434059;4919.17990343568;4950.094213727669;4965.627577931669;4627.722336659744;4784.736839473862;4933.618586795703;5148.510891465305;5453.7277633419635;4414.887504309454;4718.386609740781;4900.362952816111;5004.649674522749;5377.768226186167;2565.448428587825;2643.4316621926378;2871.6984716604875;2880.8991685291335;2901.579271005692;4871.585915197177;5428.584279995364;5689.402612725604;5701.800436984686;5712;4554.203014472454;5025.160784156939;5527.917081243784;5621.297337832771;5622.32532096151;4830.951690483121;4954.5499950054655;5152.768125434364;5641.379448260688;5721.197822685841;4937.1113199624415;5103;5448.918266225931;5471.5924993002955;5472.539879997789;5021.5229553192385;5074.720890351066;5084.41529224144;5227.92158117621;5427.402985671494;5242.108841496878;5601.719914004365;5604.06659702402;5652.293463317085;5685.147227915846;3449.706774924059;3489.476578513243;3544.982275088711;3610.530631017951;3655.1958569114754;4662.067586482649;4987.376577927759;5051.610807028097;5453.26380938584;5473.343198816167;4287.97856010718;4794.400699912511;5273.6572122811895;5284.550813180923;5317.388500322512;4278.850240241577;5045.344105266292;5149.176131818891;5317.335333083364;5346.9465305348;4640.651951103749;4904.994476132456;5145.273005307193;5400.216968539618;5431.4296998816135;4840.983393487266;5169.896602067863;5205.6616319939085;5598.944010560005;5656.151577263443;5330.520253177233;5512.614117011771;5534.363548192009;5540.196671482693;5543.362513311021 09:46:34 INFO - PROCESS | 1922 | |5;yui.html;621.4127649371344;719.3849258883654;793.7340990768092;833.1335411172381;837.8952630921135;15010.249487525622;15774.21128943554;15876.52370428886;15880.285387157577;15881.205939703012;14119.71760564788;14388.856111438883;14390.352434140463;14391.928040359784;14402.855971440282;701.1270967645289;720.8233982674252;721.5057685485433;846.547097302943;857.0872021297314;851.2721623012328;856.9828603427927;868.9044205137429;870.386377603791;870.9809522858271;922.239152699026;922.3820040572799;922.9400088994228;923.5843870258377;925.0980294213122;915.4964769376883;915.7756349694301;917.2707697380598;918.1323649151554;919.0120620333101;684.3635419060272;685.0888318536335;685.6708779785731;686.4131167851515;687.6149356360454;11482.827757583644;13831.51589694366;13875.098118622258;13933.930330348283;14997.775033374508;14333.889601418314;14651.780223296659;14710.55868323952;14753.631159220999;14803.259837008107;10736.409497477636;11306.37814920179;11508.194426390157;11879.34663593502;11974.221675591145;4613.331066995301;4658.324542941288;4727.503612120712;4826.7827947742435;4841.523335382707;88250.23499530037;89691.55154224187;89698;90701.54649226712;91566;9742.782152230971;10473.581056757797;10842.674719758419;10847.240693151562;10877.510512026978;18465;19602.70595941062;19736.210551578064;20176.798232017787;20179.890106044015;6685.598864068172;7692.846143077107;7706.922930770733;7809.2190780921455;7924.683012679544;4227.196832601796;4288.52826189119;4388;4504.256797628354;4539.319102134707;3294.58817647794;3358.916027099342;3361.1261072121424;3404.029851492313;3407;642.1170890026214;644.336333576417;647.1263793878227;653.1998302080009;654.3554598720257;574.5662025170969;575.2607898849958;599.008640699634;625.8842114208886;640.0303540136697;7605.315521603082;8640;8880.378373513791;8972.282217422591;9075.591598378089;623.7941479311817;633.3856159525253;638.6232123047424;639.2680380963864;652.9575577587442;4125.50493940723;4366.912661746747;4387.780610969438;4429.247028005247;4456.554344565518;103305.93388132345;108703;116398;117046;117449;99064.51403228957;100220.99779002117;102945.48527257466;103117;104295;87742.41931855009;87952.12047879567;89502;94174.05825941653;95763.52118239364;7787.654566221338;8283.668653254044;8376.664933402595;8456;8796.340274479311;46129.76935115303;50732.74633626808;52132.73933630308;52256.47743522516;52457;63001.68499157475;68155;69666.65166674338;71843;74162;12723.300218488072;13037.47850085986;13308.600741977756;13370.997175211704;13457.259850708306;13606.659833504242;14464.638384040063;14663.853361466676;14705.485308014167;15214.315355808794;12855.29295888735;13175;13414.932925335701;13737.450501979809;13869.653258668613;13137.540186093442;13277.30008385121;13431.664208394868;13923;14039.087459315111;12276.263424194576;13012;13115.606531804062;13844.37700303509;13996.440142394598;11579.536818527165;11602.577239714135;11628;11777.587784427504;12079.637610871689;9862.901370986197;11452.942735286604;11491.48288327044;11615.128865334964;11702.239354441934 09:46:34 INFO - PROCESS | 1922 | __end_tp_report 09:46:34 INFO - PROCESS | 1922 | __start_cc_report 09:46:34 INFO - PROCESS | 1922 | _x_x_mozilla_cycle_collect,2044 09:46:34 INFO - PROCESS | 1922 | __end_cc_report 09:46:34 INFO - PROCESS | 1922 | __startTimestamp1485971194715__endTimestamp 09:46:34 INFO - PROCESS | 1922 | 09:46:34 INFO - PROCESS | 1922 | ------- Summary: start ------- 09:46:34 INFO - PROCESS | 1922 | Number of tests: 6 09:46:34 INFO - PROCESS | 1922 | 09:46:34 INFO - PROCESS | 1922 | [#0] dojo.html Cycles:165 Average:5846.79 Median:6169.69 stddev:658.77 (10.7%) stddev-sans-first:619.94 09:46:34 INFO - PROCESS | 1922 | Values: 2935.6 3439.7 3459.3 3477.9 3529.7 4061.8 5844.9 5860.9 5900.1 5900.7 5775.1 5860.2 5862.4 5870.8 5872.0 5251.9 5278.0 5282.9 5298.2 5339.9 5230.1 5244.2 5253.2 5294.7 5374.6 5346.4 5352.0 5356.5 5356.8 5360.0 5273.8 5312.8 5398.7 5408.3 5409.9 5246.6 5327.4 5337.3 5353.2 5378.4 5689.5 5737.3 5759.6 5950.6 5965.5 6206.7 6217.3 6256.6 6264.9 6269.1 6260.8 6271.4 6311.3 6328.6 6329.8 5864.9 5910.9 6051.1 6060.9 6085.4 6255.9 6258.1 6263.0 6276.4 6394.9 6267.7 6271.7 6286.1 6291.5 6307.3 6145.8 6306.9 6313.2 6314.0 6334.1 6158.4 6165.3 6244.8 6254.2 6271.6 6282.2 6282.9 6287.8 6296.9 6312.7 5045.7 5082.1 5097.3 5126.1 5129.5 4457.0 4485.4 4500.0 4529.8 4544.3 5931.4 5995.1 6008.8 6020.5 6051.9 6269.1 6281.6 6294.7 6297.6 6332.8 5630.4 5757.9 5928.7 5937.7 5977.2 5489.5 5519.0 5536.6 5542.8 5550.3 6288.7 6295.3 6299.3 6301.9 6321.9 6232.5 6254.5 6279.8 6298.5 6302.1 6438.9 6443.6 6443.8 6445.5 6477.0 6176.4 6230.8 6349.1 6367.7 6368.6 6288.1 6329.5 6341.3 6342.3 6347.9 6170.1 6190.6 6255.3 6269.0 6306.5 5309.7 6300.2 6314.5 6336.8 6339.3 6169.7 6186.8 6225.7 6228.3 6232.6 6124.6 6167.6 6190.8 6201.5 6308.9 6144.3 6179.0 6188.6 6199.1 6212.1 09:46:34 INFO - PROCESS | 1922 | 09:46:34 INFO - PROCESS | 1922 | [#1] ext.html Cycles:180 Average:71795.91 Median:19065.24 stddev:166844.12 (875.1%) stddev-sans-first:167226.19 09:46:34 INFO - PROCESS | 1922 | Values: 460.5 468.9 521.9 527.2 550.7 25058.6 33155.7 33190.7 33192.8 33286.0 33784.5 34391.7 34451.0 42120.8 43229.0 9537.2 9711.9 9720.4 9725.2 9728.2 9576.0 9690.1 9698.1 9700.5 9703.7 8945.0 9095.4 9678.4 9751.2 11605.4 11496.3 11822.5 11850.8 11860.1 11867.5 11695.4 11781.1 11785.4 11786.6 11791.1 40331.0 40534.0 40560.6 40611.0 40764.4 3292.8 3366.3 3480.4 3579.4 3754.7 25916.8 29275.7 29668.4 30560.5 30786.7 2881.9 3258.7 3267.9 3274.5 3285.4 487631.0 490168.0 491628.5 492296.0 492458.0 34384.1 34620.0 34650.1 61226.0 61855.4 35359.4 35626.9 35715.3 35735.0 35788.5 15009.0 15153.8 15170.4 15182.0 15197.9 12736.1 12840.4 12858.9 12867.0 12880.2 7897.3 7899.9 7925.4 7963.0 7998.9 3141.6 3167.4 3170.9 3213.1 3224.4 955.6 1007.8 1040.1 1054.5 1061.2 29479.8 30240.7 30374.7 30544.8 31080.0 1045.3 1073.1 1113.1 1130.3 1144.9 15681.1 15834.0 15893.3 16022.7 16169.0 597302.0 707359.0 709033.0 710111.0 711269.0 59395.4 59885.4 59984.4 60076.0 60252.7 1262.4 1305.9 1366.0 1379.7 1413.9 30002.8 31194.7 31360.5 31459.1 31963.7 48903.0 49715.0 49723.8 49758.8 49770.5 517575.4 524395.0 524783.0 820435.0 842172.0 26895.8 27029.7 27304.3 27308.7 27598.9 46028.8 46492.8 46626.5 46906.8 47042.0 38764.0 38944.6 39563.8 39712.0 40618.8 39117.0 39261.0 39431.2 40388.4 40713.6 38574.0 38581.8 39126.0 39412.6 39512.0 29258.1 33381.8 34632.1 35271.3 35300.0 25160.4 25573.9 25944.0 26044.3 26104.7 09:46:34 INFO - PROCESS | 1922 | 09:46:34 INFO - PROCESS | 1922 | [#2] jquery.html Cycles:180 Average:33228.38 Median:14251.10 stddev:92239.21 (647.2%) stddev-sans-first:92465.00 09:46:34 INFO - PROCESS | 1922 | Values: 384.7 386.8 389.4 398.2 416.6 14453.8 20324.8 21135.5 21637.0 21663.9 16348.3 18085.1 20721.4 20755.7 20758.3 5718.1 6062.5 6063.1 6071.8 6081.4 5767.3 5923.2 6004.3 6005.0 6012.8 5920.9 5948.1 5953.2 5958.5 5958.7 5696.0 5894.0 5960.0 5969.1 5975.2 4781.5 5012.0 5145.4 5245.5 5265.9 25979.1 26481.2 26876.0 27086.5 27161.0 2369.5 2423.9 2523.1 2769.1 2869.2 15707.1 16134.0 16229.0 16859.7 16872.9 1907.7 1986.1 1994.4 2004.6 2007.6 113937.0 116860.0 117230.0 117351.0 118828.0 9401.6 10886.6 11186.9 11259.7 11693.2 14284.9 14373.0 14376.8 14388.6 14400.6 7837.8 8258.0 8265.7 8375.9 8610.8 8117.8 8295.2 8840.8 8890.5 8967.2 5930.9 6811.3 6954.2 6978.5 6996.5 1460.9 1811.6 1866.0 1866.8 1888.6 814.3 956.9 1002.4 1036.4 1037.3 22022.7 22497.3 22721.8 22839.3 22927.8 961.8 983.5 1014.1 1040.1 1104.1 11901.0 12039.7 12186.8 12218.8 12232.8 519157.0 520485.0 521795.0 572548.0 625724.0 82957.6 99036.0 99752.5 118019.0 135244.0 974.6 983.3 1001.8 1048.5 1049.5 19236.6 19745.5 19881.3 20012.5 20097.6 38993.3 39501.8 52353.0 55281.0 55817.0 69402.3 74107.3 75823.6 80203.2 81877.8 7267.5 7326.2 7508.7 7751.0 7945.9 11393.4 12652.2 12769.5 13118.5 13135.9 9384.0 11129.9 11205.9 11435.4 11452.3 10844.6 10977.1 11068.3 11297.0 11427.6 11262.1 11274.7 11389.7 11415.2 11664.7 6190.8 7322.2 7491.0 7536.5 7758.0 8594.7 10835.2 10981.8 11085.7 11588.5 09:46:34 INFO - PROCESS | 1922 | 09:46:34 INFO - PROCESS | 1922 | [#3] mootools.html Cycles:180 Average:5438.54 Median:5028.47 stddev:2968.95 (59.0%) stddev-sans-first:2962.47 09:46:34 INFO - PROCESS | 1922 | Values: 1492.8 1538.0 1689.8 1808.0 1854.8 7954.0 7998.2 8369.2 8381.4 8381.7 6811.2 7699.6 7704.1 8067.9 8222.8 2349.1 2389.9 2390.8 2391.7 2400.3 2373.7 2414.0 2414.4 2415.4 2417.4 2356.8 2365.2 2387.7 2389.0 2393.3 2346.6 2346.9 2373.9 2374.8 2377.9 2366.5 2367.6 2387.1 2393.6 2398.0 8284.8 8477.4 8498.8 8499.3 8499.8 5060.3 5223.7 5227.6 5231.0 5232.5 3394.8 3438.1 3475.7 3494.0 3515.1 1015.6 1018.7 1023.4 1026.3 1051.4 10749.9 10880.6 10884.6 10890.5 10930.2 4471.5 4599.6 4675.5 4686.1 4740.9 9488.2 9500.0 9504.1 9527.1 9530.0 5264.3 5264.5 5265.9 5268.2 5275.1 4321.6 4372.8 4747.5 4817.3 4863.1 3791.8 3824.2 3885.5 3929.2 3963.2 1203.2 1213.8 1215.2 1216.7 1224.2 802.8 863.7 893.7 897.9 904.9 5466.3 5474.9 5490.3 5576.2 5857.1 443.3 451.3 455.7 455.7 457.5 3835.1 3840.0 3899.0 3905.6 3932.7 8581.8 9719.5 9822.7 10066.0 10156.4 8943.2 10000.7 10189.9 10199.8 10207.3 7804.9 7846.8 7900.9 7983.4 7994.1 5491.0 5494.9 5664.7 5708.7 5791.2 9270.9 9334.0 9367.6 9438.8 9504.1 9467.0 9571.2 9583.6 9584.3 9635.3 5977.7 6540.9 6740.3 7138.4 7210.0 7868.6 8028.3 8042.4 8060.9 8061.1 6045.7 7196.5 7205.5 7229.6 7339.0 6873.3 6959.9 7050.4 7067.1 7075.0 6708.0 6709.6 6797.7 6803.8 6808.1 4844.6 4882.6 4888.9 4915.3 4930.8 4784.5 4806.2 4896.9 4995.3 4996.7 09:46:34 INFO - PROCESS | 1922 | 09:46:34 INFO - PROCESS | 1922 | [#4] prototype.html Cycles:180 Average:4364.69 Median:4835.97 stddev:1323.62 (27.4%) stddev-sans-first:1291.09 09:46:34 INFO - PROCESS | 1922 | Values: 265.8 311.6 317.5 323.3 325.6 4560.4 4861.0 5308.1 5378.8 5416.8 4396.7 4500.9 4874.4 5065.7 5314.8 3522.5 3802.1 4034.3 4087.6 4089.6 3518.1 3851.9 3919.8 4022.9 4055.6 3327.8 4008.6 4014.8 4046.2 4083.4 3604.5 3750.1 3990.9 4028.6 4035.4 3364.7 3511.8 3516.4 3517.4 3548.4 4291.0 4579.3 4990.6 5143.4 5194.6 4607.3 4620.0 4656.3 4659.1 4662.3 4572.7 5248.6 5638.2 5638.9 5664.4 3156.7 3894.3 3900.8 3918.1 3922.8 4982.4 5903.5 6027.8 6033.0 6044.1 3303.1 3918.0 3960.3 3965.1 3966.3 3352.9 3859.2 4034.3 4047.8 4055.8 4191.9 4548.3 4570.3 4618.9 4687.5 4667.8 4675.7 5361.8 5609.3 5668.9 1170.0 1208.6 1229.4 1240.7 1268.1 808.2 831.5 839.6 868.4 889.5 4041.7 4658.8 4919.2 4950.1 4965.6 4627.7 4784.7 4933.6 5148.5 5453.7 4414.9 4718.4 4900.4 5004.6 5377.8 2565.4 2643.4 2871.7 2880.9 2901.6 4871.6 5428.6 5689.4 5701.8 5712.0 4554.2 5025.2 5527.9 5621.3 5622.3 4831.0 4954.5 5152.8 5641.4 5721.2 4937.1 5103.0 5448.9 5471.6 5472.5 5021.5 5074.7 5084.4 5227.9 5427.4 5242.1 5601.7 5604.1 5652.3 5685.1 3449.7 3489.5 3545.0 3610.5 3655.2 4662.1 4987.4 5051.6 5453.3 5473.3 4288.0 4794.4 5273.7 5284.6 5317.4 4278.9 5045.3 5149.2 5317.3 5346.9 4640.7 4905.0 5145.3 5400.2 5431.4 4841.0 5169.9 5205.7 5598.9 5656.2 5330.5 5512.6 5534.4 5540.2 5543.4 09:46:34 INFO - PROCESS | 1922 | 09:46:34 INFO - PROCESS | 1922 | [#5] yui.html Cycles:180 Average:20963.10 Median:4521.79 stddev:30831.83 (681.9%) stddev-sans-first:30880.49 09:46:34 INFO - PROCESS | 1922 | Values: 621.4 719.4 793.7 833.1 837.9 15010.2 15774.2 15876.5 15880.3 15881.2 14119.7 14388.9 14390.4 14391.9 14402.9 701.1 720.8 721.5 846.5 857.1 851.3 857.0 868.9 870.4 871.0 922.2 922.4 922.9 923.6 925.1 915.5 915.8 917.3 918.1 919.0 684.4 685.1 685.7 686.4 687.6 11482.8 13831.5 13875.1 13933.9 14997.8 14333.9 14651.8 14710.6 14753.6 14803.3 10736.4 11306.4 11508.2 11879.3 11974.2 4613.3 4658.3 4727.5 4826.8 4841.5 88250.2 89691.6 89698.0 90701.5 91566.0 9742.8 10473.6 10842.7 10847.2 10877.5 18465.0 19602.7 19736.2 20176.8 20179.9 6685.6 7692.8 7706.9 7809.2 7924.7 4227.2 4288.5 4388.0 4504.3 4539.3 3294.6 3358.9 3361.1 3404.0 3407.0 642.1 644.3 647.1 653.2 654.4 574.6 575.3 599.0 625.9 640.0 7605.3 8640.0 8880.4 8972.3 9075.6 623.8 633.4 638.6 639.3 653.0 4125.5 4366.9 4387.8 4429.2 4456.6 103305.9 108703.0 116398.0 117046.0 117449.0 99064.5 100221.0 102945.5 103117.0 104295.0 87742.4 87952.1 89502.0 94174.1 95763.5 7787.7 8283.7 8376.7 8456.0 8796.3 46129.8 50732.7 52132.7 52256.5 52457.0 63001.7 68155.0 69666.7 71843.0 74162.0 12723.3 13037.5 13308.6 13371.0 13457.3 13606.7 14464.6 14663.9 14705.5 15214.3 12855.3 13175.0 13414.9 13737.5 13869.7 13137.5 13277.3 13431.7 13923.0 14039.1 12276.3 13012.0 13115.6 13844.4 13996.4 11579.5 11602.6 11628.0 11777.6 12079.6 9862.9 11452.9 11491.5 11615.1 11702.2 09:46:34 INFO - PROCESS | 1922 | -------- Summary: end -------- 09:46:34 INFO - PROCESS | 1922 | 09:46:35 INFO - TEST-INFO | 1922: exit 0 09:46:35 INFO - TEST-OK | dromaeo_css | took 1118285ms 09:46:35 INFO - TEST-START | kraken 09:46:35 INFO - operating with platform_type : mac_ 09:46:35 INFO - Initialising browser for kraken test... 09:46:35 INFO - TEST-INFO | started process 1927 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpneBRTo/profile http://localhost:52815/getInfo.html) 09:46:37 INFO - PROCESS | 1927 | __metrics Screen width/height:1600/1200 09:46:37 INFO - PROCESS | 1927 | colorDepth:24 09:46:37 INFO - PROCESS | 1927 | Browser inner width/height: 1024/689 09:46:37 INFO - PROCESS | 1927 | __metrics 09:46:37 INFO - PROCESS | 1927 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:46:37 INFO - PROCESS | 1927 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:46:38 INFO - TEST-INFO | 1927: exit 0 09:46:38 INFO - Browser initialized. 09:46:38 INFO - Running cycle 1/1 for kraken test... 09:46:38 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpneBRTo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:50 INFO - PROCESS | 1929 | RSS: Main: 168038400 09:46:50 INFO - PROCESS | 1929 | 09:46:53 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52815/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52815/tests/kraken/driver.html?testName=audio-beat-detection) 09:46:54 INFO - PROCESS | 1929 | RSS: Main: 218931200 09:46:54 INFO - PROCESS | 1929 | 09:46:57 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52815/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52815/tests/kraken/driver.html?testName=audio-dft) 09:46:57 INFO - PROCESS | 1929 | RSS: Main: 231899136 09:46:57 INFO - PROCESS | 1929 | 09:47:00 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52815/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52815/tests/kraken/driver.html?testName=audio-fft) 09:47:01 INFO - PROCESS | 1929 | RSS: Main: 328011776 09:47:01 INFO - PROCESS | 1929 | 09:47:03 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52815/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52815/tests/kraken/driver.html?testName=audio-oscillator) 09:47:04 INFO - PROCESS | 1929 | RSS: Main: 233160704 09:47:04 INFO - PROCESS | 1929 | 09:47:06 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52815/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52815/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:47:06 INFO - PROCESS | 1929 | RSS: Main: 234110976 09:47:06 INFO - PROCESS | 1929 | 09:47:09 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52815/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52815/tests/kraken/driver.html?testName=imaging-darkroom) 09:47:10 INFO - PROCESS | 1929 | RSS: Main: 275263488 09:47:10 INFO - PROCESS | 1929 | 09:47:13 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52815/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52815/tests/kraken/driver.html?testName=imaging-desaturate) 09:47:13 INFO - PROCESS | 1929 | RSS: Main: 274182144 09:47:13 INFO - PROCESS | 1929 | 09:47:16 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52815/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52815/tests/kraken/driver.html?testName=json-parse-financial) 09:47:17 INFO - PROCESS | 1929 | RSS: Main: 270704640 09:47:17 INFO - PROCESS | 1929 | 09:47:18 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52815/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52815/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:47:19 INFO - PROCESS | 1929 | RSS: Main: 248823808 09:47:19 INFO - PROCESS | 1929 | 09:47:21 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52815/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52815/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:47:22 INFO - PROCESS | 1929 | RSS: Main: 247902208 09:47:22 INFO - PROCESS | 1929 | 09:47:24 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52815/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52815/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:47:24 INFO - PROCESS | 1929 | RSS: Main: 250589184 09:47:24 INFO - PROCESS | 1929 | 09:47:27 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52815/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52815/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:47:28 INFO - PROCESS | 1929 | RSS: Main: 261464064 09:47:28 INFO - PROCESS | 1929 | 09:47:31 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52815/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52815/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:47:31 INFO - PROCESS | 1929 | RSS: Main: 261652480 09:47:31 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52815/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52815/tests/kraken/driver.html?testName=ai-astar) 09:47:33 INFO - PROCESS | 1929 | RSS: Main: 305537024 09:47:33 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | __start_tp_report 09:47:33 INFO - PROCESS | 1929 | _x_x_mozilla_page_load 09:47:33 INFO - PROCESS | 1929 | _x_x_mozilla_page_load_details 09:47:33 INFO - PROCESS | 1929 | |i|pagename|runs| 09:47:33 INFO - PROCESS | 1929 | |0;ai-astar;103;113;113;113;113;114;114;113;115;127 09:47:33 INFO - PROCESS | 1929 | |1;audio-beat-detection;138;89;109;162;136;138;105;104;133;107 09:47:33 INFO - PROCESS | 1929 | |2;audio-dft;181;183;186;179;180;184;187;185;185;184 09:47:33 INFO - PROCESS | 1929 | |3;audio-fft;80;59;57;93;69;82;81;76;84;57 09:47:33 INFO - PROCESS | 1929 | |4;audio-oscillator;89;70;92;70;68;70;114;97;100;90 09:47:33 INFO - PROCESS | 1929 | |5;imaging-gaussian-blur;87;84;87;84;87;87;135;86;88;83 09:47:33 INFO - PROCESS | 1929 | |6;imaging-darkroom;93;93;108;151;93;93;96;94;92;94 09:47:33 INFO - PROCESS | 1929 | |7;imaging-desaturate;80;84;88;81;83;84;83;91;129;130 09:47:33 INFO - PROCESS | 1929 | |8;json-parse-financial;41;76;75;84;86;86;70;55;56;56 09:47:33 INFO - PROCESS | 1929 | |9;json-stringify-tinderbox;62;72;76;71;70;74;69;69;68;70 09:47:33 INFO - PROCESS | 1929 | |10;stanford-crypto-aes;81;81;82;82;82;80;82;80;81;82 09:47:33 INFO - PROCESS | 1929 | |11;stanford-crypto-ccm;135;137;137;147;153;135;142;139;191;165 09:47:33 INFO - PROCESS | 1929 | |12;stanford-crypto-pbkdf2;162;162;162;163;164;162;162;161;161;158 09:47:33 INFO - PROCESS | 1929 | |13;stanford-crypto-sha256-iterative;65;66;66;66;67;66;68;65;64;66 09:47:33 INFO - PROCESS | 1929 | __end_tp_report 09:47:33 INFO - PROCESS | 1929 | __start_cc_report 09:47:33 INFO - PROCESS | 1929 | _x_x_mozilla_cycle_collect,1879 09:47:33 INFO - PROCESS | 1929 | __end_cc_report 09:47:33 INFO - PROCESS | 1929 | __startTimestamp1485971253645__endTimestamp 09:47:33 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | ------- Summary: start ------- 09:47:33 INFO - PROCESS | 1929 | Number of tests: 14 09:47:33 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | [#0] ai-astar Cycles:10 Average:113.80 Median:113.50 stddev:5.73 (5.0%) stddev-sans-first:4.56 09:47:33 INFO - PROCESS | 1929 | Values: 103.0 113.0 113.0 113.0 113.0 114.0 114.0 113.0 115.0 127.0 09:47:33 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:137.00 stddev:22.42 (16.4%) stddev-sans-first:23.03 09:47:33 INFO - PROCESS | 1929 | Values: 138.0 89.0 109.0 162.0 136.0 138.0 105.0 104.0 133.0 107.0 09:47:33 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.50 stddev:2.63 (1.4%) stddev-sans-first:2.65 09:47:33 INFO - PROCESS | 1929 | Values: 181.0 183.0 186.0 179.0 180.0 184.0 187.0 185.0 185.0 184.0 09:47:33 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | [#3] audio-fft Cycles:10 Average:73.80 Median:80.50 stddev:12.66 (15.7%) stddev-sans-first:13.22 09:47:33 INFO - PROCESS | 1929 | Values: 80.0 59.0 57.0 93.0 69.0 82.0 81.0 76.0 84.0 57.0 09:47:33 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | [#4] audio-oscillator Cycles:10 Average:86.00 Median:79.50 stddev:15.83 (19.9%) stddev-sans-first:16.75 09:47:33 INFO - PROCESS | 1929 | Values: 89.0 70.0 92.0 70.0 68.0 70.0 114.0 97.0 100.0 90.0 09:47:33 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:87.00 stddev:15.62 (18.0%) stddev-sans-first:16.51 09:47:33 INFO - PROCESS | 1929 | Values: 87.0 84.0 87.0 84.0 87.0 87.0 135.0 86.0 88.0 83.0 09:47:33 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | [#6] imaging-darkroom Cycles:10 Average:100.70 Median:93.00 stddev:18.28 (19.7%) stddev-sans-first:19.18 09:47:33 INFO - PROCESS | 1929 | Values: 93.0 93.0 108.0 151.0 93.0 93.0 96.0 94.0 92.0 94.0 09:47:33 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | [#7] imaging-desaturate Cycles:10 Average:93.30 Median:83.50 stddev:19.35 (23.2%) stddev-sans-first:19.91 09:47:33 INFO - PROCESS | 1929 | Values: 80.0 84.0 88.0 81.0 83.0 84.0 83.0 91.0 129.0 130.0 09:47:33 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | [#8] json-parse-financial Cycles:10 Average:68.50 Median:75.50 stddev:15.65 (20.7%) stddev-sans-first:13.06 09:47:33 INFO - PROCESS | 1929 | Values: 41.0 76.0 75.0 84.0 86.0 86.0 70.0 55.0 56.0 56.0 09:47:33 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.50 stddev:3.75 (5.3%) stddev-sans-first:2.60 09:47:33 INFO - PROCESS | 1929 | Values: 62.0 72.0 76.0 71.0 70.0 74.0 69.0 69.0 68.0 70.0 09:47:33 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:82.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 09:47:33 INFO - PROCESS | 1929 | Values: 81.0 81.0 82.0 82.0 82.0 80.0 82.0 80.0 81.0 82.0 09:47:33 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:144.50 stddev:17.83 (12.3%) stddev-sans-first:18.27 09:47:33 INFO - PROCESS | 1929 | Values: 135.0 137.0 137.0 147.0 153.0 135.0 142.0 139.0 191.0 165.0 09:47:33 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.00 stddev:1.57 (1.0%) stddev-sans-first:1.66 09:47:33 INFO - PROCESS | 1929 | Values: 162.0 162.0 162.0 163.0 164.0 162.0 162.0 161.0 161.0 158.0 09:47:33 INFO - PROCESS | 1929 | 09:47:33 INFO - PROCESS | 1929 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.12 09:47:33 INFO - PROCESS | 1929 | Values: 65.0 66.0 66.0 66.0 67.0 66.0 68.0 65.0 64.0 66.0 09:47:33 INFO - PROCESS | 1929 | -------- Summary: end -------- 09:47:33 INFO - PROCESS | 1929 | 09:47:34 INFO - TEST-INFO | 1929: exit 0 09:47:34 INFO - TEST-OK | kraken | took 59446ms 09:47:34 INFO - SUITE-END | took 1177s 09:47:34 INFO - Completed test suite (00:19:37) 09:47:34 INFO - javascript benchmark 09:47:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2935.5890175375453, 3439.6560343965602, 3459.2562599041203, 3477.8608855645775, 3529.699975502082, 4061.7562946223247, 5844.941550584504, 5860.912086318709, 5900.055991041434, 5900.675462849542, 5775.104858746901, 5860.208871802305, 5862.355140934505, 5870.765169393219, 5872.0, 5251.86870328241, 5278.049951008817, 5282.867928301804, 5298.1522956327, 5339.946600534003, 5230.084735171349, 5244.213367994793, 5253.159494480884, 5294.708791016493, 5374.5700343972385, 5346.358436987567, 5352.00987817255, 5356.491133342326, 5356.839294821161, 5360.035193665139, 5273.815416460425, 5312.787488500456, 5398.676079435247, 5408.323959505062, 5409.9459005409835, 5246.554042906358, 5327.360716713981, 5337.332833395825, 5353.197020446964, 5378.408375078739, 5689.487946084831, 5737.254156959569, 5759.625624334405, 5950.553708471882, 5965.522758179335, 6206.720697568575, 6217.3471785462325, 6256.562040657156, 6264.906026409608, 6269.059641053833, 6260.843478913018, 6271.43557079865, 6311.274203466614, 6328.588641738273, 6329.841753956188, 5864.912026319608, 5910.852228694274, 6051.122587224916, 6060.939390606126, 6085.421884920926, 6255.874882502325, 6258.092576576371, 6263.0, 6276.372362763687, 6394.936050639434, 6267.749290028439, 6271.749130034747, 6286.057091436322, 6291.465225455796, 6307.3377295383325, 6145.784897528565, 6306.873862522815, 6313.210848643919, 6313.968430157912, 6334.081558174131, 6158.353372895782, 6165.260168779685, 6244.781432649836, 6254.249490061222, 6271.592346497463, 6282.151909492251, 6282.937170628326, 6287.842803929847, 6296.937030629727, 6312.715927783261, 5045.697258164449, 5082.1360368737405, 5097.286379906816, 5126.128558145124, 5129.512696293921, 4456.977715111404, 4485.372047913294, 4500.0, 4529.818807247739, 4544.272916333437, 5931.406859314034, 5995.130706047686, 6008.819735407945, 6020.518358531307, 6051.850148471776, 6269.122322874801, 6281.623102613858, 6294.748210071637, 6297.590656607306, 6332.8416789579705, 5630.40880707528, 5757.8560535986935, 5928.703564821828, 5937.732802023919, 5977.22296101504, 5489.478499542537, 5518.972405137949, 5536.640118392372, 5542.7782888684005, 5550.333959924835, 6288.717007734755, 6295.276043255084, 6299.30707622152, 6301.936980630135, 6321.8735625288155, 6232.532560057924, 6254.499640028877, 6279.780207692709, 6298.527610429144, 6302.054691796267, 6438.90341644885, 6443.581167224115, 6443.838904027437, 6445.484361250995, 6477.0, 6176.413240742122, 6230.7819226326865, 6349.07938348946, 6367.745290188341, 6368.617882927039, 6288.119663247057, 6329.525285603506, 6341.302456729663, 6342.302346741947, 6347.873042539216, 6170.136180934583, 6190.597611155261, 6255.280642725963, 6269.0, 6306.527010474141, 5309.65487243328, 6300.243970723543, 6314.494840412664, 6336.809895703136, 6339.270983836917, 6169.691515424301, 6186.752529898754, 6225.719842607003, 6228.314885362697, 6232.626042437287, 6124.564025909317, 6167.568270221221, 6190.81427557174, 6201.534884883562, 6308.873822523616, 6144.310314663325, 6179.0422484514975, 6188.566800323934, 6199.132121503083, 6212.06818977157], "value": 5804.64822390381, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.4750584333862, 468.91325104855605, 521.9008388406204, 527.2486706443317, 550.6971165858777, 25058.624120638204, 33155.66844331562, 33190.66809331909, 33192.834035829845, 33286.0, 33784.49323260153, 34391.65608343916, 34451.0, 42120.78939605306, 43229.0, 9537.1893389062, 9711.854322185172, 9720.416774993488, 9725.221982241404, 9728.221742260603, 9576.0, 9690.079442452956, 9698.127168554829, 9700.466474343908, 9703.660371886985, 8945.01604823469, 9095.408798428081, 9678.37090589113, 9751.219902407825, 11605.361705106216, 11496.310221386744, 11822.527098916076, 11850.822237666442, 11860.110491713156, 11867.52529898803, 11695.35675537845, 11781.057515398748, 11785.351805650685, 11786.58746943853, 11791.11566632506, 40331.0, 40534.0, 40560.594394055974, 40611.0, 40764.38853417201, 3292.773062556747, 3366.309906469168, 3480.3561341151717, 3579.391503444421, 3754.7371683982133, 25916.833742481635, 29275.70724292751, 29668.406631867456, 30560.54159187614, 30786.692133078606, 2881.8991335303162, 3258.7393008559256, 3267.8529466174077, 3274.492453669685, 3285.4250506161325, 487631.0, 490168.0, 491628.54185728845, 492296.0, 492457.9999999964, 34384.140396490286, 34620.0, 34650.13374665603, 61226.0, 61855.381446185864, 35359.40882660286, 35626.93119206428, 35715.285694285965, 35735.0, 35788.46317305243, 15009.024413413312, 15153.848461515243, 15170.393184272505, 15182.013169143971, 15197.924010380098, 12736.108472407028, 12840.357982100857, 12858.871411285767, 12867.0, 12880.162789418659, 7897.289243968071, 7899.921000790034, 7925.445218834741, 7962.960185199037, 7998.880016799752, 3141.607299087614, 3167.445697003015, 3170.873165073371, 3213.1485156433564, 3224.3873664003763, 955.617752898846, 1007.7531004903846, 1040.1003132290514, 1054.5254635413942, 1061.2465149743614, 29479.841027820046, 30240.69759302423, 30374.69625303763, 30544.847275763925, 31080.0, 1045.3048722599538, 1073.0825144501496, 1113.0539041814393, 1130.282270758058, 1144.862616486027, 15681.05913645185, 15834.0, 15893.284802183929, 16022.67954640924, 16169.0, 597302.0, 707359.0, 709033.0, 710111.0, 711269.0, 59395.40604593899, 59885.401145987984, 59984.40015599875, 60076.0, 60252.698736506034, 1262.444524409257, 1305.8824705776526, 1365.9590212293647, 1379.7378498085332, 1413.922234277104, 30002.849985750803, 31194.68805311918, 31360.529592055682, 31459.100189261793, 31963.680363196072, 48903.021939561724, 49715.0, 49723.75138124286, 49758.75120624374, 49770.502294976584, 517575.412122937, 524395.0, 524783.0, 820435.0, 842172.0, 26895.78968946363, 27029.72970270272, 27304.317392064564, 27308.726912731414, 27598.862005690647, 46028.8492787683, 46492.767536163454, 46626.53373466222, 46906.82732931704, 47042.0, 38764.0, 38944.61055389523, 39563.80218099006, 39712.0, 40618.79690601646, 39117.0, 39261.0, 39431.21137577175, 40388.394174086825, 40713.59286407098, 38574.0, 38581.8425447237, 39126.0, 39412.60587394089, 39512.0, 29258.098223615296, 33381.83309083536, 34632.13419664528, 35271.294574108884, 35300.0, 25160.37099072538, 25573.87213063923, 25944.0, 26044.34889127787, 26104.73895261099], "value": 18843.988935342717, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.70570013939334, 386.7679392364582, 389.3595036165506, 398.243337658449, 416.6458510266274, 14453.78319325211, 20324.796752032475, 21135.47161320964, 21637.0, 21663.916804159788, 16348.346066157339, 18085.09574521275, 20721.378358649265, 20755.68866467004, 20758.27346042889, 5718.142278658193, 6062.4543791058795, 6063.120847477136, 6071.848203794918, 6081.422264884851, 5767.336756273019, 5923.229980102602, 6004.309504406983, 6005.00917348637, 6012.75948962041, 5920.911186332209, 5948.107783832438, 5953.196318497013, 5958.493528050121, 5958.702064896738, 5696.0, 5893.970530147343, 5959.970200148993, 5969.104634304846, 5975.193348897887, 4781.497942716034, 5011.972545628174, 5145.408278047998, 5245.527902488756, 5265.894682106375, 25979.090731824483, 26481.205563833115, 26876.0, 27086.45827083467, 27161.04936327239, 2369.5497855407416, 2423.87880605969, 2523.1169090818066, 2769.141566114511, 2869.1553318553238, 15707.057576545443, 16134.0, 16229.0, 16859.66280674392, 16872.90326128798, 1907.6661584222707, 1986.1161783006569, 1994.3817416600755, 2004.5990801839691, 2007.5884443689008, 113937.0, 116860.0, 117229.99999999914, 117351.0, 118828.0, 9401.623935042659, 10886.564537418573, 11186.944065279622, 11259.662210133709, 11693.239939403911, 14284.857151428352, 14373.0, 14376.784348234785, 14388.640283992983, 14400.567982960529, 7837.7648670539975, 8258.018075661797, 8265.669373225124, 8375.916240837636, 8610.784730381665, 8117.756467305991, 8295.211954864399, 8840.778980525538, 8890.4665720057, 8967.192952634165, 5930.932432162166, 6811.318868113248, 6954.200266969363, 6978.546394484444, 6996.510244282851, 1460.9481173555023, 1811.5923917118807, 1865.990670046641, 1866.8133186681223, 1888.5845114074882, 814.3078383374203, 956.8804498736495, 1002.4336250018862, 1036.362636978268, 1037.2894567221476, 22022.669659955114, 22497.325080247618, 22721.772782272295, 22839.31482055541, 22927.7707222929, 961.8028304197622, 983.5475681186591, 1014.1227837920294, 1040.0587468341164, 1104.138771758014, 11901.0, 12039.699007524881, 12186.756264874653, 12218.816717749241, 12232.81650775239, 519157.0, 520485.0, 521795.0, 572548.0, 625724.0, 82957.58521207355, 99036.01927961544, 99752.50371244438, 118019.0, 135243.99999999802, 974.5663179884883, 983.3362480325894, 1001.8497225416246, 1048.4600430778155, 1049.454283772434, 19236.557258205412, 19745.506362340482, 19881.30415435453, 20012.49968750793, 20097.59804803925, 38993.27047106675, 39501.802490987364, 52352.95294094173, 55281.0, 55817.0, 69402.2649433748, 74107.25892741003, 75823.62088189524, 80203.19796801958, 81877.77183342374, 7267.527610705287, 7326.194118647051, 7508.737194198176, 7751.0, 7945.920540794518, 11393.373364465035, 12652.240865548096, 12769.489220431078, 13118.540851070167, 13135.868641313464, 9383.953080234554, 11129.888701112885, 11205.943970280423, 11435.428228588371, 11452.312861228353, 10844.566217351217, 10977.066949309397, 11068.335899846035, 11297.0, 11427.60003399877, 11262.099032077578, 11274.661760147208, 11389.715257118638, 11415.169660678643, 11664.708382290512, 6190.81427557174, 7322.1579518356075, 7490.962545187239, 7536.547807131589, 7757.961210193913, 8594.699185528476, 10835.241533092609, 10981.83527247076, 11085.667429977113, 11588.47851846652], "value": 9754.771830914595, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.8208614966206, 1538.0, 1689.771880796093, 1807.9728804067934, 1854.7959724430302, 7954.0, 7998.200179981999, 8369.246767790897, 8381.413301068927, 8381.748547543568, 6811.216710078343, 7699.615019249043, 7704.075510938681, 8067.878981815277, 8222.794430139249, 2349.1190803448662, 2389.940251493718, 2390.784829365357, 2391.6651668766385, 2400.31590996566, 2373.679553260305, 2413.987930060347, 2414.396400899775, 2415.3961509622595, 2417.419819243378, 2356.752540983198, 2365.195833416638, 2387.6537902004197, 2388.95222095558, 2393.258089992108, 2346.6128088865316, 2346.9061237550563, 2373.8813059346962, 2374.79814215791, 2377.9048838046456, 2366.514864452783, 2367.6448532720055, 2387.1167667962964, 2393.557191919483, 2398.0, 8284.8343033139, 8477.406581539295, 8498.830023399498, 8499.277561407287, 8499.787505312355, 5060.291559181717, 5223.686578805284, 5227.60792940531, 5231.032259032053, 5232.476752324776, 3394.8472318745467, 3438.0889064397957, 3475.7045651119433, 3493.982530087333, 3515.1212196950764, 1015.629295307215, 1018.6842078955548, 1023.3757407981126, 1026.2918586175515, 1051.4281149681199, 10749.946250268698, 10880.564777408894, 10884.564617415293, 10890.455477226185, 10930.234883558154, 4471.530489298641, 4599.563041511051, 4675.532446755297, 4686.062787442525, 4740.857774266778, 9488.240940724725, 9499.952500237592, 9504.097110774464, 9527.142557169887, 9530.046995300554, 5264.31563896691, 5264.52619264268, 5265.868353291122, 5268.157094864803, 5275.050490911596, 4321.58944900234, 4372.846950356722, 4747.477777444478, 4817.253325734517, 4863.124637565202, 3791.75353602015, 3824.2351529694174, 3885.4948856648457, 3929.174873276587, 3963.246983073207, 1203.2299328429813, 1213.8118591618313, 1215.1615385384057, 1216.689744115245, 1224.2287358963795, 802.835418739157, 863.7236084453041, 893.7140115163215, 897.9057198994011, 904.8552231642906, 5466.316710411199, 5474.91787623186, 5490.341159060858, 5576.191452239403, 5857.121431785181, 443.3195045604981, 451.26669162610756, 455.69696152059174, 455.6992385025867, 457.54702844184015, 3835.0987517933263, 3839.9808000959815, 3899.0447340401784, 3905.5703872573995, 3932.744371615836, 8581.828363432822, 9719.493478510842, 9822.705318840446, 10065.993400660022, 10156.441395723159, 8943.23982461485, 10000.699979000641, 10189.949050254701, 10199.796004079877, 10207.285490015627, 7804.882926756103, 7846.843063138819, 7900.8543761154315, 7983.401244906655, 7994.120646728855, 5490.972545137409, 5494.917576236279, 5664.660120392789, 5708.714564271853, 5791.247137872049, 9270.933842608187, 9334.0, 9367.625294988124, 9438.764030899283, 9504.144626983605, 9467.0, 9571.234301256021, 9583.616655333708, 9584.28117891175, 9635.277354198603, 5977.671228082323, 6540.901886471802, 6740.325967403221, 7138.39323657495, 7209.963950180216, 7868.6065696713795, 8028.31759300466, 8042.356611470951, 8060.919390806017, 8061.113277539584, 6045.727942242697, 7196.460265480215, 7205.495615306878, 7229.602371869387, 7338.96330518344, 6873.312668733287, 6959.868059373201, 7050.400715939202, 7067.116610423697, 7075.0, 6708.02733603615, 6709.563878347892, 6797.694103765243, 6803.829904252433, 6808.080909077409, 4844.588210002189, 4882.60939124862, 4888.926666100083, 4915.311856340187, 4930.778114984906, 4784.545468180518, 4806.206975848946, 4896.853094407031, 4995.325631039763, 4996.650234483552], "value": 4352.175805516429, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [265.83119718978446, 311.6384993407646, 317.4920127795527, 323.3484528674721, 325.60926887734723, 4560.429946256718, 4860.954894697639, 5308.071087559681, 5378.838634840956, 5416.837494875155, 4396.736195828253, 4500.942278564535, 4874.366332376786, 5065.745743144303, 5314.787408503656, 3522.4990256917617, 3802.1255111324413, 4034.293998550242, 4087.6321131098193, 4089.6484521400166, 3518.1204698825295, 3851.9184652278204, 3919.8440857528244, 4022.939655905164, 4055.614716601918, 3327.8169700666454, 4008.5590585035625, 4014.799260037001, 4046.2109888571595, 4083.4487344208596, 3604.4953706480983, 3750.1374683822737, 3990.880273591768, 4028.6231123636903, 4035.435039094529, 3364.747643926715, 3511.7892926424242, 3516.384632689295, 3517.402041652925, 3548.3919319300294, 4290.957090429087, 4579.28276896164, 4990.550850423443, 5143.431253467691, 5194.584433245369, 4607.285870690049, 4619.983603607201, 4656.301554766812, 4659.138059459011, 4662.3239630253765, 4572.719638501225, 5248.632595718302, 5638.154276858463, 5638.857234251, 5664.433556644344, 3156.731677807389, 3894.3184942635207, 3900.843966241347, 3918.098837267416, 3922.8430862765454, 4982.380726263978, 5903.49820265278, 6027.819165425044, 6033.0, 6044.129038706579, 3303.091649796277, 3917.981324855558, 3960.346542820402, 3965.1276719121747, 3966.3257246268204, 3352.865885364558, 3859.2281543691374, 4034.253663072341, 4047.817848196838, 4055.830130879965, 4191.874243772691, 4548.2722764358205, 4570.337301091323, 4618.930716039262, 4687.531246875354, 4667.806131118369, 4675.696079754805, 5361.785528578813, 5609.27079479665, 5668.858278543069, 1169.9590514331958, 1208.567847101188, 1229.373019759911, 1240.7034648792035, 1268.1440027981075, 808.2200676347236, 831.501099340391, 839.5592314035058, 868.4181598329135, 889.5196593839383, 4041.6766658667234, 4658.790354434059, 4919.17990343568, 4950.094213727669, 4965.627577931669, 4627.722336659744, 4784.736839473862, 4933.618586795703, 5148.510891465305, 5453.7277633419635, 4414.887504309454, 4718.386609740781, 4900.362952816111, 5004.649674522749, 5377.768226186167, 2565.448428587825, 2643.4316621926378, 2871.6984716604875, 2880.8991685291335, 2901.579271005692, 4871.585915197177, 5428.584279995364, 5689.402612725604, 5701.800436984686, 5712.0, 4554.203014472454, 5025.160784156939, 5527.917081243784, 5621.297337832771, 5622.32532096151, 4830.951690483121, 4954.5499950054655, 5152.768125434364, 5641.379448260688, 5721.197822685841, 4937.1113199624415, 5103.0, 5448.918266225931, 5471.5924993002955, 5472.539879997789, 5021.5229553192385, 5074.720890351066, 5084.41529224144, 5227.92158117621, 5427.402985671494, 5242.108841496878, 5601.719914004365, 5604.06659702402, 5652.293463317085, 5685.147227915846, 3449.706774924059, 3489.476578513243, 3544.982275088711, 3610.530631017951, 3655.1958569114754, 4662.067586482649, 4987.376577927759, 5051.610807028097, 5453.26380938584, 5473.343198816167, 4287.97856010718, 4794.400699912511, 5273.6572122811895, 5284.550813180923, 5317.388500322512, 4278.850240241577, 5045.344105266292, 5149.176131818891, 5317.335333083364, 5346.9465305348, 4640.651951103749, 4904.994476132456, 5145.273005307193, 5400.216968539618, 5431.4296998816135, 4840.983393487266, 5169.896602067863, 5205.6616319939085, 5598.944010560005, 5656.151577263443, 5330.520253177233, 5512.614117011771, 5534.363548192009, 5540.196671482693, 5543.362513311021], "value": 3944.9456662359553, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.4127649371344, 719.3849258883654, 793.7340990768092, 833.1335411172381, 837.8952630921135, 15010.249487525622, 15774.21128943554, 15876.52370428886, 15880.285387157577, 15881.205939703012, 14119.71760564788, 14388.856111438883, 14390.352434140463, 14391.928040359784, 14402.855971440282, 701.1270967645289, 720.8233982674252, 721.5057685485433, 846.547097302943, 857.0872021297314, 851.2721623012328, 856.9828603427927, 868.9044205137429, 870.386377603791, 870.9809522858271, 922.239152699026, 922.3820040572799, 922.9400088994228, 923.5843870258377, 925.0980294213122, 915.4964769376883, 915.7756349694301, 917.2707697380598, 918.1323649151554, 919.0120620333101, 684.3635419060272, 685.0888318536335, 685.6708779785731, 686.4131167851515, 687.6149356360454, 11482.827757583644, 13831.51589694366, 13875.098118622258, 13933.930330348283, 14997.775033374508, 14333.889601418314, 14651.780223296659, 14710.55868323952, 14753.631159220999, 14803.259837008107, 10736.409497477636, 11306.37814920179, 11508.194426390157, 11879.34663593502, 11974.221675591145, 4613.331066995301, 4658.324542941288, 4727.503612120712, 4826.7827947742435, 4841.523335382707, 88250.23499530037, 89691.55154224187, 89698.0, 90701.54649226712, 91566.0, 9742.782152230971, 10473.581056757797, 10842.674719758419, 10847.240693151562, 10877.510512026978, 18465.0, 19602.70595941062, 19736.210551578064, 20176.798232017787, 20179.890106044015, 6685.598864068172, 7692.846143077107, 7706.922930770733, 7809.2190780921455, 7924.683012679544, 4227.196832601796, 4288.52826189119, 4388.0, 4504.256797628354, 4539.319102134707, 3294.58817647794, 3358.916027099342, 3361.1261072121424, 3404.029851492313, 3407.0, 642.1170890026214, 644.336333576417, 647.1263793878227, 653.1998302080009, 654.3554598720257, 574.5662025170969, 575.2607898849958, 599.008640699634, 625.8842114208886, 640.0303540136697, 7605.315521603082, 8640.0, 8880.378373513791, 8972.282217422591, 9075.591598378089, 623.7941479311817, 633.3856159525253, 638.6232123047424, 639.2680380963864, 652.9575577587442, 4125.50493940723, 4366.912661746747, 4387.780610969438, 4429.247028005247, 4456.554344565518, 103305.93388132345, 108703.0, 116398.0, 117046.0, 117449.0, 99064.51403228957, 100220.99779002117, 102945.48527257466, 103117.0, 104295.0, 87742.41931855009, 87952.12047879567, 89502.0, 94174.05825941653, 95763.52118239364, 7787.654566221338, 8283.668653254044, 8376.664933402595, 8456.0, 8796.340274479311, 46129.76935115303, 50732.74633626808, 52132.73933630308, 52256.47743522516, 52457.0, 63001.68499157475, 68155.0, 69666.65166674338, 71843.0, 74162.0, 12723.300218488072, 13037.47850085986, 13308.600741977756, 13370.997175211704, 13457.259850708306, 13606.659833504242, 14464.638384040063, 14663.853361466676, 14705.485308014167, 15214.315355808794, 12855.29295888735, 13175.0, 13414.932925335701, 13737.450501979809, 13869.653258668613, 13137.540186093442, 13277.30008385121, 13431.664208394868, 13923.0, 14039.087459315111, 12276.263424194576, 13012.0, 13115.606531804062, 13844.37700303509, 13996.440142394598, 11579.536818527165, 11602.577239714135, 11628.0, 11777.587784427504, 12079.637610871689, 9862.901370986197, 11452.942735286604, 11491.48288327044, 11615.128865334964, 11702.239354441934], "value": 7460.805910047998, "unit": "score"}], "name": "dromaeo_css", "value": 7177.244537438481, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 115.0, 127.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 89.0, 109.0, 162.0, 136.0, 138.0, 105.0, 104.0, 133.0, 107.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 186.0, 179.0, 180.0, 184.0, 187.0, 185.0, 185.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 57.0, 93.0, 69.0, 82.0, 81.0, 76.0, 84.0, 57.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 92.0, 70.0, 68.0, 70.0, 114.0, 97.0, 100.0, 90.0], "value": 86.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 87.0, 87.0, 135.0, 86.0, 88.0, 83.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 108.0, 151.0, 93.0, 93.0, 96.0, 94.0, 92.0, 94.0], "value": 100.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 88.0, 81.0, 83.0, 84.0, 83.0, 91.0, 129.0, 130.0], "value": 93.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [41.0, 76.0, 75.0, 84.0, 86.0, 86.0, 70.0, 55.0, 56.0, 56.0], "value": 68.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 72.0, 76.0, 71.0, 70.0, 74.0, 69.0, 69.0, 68.0, 70.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 82.0, 82.0, 82.0, 80.0, 82.0, 80.0, 81.0, 82.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 137.0, 137.0, 147.0, 153.0, 135.0, 142.0, 139.0, 191.0, 165.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 164.0, 162.0, 162.0, 161.0, 161.0, 158.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 67.0, 66.0, 68.0, 65.0, 64.0, 66.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1459.5, "alertThreshold": 2.0}]} 09:47:34 INFO - Return code: 0 09:47:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:47:34 INFO - # TBPL SUCCESS # 09:47:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:47:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:47:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:47:34 INFO - 2017-02-01 09:47:34.959 screenresolution[1933:17030] starting screenresolution argv=screenresolution get 09:47:34 INFO - 2017-02-01 09:47:34.963 screenresolution[1933:17030] Display 0: 1600x1200x32@60 09:47:34 INFO - 2017-02-01 09:47:34.969 screenresolution[1934:17033] starting screenresolution argv=screenresolution list 09:47:34 INFO - Available Modes on Display 0 09:47:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:47:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:47:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:47:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:47:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:47:35 INFO - Intel Iris: 09:47:35 INFO - Chipset Model: Intel Iris 09:47:35 INFO - Type: GPU 09:47:35 INFO - Bus: Built-In 09:47:35 INFO - VRAM (Dynamic, Max): 1536 MB 09:47:35 INFO - Vendor: Intel (0x8086) 09:47:35 INFO - Device ID: 0x0a2e 09:47:35 INFO - Revision ID: 0x0009 09:47:35 INFO - Displays: 09:47:35 INFO - Display: 09:47:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:47:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:47:35 INFO - Display Serial Number: 1600x1200 60 09:47:35 INFO - Main Display: Yes 09:47:35 INFO - Mirror: Off 09:47:35 INFO - Online: Yes 09:47:35 INFO - Rotation: Supported 09:47:35 INFO - Return code: 0 09:47:35 INFO - Running post-action listener: _resource_record_post_action 09:47:35 INFO - [mozharness: 2017-02-01 17:47:35.210676Z] Finished run-tests step (success) 09:47:35 INFO - Running post-run listener: _resource_record_post_run 09:47:35 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 925696; Write bytes: 500892672; Read time: 15; Write time: 1795 09:47:35 INFO - TinderboxPrint: CPU usage
53.4% 09:47:35 INFO - TinderboxPrint: I/O read bytes / time
925,696 / 15 09:47:35 INFO - TinderboxPrint: I/O write bytes / time
500,892,672 / 1,795 09:47:35 INFO - TinderboxPrint: CPU idle
2,239.4 (46.6%) 09:47:35 INFO - TinderboxPrint: CPU system
960.6 (20.0%) 09:47:35 INFO - TinderboxPrint: CPU user
1,601.7 (33.4%) 09:47:35 INFO - TinderboxPrint: Swap in / out
192,901,120 / 0 09:47:35 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 180867584; Write bytes: 177657856; Read time: 16775; Write time: 381 09:47:35 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 925696; Write bytes: 305503232; Read time: 15; Write time: 1361 09:47:35 INFO - Running post-run listener: _upload_blobber_files 09:47:35 INFO - Blob upload gear active. 09:47:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:47:35 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 09:47:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:47:36 INFO - (blobuploader) - INFO - Open directory for files ... 09:47:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:47:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:47:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:37 INFO - (blobuploader) - INFO - Done attempting. 09:47:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:47:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:47:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:38 INFO - (blobuploader) - INFO - Done attempting. 09:47:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:47:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:47:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:47:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:47:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:47:40 INFO - (blobuploader) - INFO - Done attempting. 09:47:40 INFO - (blobuploader) - INFO - Iteration through files over. 09:47:40 INFO - Return code: 0 09:47:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:47:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:47:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e0bb78a10a7d9f4c3ec2626a614a6cca5b757e0f721aa4f4e1e243cc92a7e6b049f95ba8e2cef457e46f5b9404f0d0c91c1df3abac97749ac54d1734b2a9b1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cda4f41f495176c08618dd344a40edb1fd4351eb452a23c59090ad23e2181a0d19ae04938991f2a72c1d4f869784f16f67251ac140b7b6823b70d568caae7928", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58c3e3864971b8a20c9204952bbc84ad646eb0737d4f79d3b4cc677b88c7b850628f4346c0d60016a9972e5a6b8e384660d746ebc51d778e2220ab48fa6db980"} 09:47:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:47:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:47:40 INFO - Contents: 09:47:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e0bb78a10a7d9f4c3ec2626a614a6cca5b757e0f721aa4f4e1e243cc92a7e6b049f95ba8e2cef457e46f5b9404f0d0c91c1df3abac97749ac54d1734b2a9b1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cda4f41f495176c08618dd344a40edb1fd4351eb452a23c59090ad23e2181a0d19ae04938991f2a72c1d4f869784f16f67251ac140b7b6823b70d568caae7928", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58c3e3864971b8a20c9204952bbc84ad646eb0737d4f79d3b4cc677b88c7b850628f4346c0d60016a9972e5a6b8e384660d746ebc51d778e2220ab48fa6db980"} 09:47:40 INFO - Running post-run listener: copy_logs_to_upload_dir 09:47:40 INFO - Copying logs to upload dir... 09:47:40 INFO - mkdir: /builds/slave/test/build/upload/logs 09:47:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.885664 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-01 09:47:40.803861) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 09:47:40.808579) ========= 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.SEhsj4Innu/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.Kw0Ab6SZIW/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e0bb78a10a7d9f4c3ec2626a614a6cca5b757e0f721aa4f4e1e243cc92a7e6b049f95ba8e2cef457e46f5b9404f0d0c91c1df3abac97749ac54d1734b2a9b1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cda4f41f495176c08618dd344a40edb1fd4351eb452a23c59090ad23e2181a0d19ae04938991f2a72c1d4f869784f16f67251ac140b7b6823b70d568caae7928", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58c3e3864971b8a20c9204952bbc84ad646eb0737d4f79d3b4cc677b88c7b850628f4346c0d60016a9972e5a6b8e384660d746ebc51d778e2220ab48fa6db980"} build_url:https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011140 build_url: 'https://queue.taskcluster.net/v1/task/Z3wBhaytTyKOgyf_IIkCEw/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e0bb78a10a7d9f4c3ec2626a614a6cca5b757e0f721aa4f4e1e243cc92a7e6b049f95ba8e2cef457e46f5b9404f0d0c91c1df3abac97749ac54d1734b2a9b1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cda4f41f495176c08618dd344a40edb1fd4351eb452a23c59090ad23e2181a0d19ae04938991f2a72c1d4f869784f16f67251ac140b7b6823b70d568caae7928", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/58c3e3864971b8a20c9204952bbc84ad646eb0737d4f79d3b4cc677b88c7b850628f4346c0d60016a9972e5a6b8e384660d746ebc51d778e2220ab48fa6db980"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 09:47:40.844222) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:47:40.844536) ========= 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.SEhsj4Innu/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.Kw0Ab6SZIW/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.004519 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 09:47:40.892893) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 09:47:40.896197) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 09:47:40.896485) ========= ========= Total master_lag: 0.20 =========