builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0374 starttime: 1476289435.56 results: success (0) buildid: 20161012081547 builduid: 56516680c98c487da0c03d913fd273a3 revision: 1b42244a8a8ca258eb0627f7f062771613dff38d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 09:23:55.557668) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 09:23:55.558188) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 09:23:55.558503) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 09:23:55.585373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 09:23:55.585802) ========= 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.KX9OszNHzd/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.RDmbKrAXjv/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-12 09:23:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 55.0M=0s 2016-10-12 09:23:55 (55.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126048 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 09:23:55.734698) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 09:23:55.735045) ========= 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.KX9OszNHzd/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.RDmbKrAXjv/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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.026972 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 09:23:55.786069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-12 09:23:55.786634) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 1b42244a8a8ca258eb0627f7f062771613dff38d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 1b42244a8a8ca258eb0627f7f062771613dff38d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KX9OszNHzd/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.RDmbKrAXjv/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-12 09:23:55,870 truncating revision to first 12 chars 2016-10-12 09:23:55,870 Setting DEBUG logging. 2016-10-12 09:23:55,870 attempt 1/10 2016-10-12 09:23:55,870 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/1b42244a8a8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 09:23:58,307 unpacking tar archive at: autoland-1b42244a8a8c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.697490 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-12 09:23:58.507071) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 09:23:58.507550) ========= script_repo_revision: 1b42244a8a8ca258eb0627f7f062771613dff38d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 09:23:58.508107) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 09:23:58.508403) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 09:23:58.527643) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-12 09:23:58.528144) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KX9OszNHzd/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.RDmbKrAXjv/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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:23:58 INFO - MultiFileLogger online at 20161012 09:23:58 in /builds/slave/test 09:23:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 09:23:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:23:58 INFO - {'append_to_log': False, 09:23:58 INFO - 'base_work_dir': '/builds/slave/test', 09:23:58 INFO - 'blob_upload_branch': 'Autoland', 09:23:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:23:58 INFO - 'branch': 'Autoland', 09:23:58 INFO - 'buildbot_json_path': 'buildprops.json', 09:23:58 INFO - 'config_files': ('talos/mac_config.py',), 09:23:58 INFO - 'default_actions': ('clobber', 09:23:58 INFO - 'read-buildbot-config', 09:23:58 INFO - 'download-and-extract', 09:23:58 INFO - 'populate-webroot', 09:23:58 INFO - 'create-virtualenv', 09:23:58 INFO - 'install', 09:23:58 INFO - 'run-tests'), 09:23:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:23:58 INFO - 'download_minidump_stackwalk': True, 09:23:58 INFO - 'download_symbols': 'ondemand', 09:23:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:23:58 INFO - 'tooltool.py': '/tools/tooltool.py', 09:23:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:23:58 INFO - '/tools/misc-python/virtualenv.py')}, 09:23:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:23:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:23:58 INFO - 'installer_path': 'installer.exe', 09:23:58 INFO - 'log_level': 'info', 09:23:58 INFO - 'log_name': 'talos', 09:23:58 INFO - 'log_to_console': True, 09:23:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:23:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:23:58 INFO - 'opt_config_files': (), 09:23:58 INFO - 'pip_index': False, 09:23:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:23:58 INFO - 'cmd': ('bash', 09:23:58 INFO - '-c', 09:23:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:23:58 INFO - 'enabled': True, 09:23:58 INFO - 'halt_on_failure': False, 09:23:58 INFO - 'name': 'check_screen_resolution'},), 09:23:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:23:58 INFO - 'cmd': ('bash', 09:23:58 INFO - '-c', 09:23:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:23:58 INFO - 'enabled': True, 09:23:58 INFO - 'halt_on_failure': False, 09:23:58 INFO - 'name': 'check_screen_resolution'},), 09:23:58 INFO - 'run_cmd_checks_enabled': True, 09:23:58 INFO - 'sps_profile': False, 09:23:58 INFO - 'sps_profile_interval': 0, 09:23:58 INFO - 'suite': 'dromaeojs', 09:23:58 INFO - 'system_bits': '32', 09:23:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:23:58 INFO - 'title': 't-yosemite-r7-0374', 09:23:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:23:58 INFO - 'use_talos_json': True, 09:23:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:23:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:23:58 INFO - 'work_dir': 'build'} 09:23:58 INFO - [mozharness: 2016-10-12 16:23:58.731206Z] Running clobber step. 09:23:58 INFO - Running pre-action listener: _resource_record_pre_action 09:23:58 INFO - Running main action method: clobber 09:23:58 INFO - rmtree: /builds/slave/test/build 09:23:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:24:00 INFO - Running post-action listener: _resource_record_post_action 09:24:00 INFO - [mozharness: 2016-10-12 16:24:00.910410Z] Finished clobber step (success) 09:24:00 INFO - [mozharness: 2016-10-12 16:24:00.910596Z] Running read-buildbot-config step. 09:24:00 INFO - Running pre-action listener: _resource_record_pre_action 09:24:00 INFO - Running main action method: read_buildbot_config 09:24:00 INFO - Using buildbot properties: 09:24:00 INFO - { 09:24:00 INFO - "project": "", 09:24:00 INFO - "product": "firefox", 09:24:00 INFO - "script_repo_revision": "production", 09:24:00 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 09:24:00 INFO - "repository": "", 09:24:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 09:24:00 INFO - "buildid": "20161012081547", 09:24:00 INFO - "pgo_build": "False", 09:24:00 INFO - "basedir": "/builds/slave/test", 09:24:00 INFO - "buildnumber": 257, 09:24:00 INFO - "slavename": "t-yosemite-r7-0374", 09:24:00 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:24:00 INFO - "platform": "yosemite_r7", 09:24:00 INFO - "scheduler": "tests-autoland-macosx64-talos", 09:24:00 INFO - "branch": "autoland", 09:24:00 INFO - "repo_path": "integration/autoland", 09:24:00 INFO - "revision": "1b42244a8a8ca258eb0627f7f062771613dff38d", 09:24:00 INFO - "stage_platform": "macosx64", 09:24:00 INFO - "builduid": "56516680c98c487da0c03d913fd273a3", 09:24:00 INFO - "slavebuilddir": "test" 09:24:00 INFO - } 09:24:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 09:24:00 INFO - Running post-action listener: _resource_record_post_action 09:24:00 INFO - [mozharness: 2016-10-12 16:24:00.914178Z] Finished read-buildbot-config step (success) 09:24:00 INFO - [mozharness: 2016-10-12 16:24:00.914298Z] Running download-and-extract step. 09:24:00 INFO - Running pre-action listener: _resource_record_pre_action 09:24:00 INFO - Running main action method: download_and_extract 09:24:00 INFO - mkdir: /builds/slave/test/build/tests 09:24:00 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:24:00 INFO - trying https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 09:24:00 INFO - Downloading https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:24:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 09:24:01 INFO - Downloaded 1199 bytes. 09:24:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:24:01 INFO - Using the following test package requirements: 09:24:01 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:24:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:24:01 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 09:24:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:24:01 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 09:24:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:24:01 INFO - u'jsshell-mac.zip'], 09:24:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:24:01 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 09:24:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:24:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:24:01 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 09:24:01 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:24:01 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 09:24:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:24:01 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 09:24:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:24:01 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 09:24:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:24:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:24:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:24:01 INFO - Fetch https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:24:02 INFO - Http code: 200 09:24:02 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 09:24:02 INFO - x-amz-cf-id: E_y_ddXlZ2hdruCvZ0gmevswu55jz8UQWcp17ieymuN80z8hEp2obQ== 09:24:02 INFO - x-amz-version-id: oPuXa1YJ2R5nUY8spwHz3TD2_9Xx3SmX 09:24:02 INFO - Expected file size: 16510526 09:24:02 INFO - Obtained file size: 16510526 09:24:09 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:24:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:24:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:24:09 INFO - Fetch https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:24:10 INFO - Http code: 200 09:24:10 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 09:24:10 INFO - x-amz-cf-id: mBbS1A9iZ1dRq_iBIXVNXqFfHzHIv9hPoivSFk0s9zafOFEsC7_whw== 09:24:10 INFO - x-amz-version-id: oPuXa1YJ2R5nUY8spwHz3TD2_9Xx3SmX 09:24:10 INFO - Expected file size: 16510526 09:24:10 INFO - Obtained file size: 16510526 09:24:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 09:24:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:24:16 INFO - Fetch https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 09:24:17 INFO - Http code: 200 09:24:17 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 09:24:17 INFO - x-amz-cf-id: XNLzKXaB9p8RMGfehqx52jMuvlNrJspesoHG1MCwNmnHwJD3Gi3z9g== 09:24:17 INFO - x-amz-version-id: VnyzSkQwlz6IqG29h4JbS9cFvbtRfTOp 09:24:17 INFO - Expected file size: 14409006 09:24:17 INFO - Obtained file size: 14409006 09:24: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:24:17 INFO - trying https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:24:17 INFO - Downloading https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 09:24:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 09:24:20 INFO - Downloaded 111719271 bytes. 09:24:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:24:20 INFO - mkdir: /builds/slave/test/properties 09:24:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:24:20 INFO - Writing to file /builds/slave/test/properties/build_url 09:24:20 INFO - Contents: 09:24:20 INFO - build_url:https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:24:21 INFO - Running post-action listener: _resource_record_post_action 09:24:21 INFO - Running post-action listener: set_extra_try_arguments 09:24:21 INFO - [mozharness: 2016-10-12 16:24:21.307616Z] Finished download-and-extract step (success) 09:24:21 INFO - [mozharness: 2016-10-12 16:24:21.307769Z] Running populate-webroot step. 09:24:21 INFO - Running pre-action listener: _resource_record_pre_action 09:24:21 INFO - Running main action method: populate_webroot 09:24:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:24:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:24:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:24:21 INFO - '--tppagecycles', 09:24:21 INFO - '7'], 09:24:21 INFO - 'tests': ['tsvgm']}}, 09:24:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:24:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:24:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:24:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:24:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:24:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:24:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:21 INFO - 'talos_options': ['--disable-e10s'], 09:24:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:21 INFO - 'talos_options': ['--disable-e10s'], 09:24:21 INFO - 'tests': ['damp', 'tps']}, 09:24:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:21 INFO - 'tests': ['damp', 'tps']}, 09:24:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:24:21 INFO - 'tests': ['dromaeo_dom']}, 09:24:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:24:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:24:21 INFO - 'tests': ['basic_compositor_video']}, 09:24:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:24:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:24:21 INFO - 'tests': ['a11yr', 09:24:21 INFO - 'ts_paint', 09:24:21 INFO - 'tpaint', 09:24:21 INFO - 'sessionrestore', 09:24:21 INFO - 'sessionrestore_no_auto_restore', 09:24:21 INFO - 'tabpaint']}, 09:24:21 INFO - 'other-e10s': {'tests': ['a11yr', 09:24:21 INFO - 'ts_paint', 09:24:21 INFO - 'tpaint', 09:24:21 INFO - 'sessionrestore', 09:24:21 INFO - 'sessionrestore_no_auto_restore', 09:24:21 INFO - 'tabpaint']}, 09:24:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:24:21 INFO - 'ts_paint', 09:24:21 INFO - 'tpaint', 09:24:21 INFO - 'sessionrestore', 09:24:21 INFO - 'sessionrestore_no_auto_restore', 09:24:21 INFO - 'tabpaint']}, 09:24:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:24:21 INFO - 'ts_paint', 09:24:21 INFO - 'tpaint', 09:24:21 INFO - 'sessionrestore', 09:24:21 INFO - 'sessionrestore_no_auto_restore', 09:24:21 INFO - 'tabpaint']}, 09:24:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:24:21 INFO - 'tests': ['a11yr', 09:24:21 INFO - 'ts_paint', 09:24:21 INFO - 'tpaint', 09:24:21 INFO - 'sessionrestore', 09:24:21 INFO - 'sessionrestore_no_auto_restore', 09:24:21 INFO - 'tabpaint']}, 09:24:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:24:21 INFO - 'tests': ['a11yr', 09:24:21 INFO - 'ts_paint', 09:24:21 INFO - 'tpaint', 09:24:21 INFO - 'sessionrestore', 09:24:21 INFO - 'sessionrestore_no_auto_restore', 09:24:21 INFO - 'tabpaint']}, 09:24:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:24:21 INFO - 'tests': ['tsvgx', 09:24:21 INFO - 'tsvgr_opacity', 09:24:21 INFO - 'tart', 09:24:21 INFO - 'tscrollx', 09:24:21 INFO - 'cart']}, 09:24:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:24:21 INFO - 'tsvgr_opacity', 09:24:21 INFO - 'tart', 09:24:21 INFO - 'tscrollx', 09:24:21 INFO - 'cart']}, 09:24:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:21 INFO - 'talos_options': ['--disable-e10s'], 09:24:21 INFO - 'tests': ['tp5o']}, 09:24:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:21 INFO - 'tests': ['tp5o']}, 09:24:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:21 INFO - 'talos_options': ['--disable-e10s', 09:24:21 INFO - '--xperf_path', 09:24:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:21 INFO - 'tests': ['tp5n']}, 09:24:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:21 INFO - 'talos_options': ['--xperf_path', 09:24:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:21 INFO - 'tests': ['tp5n']}}, 09:24:21 INFO - 'talos.zip': {'path': '', 09:24:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:24:21 INFO - Running post-action listener: _resource_record_post_action 09:24:21 INFO - [mozharness: 2016-10-12 16:24:21.326142Z] Finished populate-webroot step (success) 09:24:21 INFO - [mozharness: 2016-10-12 16:24:21.326249Z] Running create-virtualenv step. 09:24:21 INFO - Running pre-action listener: _resource_record_pre_action 09:24:21 INFO - Running main action method: create_virtualenv 09:24:21 INFO - Creating virtualenv /builds/slave/test/build/venv 09:24:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:24:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:24:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:24:21 INFO - Using real prefix '/tools/python27' 09:24:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:24:22 INFO - Installing distribute.............................................................................................................................................................................................done. 09:24:25 INFO - Installing pip.................done. 09:24:25 INFO - Return code: 0 09:24:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:24:25 INFO - Reading from file tmpfile_stdout 09:24:25 INFO - Output received: 09:24:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:24:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104cda490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8eb156b1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aeed30>, '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 0x104914db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ae6b20>, '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.KX9OszNHzd/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.RDmbKrAXjv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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:24:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:24:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KX9OszNHzd/Render', 09:24:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:25 INFO - 'HOME': '/Users/cltbld', 09:24:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:25 INFO - 'LOGNAME': 'cltbld', 09:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:25 INFO - 'MOZ_NO_REMOTE': '1', 09:24:25 INFO - 'NO_EM_RESTART': '1', 09:24:25 INFO - 'PAGER': '/bin/cat', 09:24:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:25 INFO - 'PWD': '/builds/slave/test', 09:24:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:25 INFO - 'SHELL': '/bin/bash', 09:24:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RDmbKrAXjv/Listeners', 09:24:25 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 09:24:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:25 INFO - 'USER': 'cltbld', 09:24:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:25 INFO - 'XPC_FLAGS': '0x0', 09:24:25 INFO - 'XPC_SERVICE_NAME': '0', 09:24:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:24:25 INFO - Cleaning up... 09:24:25 INFO - Return code: 0 09:24:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104cda490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8eb156b1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aeed30>, '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 0x104914db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ae6b20>, '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.KX9OszNHzd/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.RDmbKrAXjv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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:24:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:24:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KX9OszNHzd/Render', 09:24:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:25 INFO - 'HOME': '/Users/cltbld', 09:24:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:25 INFO - 'LOGNAME': 'cltbld', 09:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:25 INFO - 'MOZ_NO_REMOTE': '1', 09:24:25 INFO - 'NO_EM_RESTART': '1', 09:24:25 INFO - 'PAGER': '/bin/cat', 09:24:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:25 INFO - 'PWD': '/builds/slave/test', 09:24:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:25 INFO - 'SHELL': '/bin/bash', 09:24:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RDmbKrAXjv/Listeners', 09:24:25 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 09:24:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:25 INFO - 'USER': 'cltbld', 09:24:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:25 INFO - 'XPC_FLAGS': '0x0', 09:24:25 INFO - 'XPC_SERVICE_NAME': '0', 09:24:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:25 INFO - Downloading/unpacking psutil>=3.1.1 09:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:24:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:29 INFO - Installing collected packages: psutil 09:24:29 INFO - Running setup.py install for psutil 09:24:29 INFO - building 'psutil._psutil_osx' extension 09:24:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:24:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:24:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:24:29 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:24:30 INFO - building 'psutil._psutil_posix' extension 09:24:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:24:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:24:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:24:30 INFO - ^ 09:24:30 INFO - 1 warning generated. 09:24:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:24:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:30 INFO - Successfully installed psutil 09:24:30 INFO - Cleaning up... 09:24:30 INFO - Return code: 0 09:24:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104cda490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8eb156b1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aeed30>, '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 0x104914db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ae6b20>, '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.KX9OszNHzd/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.RDmbKrAXjv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:24:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KX9OszNHzd/Render', 09:24:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:30 INFO - 'HOME': '/Users/cltbld', 09:24:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:30 INFO - 'LOGNAME': 'cltbld', 09:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:30 INFO - 'MOZ_NO_REMOTE': '1', 09:24:30 INFO - 'NO_EM_RESTART': '1', 09:24:30 INFO - 'PAGER': '/bin/cat', 09:24:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:30 INFO - 'PWD': '/builds/slave/test', 09:24:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:30 INFO - 'SHELL': '/bin/bash', 09:24:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RDmbKrAXjv/Listeners', 09:24:30 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 09:24:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:30 INFO - 'USER': 'cltbld', 09:24:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:30 INFO - 'XPC_FLAGS': '0x0', 09:24:30 INFO - 'XPC_SERVICE_NAME': '0', 09:24:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:24:33 INFO - Installing collected packages: mozsystemmonitor 09:24:33 INFO - Running setup.py install for mozsystemmonitor 09:24:33 INFO - Successfully installed mozsystemmonitor 09:24:33 INFO - Cleaning up... 09:24:33 INFO - Return code: 0 09:24:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:24: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:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104cda490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8eb156b1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aeed30>, '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 0x104914db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ae6b20>, '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.KX9OszNHzd/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.RDmbKrAXjv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:24:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KX9OszNHzd/Render', 09:24:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:33 INFO - 'HOME': '/Users/cltbld', 09:24:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:33 INFO - 'LOGNAME': 'cltbld', 09:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:33 INFO - 'MOZ_NO_REMOTE': '1', 09:24:33 INFO - 'NO_EM_RESTART': '1', 09:24:33 INFO - 'PAGER': '/bin/cat', 09:24:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:33 INFO - 'PWD': '/builds/slave/test', 09:24:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:33 INFO - 'SHELL': '/bin/bash', 09:24:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RDmbKrAXjv/Listeners', 09:24:33 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 09:24:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:33 INFO - 'USER': 'cltbld', 09:24:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:33 INFO - 'XPC_FLAGS': '0x0', 09:24:33 INFO - 'XPC_SERVICE_NAME': '0', 09:24:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:33 INFO - Downloading/unpacking jsonschema==2.5.1 09:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:24:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:36 INFO - Downloading functools32-3.2.3-2.tar.gz 09:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:24:36 INFO - warning: no files found matching '*.txt' 09:24:36 INFO - no previously-included directories found matching 'build' 09:24:36 INFO - no previously-included directories found matching 'dist' 09:24:36 INFO - no previously-included directories found matching '.git*' 09:24:36 INFO - Installing collected packages: jsonschema, functools32 09:24:36 INFO - Running setup.py install for functools32 09:24:36 INFO - warning: no files found matching '*.txt' 09:24:36 INFO - no previously-included directories found matching 'build' 09:24:36 INFO - no previously-included directories found matching 'dist' 09:24:36 INFO - no previously-included directories found matching '.git*' 09:24:36 INFO - Successfully installed jsonschema functools32 09:24:36 INFO - Cleaning up... 09:24:36 INFO - Return code: 0 09:24:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104cda490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8eb156b1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aeed30>, '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 0x104914db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ae6b20>, '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.KX9OszNHzd/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.RDmbKrAXjv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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:24:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:24:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KX9OszNHzd/Render', 09:24:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:36 INFO - 'HOME': '/Users/cltbld', 09:24:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:36 INFO - 'LOGNAME': 'cltbld', 09:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:36 INFO - 'MOZ_NO_REMOTE': '1', 09:24:36 INFO - 'NO_EM_RESTART': '1', 09:24:36 INFO - 'PAGER': '/bin/cat', 09:24:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:36 INFO - 'PWD': '/builds/slave/test', 09:24:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:36 INFO - 'SHELL': '/bin/bash', 09:24:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RDmbKrAXjv/Listeners', 09:24:36 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 09:24:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:36 INFO - 'USER': 'cltbld', 09:24:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:36 INFO - 'XPC_FLAGS': '0x0', 09:24:36 INFO - 'XPC_SERVICE_NAME': '0', 09:24:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:24:37 INFO - Cleaning up... 09:24:37 INFO - Return code: 0 09:24:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104cda490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8eb156b1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aeed30>, '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 0x104914db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ae6b20>, '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.KX9OszNHzd/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.RDmbKrAXjv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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:24:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:24:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KX9OszNHzd/Render', 09:24:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:37 INFO - 'HOME': '/Users/cltbld', 09:24:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:37 INFO - 'LOGNAME': 'cltbld', 09:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:37 INFO - 'MOZ_NO_REMOTE': '1', 09:24:37 INFO - 'NO_EM_RESTART': '1', 09:24:37 INFO - 'PAGER': '/bin/cat', 09:24:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:37 INFO - 'PWD': '/builds/slave/test', 09:24:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:37 INFO - 'SHELL': '/bin/bash', 09:24:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RDmbKrAXjv/Listeners', 09:24:37 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 09:24:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:37 INFO - 'USER': 'cltbld', 09:24:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:37 INFO - 'XPC_FLAGS': '0x0', 09:24:37 INFO - 'XPC_SERVICE_NAME': '0', 09:24:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:37 INFO - Downloading/unpacking blobuploader==1.2.4 09:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:39 INFO - Downloading blobuploader-1.2.4.tar.gz 09:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:24:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:24:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:41 INFO - Downloading docopt-0.6.1.tar.gz 09:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:41 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:41 INFO - Running setup.py install for blobuploader 09:24:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:24:41 INFO - Running setup.py install for requests 09:24:41 INFO - Running setup.py install for docopt 09:24:41 INFO - Successfully installed blobuploader requests docopt 09:24:41 INFO - Cleaning up... 09:24:42 INFO - Return code: 0 09:24:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104cda490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8eb156b1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aeed30>, '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 0x104914db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ae6b20>, '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.KX9OszNHzd/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.RDmbKrAXjv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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:24:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:24:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:24:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KX9OszNHzd/Render', 09:24:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:42 INFO - 'HOME': '/Users/cltbld', 09:24:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:42 INFO - 'LOGNAME': 'cltbld', 09:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:42 INFO - 'MOZ_NO_REMOTE': '1', 09:24:42 INFO - 'NO_EM_RESTART': '1', 09:24:42 INFO - 'PAGER': '/bin/cat', 09:24:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:42 INFO - 'PWD': '/builds/slave/test', 09:24:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:42 INFO - 'SHELL': '/bin/bash', 09:24:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RDmbKrAXjv/Listeners', 09:24:42 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 09:24:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:42 INFO - 'USER': 'cltbld', 09:24:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:42 INFO - 'XPC_FLAGS': '0x0', 09:24:42 INFO - 'XPC_SERVICE_NAME': '0', 09:24:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:42 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-QoYc1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:42 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-EvqwPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:42 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-6NWBB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:42 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-ojFAhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:42 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-MnpoG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:42 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-91Ssbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:42 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-YgA1ED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:43 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-IW7u1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:43 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-P3Dax6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:43 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-qpUTID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:43 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-jVVRgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:43 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-kkYeus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:43 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-9g8jyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:43 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-NvQyhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:43 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-jIsJP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:43 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-o4EOLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:44 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-xaxaIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:24:44 INFO - Running setup.py install for manifestparser 09:24:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:24:44 INFO - Running setup.py install for mozcrash 09:24:44 INFO - Running setup.py install for mozdebug 09:24:44 INFO - Running setup.py install for mozdevice 09:24:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:24:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:24:44 INFO - Running setup.py install for mozfile 09:24:44 INFO - Running setup.py install for mozhttpd 09:24:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:24:44 INFO - Running setup.py install for mozinfo 09:24:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:24:45 INFO - Running setup.py install for mozInstall 09:24:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:24:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:24:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:24:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:24:45 INFO - Running setup.py install for mozleak 09:24:45 INFO - Running setup.py install for mozlog 09:24:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:24:45 INFO - Running setup.py install for moznetwork 09:24:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:24:45 INFO - Running setup.py install for mozprocess 09:24:45 INFO - Running setup.py install for mozprofile 09:24:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:24:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:24:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:24:46 INFO - Running setup.py install for mozrunner 09:24:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:24:46 INFO - Running setup.py install for mozscreenshot 09:24:46 INFO - Running setup.py install for moztest 09:24:46 INFO - Running setup.py install for mozversion 09:24:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:24:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:24:46 INFO - Cleaning up... 09:24:46 INFO - Return code: 0 09:24:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104cda490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8eb156b1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aeed30>, '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 0x104914db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ae6b20>, '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.KX9OszNHzd/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.RDmbKrAXjv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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:24:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:24:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:24:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KX9OszNHzd/Render', 09:24:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:46 INFO - 'HOME': '/Users/cltbld', 09:24:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:46 INFO - 'LOGNAME': 'cltbld', 09:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:46 INFO - 'MOZ_NO_REMOTE': '1', 09:24:46 INFO - 'NO_EM_RESTART': '1', 09:24:46 INFO - 'PAGER': '/bin/cat', 09:24:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:46 INFO - 'PWD': '/builds/slave/test', 09:24:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:46 INFO - 'SHELL': '/bin/bash', 09:24:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RDmbKrAXjv/Listeners', 09:24:46 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 09:24:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:46 INFO - 'USER': 'cltbld', 09:24:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:46 INFO - 'XPC_FLAGS': '0x0', 09:24:46 INFO - 'XPC_SERVICE_NAME': '0', 09:24:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:47 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-fNAMlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:47 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-J05eFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:47 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-JzhCqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:47 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-u_aI7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:47 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-stmSNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:47 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-LRYVGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:47 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-t3GPJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:47 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-7OQUpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:47 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-XKRuzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:24:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:47 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-fbYFUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:48 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-Z9p6Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:48 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-OgJpeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:48 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-84mpGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:48 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-xqaaE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:48 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-ML5RF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:48 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-3aYIfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:48 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-HAA3yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:24:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:51 INFO - Downloading blessings-1.6.tar.gz 09:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:24:51 INFO - Installing collected packages: blessings 09:24:51 INFO - Running setup.py install for blessings 09:24:51 INFO - Successfully installed blessings 09:24:51 INFO - Cleaning up... 09:24:51 INFO - Return code: 0 09:24:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:24:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:51 INFO - Reading from file tmpfile_stdout 09:24:51 INFO - Current package versions: 09:24:51 INFO - blessings == 1.6 09:24:51 INFO - blobuploader == 1.2.4 09:24:51 INFO - docopt == 0.6.1 09:24:51 INFO - functools32 == 3.2.3-2 09:24:51 INFO - jsonschema == 2.5.1 09:24:51 INFO - manifestparser == 1.1 09:24:51 INFO - mozInstall == 1.12 09:24:51 INFO - mozcrash == 0.17 09:24:51 INFO - mozdebug == 0.1 09:24:51 INFO - mozdevice == 0.48 09:24:51 INFO - mozfile == 1.2 09:24:51 INFO - mozhttpd == 0.7 09:24:51 INFO - mozinfo == 0.9 09:24:51 INFO - mozleak == 0.1 09:24:51 INFO - mozlog == 3.4 09:24:51 INFO - moznetwork == 0.27 09:24:51 INFO - mozprocess == 0.23 09:24:51 INFO - mozprofile == 0.28 09:24:51 INFO - mozrunner == 6.12 09:24:51 INFO - mozscreenshot == 0.1 09:24:51 INFO - mozsystemmonitor == 0.3 09:24:51 INFO - moztest == 0.7 09:24:51 INFO - mozversion == 1.4 09:24:51 INFO - psutil == 3.1.1 09:24:51 INFO - requests == 1.2.3 09:24:51 INFO - wsgiref == 0.1.2 09:24:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:52 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 0x104cda490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8eb156b1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aeed30>, '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 0x104914db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ae6b20>, '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.KX9OszNHzd/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.RDmbKrAXjv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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:24:52 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:24:52 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:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KX9OszNHzd/Render', 09:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:52 INFO - 'HOME': '/Users/cltbld', 09:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:52 INFO - 'LOGNAME': 'cltbld', 09:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:52 INFO - 'MOZ_NO_REMOTE': '1', 09:24:52 INFO - 'NO_EM_RESTART': '1', 09:24:52 INFO - 'PAGER': '/bin/cat', 09:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:52 INFO - 'PWD': '/builds/slave/test', 09:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:52 INFO - 'SHELL': '/bin/bash', 09:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RDmbKrAXjv/Listeners', 09:24:52 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 09:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:52 INFO - 'USER': 'cltbld', 09:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:52 INFO - 'XPC_FLAGS': '0x0', 09:24:52 INFO - 'XPC_SERVICE_NAME': '0', 09:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:52 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:24:52 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:24:52 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:24:52 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:24:52 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:24:52 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:24:52 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:24:52 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:24:52 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:24:52 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:24:52 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:24:52 INFO - Cleaning up... 09:24:52 INFO - Return code: 0 09:24:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104cda490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8eb156b1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aeed30>, '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 0x104914db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ae6b20>, '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.KX9OszNHzd/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.RDmbKrAXjv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:24:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KX9OszNHzd/Render', 09:24:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:53 INFO - 'HOME': '/Users/cltbld', 09:24:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:53 INFO - 'LOGNAME': 'cltbld', 09:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:53 INFO - 'MOZ_NO_REMOTE': '1', 09:24:53 INFO - 'NO_EM_RESTART': '1', 09:24:53 INFO - 'PAGER': '/bin/cat', 09:24:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:53 INFO - 'PWD': '/builds/slave/test', 09:24:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:53 INFO - 'SHELL': '/bin/bash', 09:24:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RDmbKrAXjv/Listeners', 09:24:53 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 09:24:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:53 INFO - 'USER': 'cltbld', 09:24:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:53 INFO - 'XPC_FLAGS': '0x0', 09:24:53 INFO - 'XPC_SERVICE_NAME': '0', 09:24:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:24:53 INFO - Cleaning up... 09:24:53 INFO - Return code: 0 09:24:53 INFO - Running post-action listener: _resource_record_post_action 09:24:53 INFO - Running post-action listener: _start_resource_monitoring 09:24:53 INFO - Starting resource monitoring. 09:24:53 INFO - [mozharness: 2016-10-12 16:24:53.921818Z] Finished create-virtualenv step (success) 09:24:53 INFO - [mozharness: 2016-10-12 16:24:53.922842Z] Running install step. 09:24:53 INFO - Running pre-action listener: _resource_record_pre_action 09:24:53 INFO - Running main action method: install 09:24:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:54 INFO - Reading from file tmpfile_stdout 09:24:54 INFO - Detecting whether we're running mozinstall >=1.0... 09:24:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:24:54 INFO - Reading from file tmpfile_stdout 09:24:54 INFO - Output received: 09:24:54 INFO - Usage: mozinstall [options] installer 09:24:54 INFO - Options: 09:24:54 INFO - -h, --help show this help message and exit 09:24:54 INFO - -d DEST, --destination=DEST 09:24:54 INFO - Directory to install application into. [default: 09:24:54 INFO - "/builds/slave/test"] 09:24:54 INFO - --app=APP Application being installed. [default: firefox] 09:24:54 INFO - mkdir: /builds/slave/test/build/application 09:24:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:25:28 INFO - Reading from file tmpfile_stdout 09:25:28 INFO - Output received: 09:25:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:25:28 INFO - Running post-action listener: _resource_record_post_action 09:25:28 INFO - [mozharness: 2016-10-12 16:25:28.467019Z] Finished install step (success) 09:25:28 INFO - [mozharness: 2016-10-12 16:25:28.467183Z] Running run-tests step. 09:25:28 INFO - Running pre-action listener: _resource_record_pre_action 09:25:28 INFO - Running main action method: run_tests 09:25:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:25:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:25:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:25:28 INFO - 2016-10-12 09:25:28.479 screenresolution[1632:7416] starting screenresolution argv=screenresolution get 09:25:28 INFO - 2016-10-12 09:25:28.481 screenresolution[1632:7416] Display 0: 1600x1200x32@60 09:25:28 INFO - 2016-10-12 09:25:28.486 screenresolution[1633:7418] starting screenresolution argv=screenresolution list 09:25:28 INFO - Available Modes on Display 0 09:25:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:25:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:25:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:25:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:25:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:25:28 INFO - Intel Iris: 09:25:28 INFO - Chipset Model: Intel Iris 09:25:28 INFO - Type: GPU 09:25:28 INFO - Bus: Built-In 09:25:28 INFO - VRAM (Dynamic, Max): 1536 MB 09:25:28 INFO - Vendor: Intel (0x8086) 09:25:28 INFO - Device ID: 0x0a2e 09:25:28 INFO - Revision ID: 0x0009 09:25:28 INFO - Displays: 09:25:28 INFO - Display: 09:25:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:25:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:25:28 INFO - Display Serial Number: 1600x1200 60 09:25:28 INFO - Main Display: Yes 09:25:28 INFO - Mirror: Off 09:25:28 INFO - Online: Yes 09:25:28 INFO - Rotation: Supported 09:25:28 INFO - Return code: 0 09:25:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:25:28 INFO - Python 2.7.3 09:25:28 INFO - Return code: 0 09:25:28 INFO - grabbing minidump binary from tooltool 09:25:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104aeed30>, '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 0x104914db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ae6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:25:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:25:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:25:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:25:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:25:28 INFO - Return code: 0 09:25:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:25:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:25:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:25:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:25:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:25:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0374', '--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:25:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0374 --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:25:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KX9OszNHzd/Render', 09:25:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:28 INFO - 'HOME': '/Users/cltbld', 09:25:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:28 INFO - 'LOGNAME': 'cltbld', 09:25:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:25:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:28 INFO - 'MOZ_NO_REMOTE': '1', 09:25:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:25:28 INFO - 'NO_EM_RESTART': '1', 09:25:28 INFO - 'PAGER': '/bin/cat', 09:25:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:28 INFO - 'PWD': '/builds/slave/test', 09:25:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:25:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:28 INFO - 'SHELL': '/bin/bash', 09:25:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RDmbKrAXjv/Listeners', 09:25:28 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 09:25:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:28 INFO - 'USER': 'cltbld', 09:25:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:28 INFO - 'XPC_FLAGS': '0x0', 09:25:28 INFO - 'XPC_SERVICE_NAME': '0', 09:25:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:25:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0374', '--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:25:29 INFO - mozversion application_buildid: 20161012081547 09:25:29 INFO - mozversion application_changeset: 1b42244a8a8ca258eb0627f7f062771613dff38d 09:25:29 INFO - mozversion application_display_name: Nightly 09:25:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:25:29 INFO - mozversion application_name: Firefox 09:25:29 INFO - mozversion application_remotingname: firefox 09:25:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:25:29 INFO - mozversion application_vendor: Mozilla 09:25:29 INFO - mozversion application_version: 52.0a1 09:25:29 INFO - mozversion platform_buildid: 20161012081547 09:25:29 INFO - mozversion platform_changeset: 1b42244a8a8ca258eb0627f7f062771613dff38d 09:25:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:25:29 INFO - mozversion platform_version: 52.0a1 09:25:29 INFO - using testdate: 1476289529 09:25:29 INFO - actual date: 1476289529 09:25:29 INFO - starting webserver on 'localhost:49267' 09:25:29 INFO - SUITE-START | Running 2 tests 09:25:29 INFO - TEST-START | dromaeo_css 09:25:29 INFO - operating with platform_type : mac_ 09:25:29 INFO - Initialising browser for dromaeo_css test... 09:25:29 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/tmpA6xM_l/profile http://localhost:49267/getInfo.html) 09:25:31 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 09:25:31 INFO - PROCESS | 1643 | colorDepth:24 09:25:31 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 09:25:31 INFO - PROCESS | 1643 | __metrics 09:25:31 INFO - PROCESS | 1643 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:25:31 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:25:32 INFO - TEST-INFO | 1643: exit 0 09:25:32 INFO - Browser initialized. 09:25:32 INFO - Running cycle 1/1 for dromaeo_css test... 09:25:32 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/tmpA6xM_l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:44 INFO - PROCESS | 1645 | RSS: Main: 243335168 09:25:44 INFO - PROCESS | 1645 | 09:26:34 INFO - PROCESS | 1645 | 1476289594881 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:28:48 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 09:28:50 INFO - PROCESS | 1645 | RSS: Main: 413372416 09:28:50 INFO - PROCESS | 1645 | 09:31:53 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 09:31:54 INFO - PROCESS | 1645 | RSS: Main: 370946048 09:31:54 INFO - PROCESS | 1645 | 09:34:56 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 09:34:57 INFO - PROCESS | 1645 | RSS: Main: 354082816 09:34:57 INFO - PROCESS | 1645 | 09:37:59 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 09:38:00 INFO - PROCESS | 1645 | RSS: Main: 345829376 09:38:00 INFO - PROCESS | 1645 | 09:41:03 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 09:41:04 INFO - PROCESS | 1645 | RSS: Main: 340987904 09:41:04 INFO - PROCESS | 1645 | 09:44:07 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 09:44:07 INFO - PROCESS | 1645 | RSS: Main: 668368896 09:44:07 INFO - PROCESS | 1645 | 09:44:07 INFO - PROCESS | 1645 | __start_tp_report 09:44:07 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 09:44:07 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 09:44:07 INFO - PROCESS | 1645 | |i|pagename|runs| 09:44:07 INFO - PROCESS | 1645 | |0;dojo.html;3325.8503367348467;3328.184594774281;3332.683589981957;3357.1774915145793;3387.0346951118922;5512.779488820453;5629.493345598895;5689.061304884699;5722.341930677973;5755.7697692092315;5627.7467513961865;5664.376918538957;5691.715414229282;5752.309722833255;5802.100674395465;5137.717425541594;5176.430592634807;5195.376554813409;5203.583713302926;5222.582193424536;5178.559822415099;5275.815346462875;5285.656432331905;5292.073887069767;5334.546563542103;5110.591152707774;5232.084385232569;5235.58115350771;5265.131253343194;5295.31160949078;5133.383993920716;5218.373795144607;5223.843284701465;5227.424983251877;5233.633645644806;5112.642115051911;5159.535641792257;5184.559312458446;5191.792328306901;5203.323567936182;5636.859078523029;5664.490195882349;5665.3768085510565;5666.914996275059;5671.7164141793155;6095.515930898297;6102.368068311564;6103.489197737734;6109.16175461965;6138.539609529258;6136.886723216021;6175.382461753788;6188.288346840126;6207.534434917354;6208;5642.181883626851;5713;5747.56893233005;5761.222234998306;5786.913196302059;6276.874462510724;6289.968550157311;6296.968515157395;6303.590266632654;6327.715252813635;6115.113308570232;6122.571420000646;6124.11200375943;6134.417230363198;6139.47814435769;6045.274567051894;6107.636783026228;6109.175261339751;6114.631938157225;6125.17440701618;6165.414285642857;6198.690065496708;6207.534434917399;6214.906776398358;6222.222222222223;6240.095186197976;6243.344448832898;6249.7187626556915;6251.9687401563615;6259.937400626027;4829.275608658659;4891.559759621651;4891.997140586172;4917.631177661689;4972.627052971042;4372.519022907478;4414.492333381702;4431.7562534060935;4443.7111587746695;4527.954720452819;5708.743106560215;5725.570582206351;5729.598928074995;5731.713414329267;5736.856578585485;6089.330173680892;6183.598066125777;6287;6326.335734747877;6338.492920566344;5632.85917852057;5691.601587888891;5716.142578613241;5737.483626473638;5759.251297331404;5415.810446634349;5416.566674666017;5427.674339539641;5436.646617969898;5467.480589344006;6291.591046581958;6304.873902522016;6307.936920630735;6319.336469670802;6323.08315294289;6098.220442830473;6102.489251635809;6158.445739883432;6222.128901953821;6272.933601287701;5413.945860541344;6196.628202307876;6244.406781355764;6269;6313.652749098844;6160.907586386297;6166.290876549254;6180.165677633462;6193.102000209854;6194.81415557534;6075.817725468243;6101.816945491642;6243.021264981054;6295.244570651551;6315.3053164152825;5971.193888824953;6040.818775436744;6046.395360463918;6083.574149809471;6109.009944784373;6031.396860314109;6071.241094863142;6097.390260973867;6100.1459795629535;6136.815895523141;5891.970540147272;5912.556558258062;5923.644581325134;5925.200097986716;5950.9702451487465;5910.527157827278;6006.819795406145;6012.278526576839;6067.332593414809;6080.148779170831;5870.970645146747;5876.294844618673;5878.970605147118;5879.794207202727;5883.705814709333 09:44:07 INFO - PROCESS | 1645 | |1;ext.html;494.77982297877435;496.8583953573232;516.1998901702361;521.3691433365627;547.5400663442708;24561.75438245617;31077.20305172534;40701.98245043875;41531;41912;39282.60717392825;39596.010099747524;39610.40584391236;39641.20717585646;39706.404403933964;8136.471129376601;9384.390014649043;9513.952430237874;9537.903141138753;9539.952300238489;9349.81300373992;9363.859542106873;9450.905490945072;9451.905480945206;9490.145886870181;8101.230383113624;9440.480773557452;9493.715188544355;9496.620135194584;9522.80954380912;9447.716568502956;9475.620975161055;9484.14642682155;9487.573059212318;9489.098535639103;8439.493630382196;9400.858987115198;9472.810543789086;9474.857877131848;9495.097965693249;38492;38689.80655096735;38730.22539549221;38762;38774.80612596947;3187.9579325125806;3265.0694552052787;3267.673232676737;3503.877364292263;3726.441033844918;29400.70599294001;29590.556141657893;29886.252843678863;29913.401731965456;31041.84479077613;3116.205367631262;3171.349873275973;3184.1561986073707;3233;3265.6571060038827;406245;406735;407200;410225;410907;54491;54769.904601908536;54771;54798;54830.45169548333;33046.17384565405;33575.824846130265;33630.49554256688;34562;56556.71721641366;15525.689486210213;15841.762373564407;15872.365105395655;15891.523254302389;15895.284712187979;12141.514339426501;12234.81647775284;12235;12247.93876030632;12257.877421225852;17663.911680441517;17772.022538760233;17774.111294435228;17781.555461113316;17812;6363.7772677956045;7112.395446387115;7540.3213710766295;7681.884771728429;7761.713012459925;969.8157350103598;991.5389343955095;1008.7326858382535;1041.4324193314662;1054.8259537176434;29032.274193144916;29172.562411563842;29432;29728.702712973027;29785.553216701766;999.575180548264;1002.0630710285906;1021.5709402051008;1051.8369652703843;1067.8932106789414;14524.709505810037;14991.250437478082;15059.924700376429;15459.690806183813;15463.768043479356;638033;673670.6316468484;674162;674868;675060;54715.45284547183;55210.447895521334;55336;55342;55446.44553554413;1049.5906596427399;1124.3366413815888;1249.5876360800914;1349.3860293566404;1361.3329468560335;24522.63216051725;26896;27217.911283549227;29049.402282873798;30213.37494161283;52268.95462090813;52998.470015300896;53198;53223.73388133034;53274;579433;581116;583792;585823;586192.656881177;31642.208944776565;33749.325013500085;36467.63532364643;41009.564665236576;41531.54639587721;41364.379534306405;43609.731876861966;43883.122337552435;43980.78009609931;44689.77655111704;30937;36807.44788828223;36916.63083369132;38187;38246;36194;36592.45111323385;37197.51209951572;37399.813000934824;37495.43756843595;35699.46450803188;35841.28317433585;36573.26853462862;36733.26533469369;37080.07299817526;30219.79120835142;31420.057398278088;32705.836470817492;32812.83593582017;32883.19142447189;21590.676139858228;24275.757242428055;24498.87750561236;25116.869740862072;25187.496250075263 09:44:07 INFO - PROCESS | 1645 | |2;jquery.html;305.71110300765775;352.65616024376254;366.8074261012968;379.3020841651361;408.3018039153048;14843.40626374945;15350.692986140271;17643.647127057466;19467.415977520697;19662;16829.579260518494;19820.81075135493;21017.054232559534;21747.891260543714;22036.779632203674;6172.753089876411;6735.259121496656;6786.8303292417595;6791.252962174181;6802.625855577966;6533.967330163343;6721.260661327275;6764.6617669116595;6783.152105986752;6820.352066553694;6544.723778863124;6565.934340656604;6809.6595170241535;6811.284815094394;6816.045753594501;6489.31862154474;6803.319668033207;6862.7598034068815;6867.278935711728;6872.175338959357;6623.013096071208;6635.13743213384;6638.900416493757;6820.488463365218;7208.315210055036;27680.723192768015;28298.29254268639;28483.57274640882;28540.714592854012;28858.855705721548;2361.468669549338;2453.1659235859715;2474.6040633498556;2516.7860731837814;2958.4970555005702;14917.776233356508;16420.917895410566;16474.588135296595;16952.491425257263;17373;1916.8849869007904;1926.1428664244418;2034.043999320317;2034.3591768592846;2041.9285325013552;119568;133685;138739;141432;141802.29098854543;16515.28406108616;20294.49263768388;20914.16343346249;21013.369598912057;21125.68311475329;27853.86073069622;29389;29477;30668.693313066582;32502.83748581242;10040.14658754014;10383.650125483638;10503.474826258656;10512.789744205073;10736.516856741466;8451.957740211383;8626.95686521576;8638.568071596395;8824.691135810215;8840.602172902234;7356.498790411286;8584.828303434022;9222.631094756134;9314.86027709585;9444.669436569688;3077.1230199393513;3573.5533058367705;3699.5560532735703;3709.276691045274;3718.727519782574;384.9441830934499;708.6669265445232;818.059231883339;954.19370631816;989.5250279865704;10988.285761425483;11682.415879206006;12035.217710848767;12063.879361206451;12127.878721212852;430.87504623659413;841.1504380575662;890.5636238243344;912.977175570616;948.7011591348703;10336.896631033593;10678.893211067945;10697.732556685989;10764.277715565471;10775.946120269506;558208.2089589526;564388;568475;576923;579545;120019;120713;120802.3959880195;124460.37769811093;125744;949.0983565612696;962.6582563190107;979.7893452907659;980.8283550378655;984.3257368702461;17966.461006169837;18003.72994405059;18043;18055.548611284823;18166.5458363542;42924.42453452678;51456.22815657693;51469.742651286506;51763.35734542879;52880.73559632177;58292;76535.46929061499;77040;77763.61118194372;78296.4340713194;6576.704048317742;7764.84470310602;7966.641501132347;8038.075621303391;8040.477368970998;9731.367461115005;11933.641990740292;12051.638450846489;12486.313252771184;12514.687132821387;10644.414557199429;10724.678259652223;10927.45362731876;11040.116790656888;11076.5569377224;10121.645742398981;10429.374237545771;10450.059494645518;10699.251052426256;11131.998120169224;5558.082916318924;7419.666115024729;10038.598456061676;10932.617358392736;11033.779324413626;7752.14726380109;7965.880511792212;7992.560409177551;8059.879101813361;8195.918040819754;8119.959400202961;8639.029724624765;9976.800463990825;10834.241603087708;11033.668989930315 09:44:07 INFO - PROCESS | 1645 | |3;mootools.html;1322.3190057120582;1521.0949485056394;1658.56048147241;1789.3558319005165;1878.5303674081472;8324.33405327574;8788.428752131107;8789;8794.6921857735;8803.867941980876;7754.108277548084;8013.158618345077;8035.276825085741;8402.91597084029;8561.272291855184;2300.919467818627;2339.228054741931;2340.473393486469;2340.8010319122895;2342.8594284342907;2290.1526435218907;2313.3175713164574;2316.9652455213186;2336.778006089419;2337.520808234308;2291.186628746796;2306.215886598556;2314.6296592545195;2317;2330.96503552446;2281.2243837095302;2296.115995341797;2301.390131615123;2301.6662583925236;2303.6890019847274;1927.787943326233;2024.4533975826444;2275.5107651854933;2317.6060069788177;2318.2349824557855;8514.403991720583;8704.564771761387;8714.782130446789;8716.128387161296;8723.38936274461;5114.181730923035;5260.684358938438;5268.762905669216;5279.44565820591;5279.70961597112;3094.582231398755;3344.5986481622117;3464.7574669773126;3545.3441113393847;3579.7470885189973;1074.3231763988715;1074.8441475986017;1075.704181350127;1093.1582681335328;1093.912487001046;11293.15301352402;11426.485808138654;11429.02853257474;11433;11467.942660286728;4480.14877173336;4522.479914809839;4700.224462963641;4727.550882666142;4743.762811859462;9748.366356186825;9765.707028789147;9767.51162441875;9777;9813.754656133653;5235.214717792285;5254.185601231815;5255.39562950258;5260.053190425683;5263.26314315996;4318.1363727254675;4327.459067616548;4779.498152693986;4806.687565308243;4827.889585395308;3027.576139340494;3777.792221427848;3874.3994680824517;3891.801132360264;3929.410588411704;1229.1518851992275;1236.1532350340046;1238.2013601227338;1247.3700781105483;1261.1928365845865;722.609790713009;831.9126491718404;894.9507777072323;895.7805337692307;934.6588495199203;5461.2627295315415;5735.483806457355;5759.1649210865025;5946.940530594725;6076.361981991916;923.8614207868874;927.6614035876856;929.4284015330658;947.7914858731068;989.3272574649163;3650.142216579102;3713.9071523211596;3899.161680238762;3925.862594809168;3935.7726664135707;9130.589123489459;10344.37933723979;10662.466876656135;10686.519106640064;10756.677299681021;9903.059209375098;10485.056344928993;10492.790144197073;10675.87903270161;10705.678829635124;7982.960085199653;8213.014438267446;8216.507009579444;8221.753347399588;8225.71210007647;5748.568857335633;5757;5770.451807078321;5967.134765458897;6118.051701986199;9674.226061915171;10002.349847259904;10017.449040302854;10022.849657255292;10037.046480584333;9967.601295948081;10257.487125643538;10260.846087308548;10267.127294180078;10272.024157705006;6589.308122647245;6825;6847;7415.777526674208;7559.924400755922;7603.391728661583;7661.387089032975;8237;8322;8400.075991641037;7158.606276654834;7221.53060051095;7231.059962204879;7290.161631412456;7386.704531818882;7052.471064670273;7126.857462850818;7308.634568271672;7315.012473316035;7356.043714317105;6787.423069039187;6870.484713646397;6902.240753517009;6953.061336719478;6954.756583519553;4750.857474275777;4775.044991001744;4824.541668541483;4834.250691142878;4947.975260123676;4867.367242258484;4948.752562371795;4980.925286120639;5032.094223039741;5051.040302342543 09:44:07 INFO - PROCESS | 1645 | |4;prototype.html;305.57372465410754;309.288636136885;316.90809665197094;321.78762017068726;325.08812780151663;5142.662907644011;5282.709450980195;5522.5581953443725;5529.3230002048585;5554.1946417769395;5169.30214421053;5208.921866172011;5308.416074231832;5365.517103460697;5435;3624.9125262421167;3661.5972243053375;3705;4116.485439320078;4126.42230087788;3802.9429558556503;3804.6385593368723;3973.1457736586626;4099.200655872106;4109.671226301889;3546.5034895114577;3572.4641303804506;3607.8196090195515;3750.5686846012786;4105.712600117993;3750.3811871041516;3918.686505079601;4082.1631565528996;4121.196366708493;4126.938095928564;3200.7119359257545;3383.5601371821754;3563.0914116900285;3572.160542272564;3599.42409214527;4160.43834082398;4976.402831660188;5283.1546952487415;5284.550813180885;5299.482745695802;3987.501562304712;4635.976820115911;4719.905601887943;4720.693154944917;4774.689645173053;5751.654900705971;5752.482276595085;5780.364159942403;5794.304683437972;5798.666306749429;3147.4734753644466;3896.5908579599018;3898.6101389860787;3901.8244179012013;3918.608139186087;5361.035013697533;6032.160191141744;6048.637081775108;6066.514678825683;6078.513718902477;3563.376409128444;3638.290533346025;3787.4318852172396;3935.0949281665376;3963.088489647397;3400.9489857652156;3722.1439069014277;4039.939400908989;4046.5144182697677;4049.493813273341;4070.104576993057;4549.545045495424;4723.6929599575915;4740.431148262231;4750.358701575312;5410.323709536308;5505.3114413343155;5806.709664516842;5808.767649294065;5888.499477544457;1166.7258194324327;1268.9340953599021;1351.3445978700322;1363.8158848555518;1383.8823699985412;833.9499630022218;834.1658341658342;845.1590667285967;906.9319801014818;921.9354645174908;4347.174186841534;4453.910921781546;5278.630495865329;5322.281491998608;5378.677279363251;5775.451332123442;5794.971025144847;5795.594308398372;5801.156034710979;5849.6782676952325;4941.777620007108;4954.331165292711;5281.20781882713;5302.522772950453;5304.708241046779;2684.463107378532;3028.4851575232265;3066.5553494743135;3079.969200307968;3089.335792804513;5770.835936523804;5992.471919660458;6027.38356985805;6037.486813620892;6047.850908327404;5136.152534831711;5490.890182196414;6135.877282454326;6211.782587609412;6255.40573645503;6040.426159514839;6287.49700023997;6301.905471417932;6343.365663433804;6356.2054743157105;5540.972295138659;5666.563377747608;5983.700814959322;6050.757969681164;6058.787942421994;5970.283565972111;5971.701414929149;5975.193348897843;5983.37174596661;5985.820425387245;5801.158831969426;5832.008558544972;6264.968675156595;6291.716872740829;6346.333634968262;3942.9408558872215;3967.523897132247;3971.5035620547433;3989.840406383712;4022.235775202702;5476.91784623223;5533.418991006048;6076.6961651916345;6101.572889897665;6120.724567394389;5746.339170995389;5780.30636323627;5814.709264536672;5890.617109887844;5916.467517923407;5350.448369972664;5359.464053594766;5822.650640961556;5832.883342333044;5834.474897259267;5523.4200408956485;5659.207710920557;5745.913811292918;5760.452756988079;5779.190913272061;5246.31797866275;5561.582881283839;5829.47534721877;5846.193826963166;5877.706114694333;4330.631896288724;4859.708417494961;4897.7061376316105;5628.465295796893;5721.8569535761935 09:44:07 INFO - PROCESS | 1645 | |5;yui.html;703.5532436902566;712.2236761929496;715.2811424518359;738.3908275672571;808.1312588966861;14831.258437078144;15519.689606207869;15577.532674019769;15578.688426231483;15601.843981560181;13171.341432928362;13178.077534572583;13185.208887466759;13186.868131318684;13199.6700082498;661.8080756580586;680.6800803622315;686.2485578291762;828.3952714518405;852.2755657690975;826.6156237349661;826.9173082691743;848.6053984897021;857.1128881607538;860.4407135362034;879.2614204068581;880.4937161132342;882.2853488674162;882.5543100734152;884.2086332732201;694.3924066441863;708.2740191303903;874.8206617643432;876.4040452492303;876.8158686675838;646.5861848417017;658.3811217455624;661.9040239165342;663.5686803577665;664.3124366280877;14565.708685826225;14573.489927852474;14598.34307456167;14602.415903363853;14605.70788584233;13090.672733181651;13382.397792099378;13563;13620.114692545052;13886.583402497941;12195.512179512809;12242.520202548263;12318;12398.442070106867;12883.742325153444;4399.174342647797;4447.577480139382;4510.977445112753;4551.590356867898;4638.9536104638855;94614;112471;115343.84656153416;115798.42100789526;118735;8840.381173317806;10571.015630044289;10684.839727404094;10740.892591073989;10818;20867.686984695243;20869.582608347748;20879;20894;20911.68632470514;7509.774706758806;7540.773776786705;7747.573883436352;7763.417743669247;7764.728234511765;4222.469498867367;4226.302660061056;4247.299195632748;4289.206496798102;4433.800478978454;3336.0992532016703;3401.523786669868;3448.275862068994;3452.2577645806273;3456.792592444461;601.7683191971123;605.1769593353036;613.1262950295811;616.7594638091148;622.6077571130159;590.2945979554391;601.392593480579;604.2627993847499;605.8485378655337;631.8831016261914;8653.826923461496;8670.609822558;8756.511711138464;8814.51520166397;8997.775055623531;499.6702176563451;502.3444405051443;616.3805375597495;625.5158765675146;644.6196743921109;3918.3730603103368;4376.803043863034;4530;4540.388162202436;4549.249373853278;82386.94032649232;86670.56664716636;113218;123887.38056309841;144458;123463;123931.38034309771;125449;128858;131781.68218317695;103189.48405258075;108134;108351;109591;110997;8324.125966773401;8859;8954.417962832395;8987.236084932592;9165.404248723811;58062.7096864513;61122.083168753394;61162.082568762395;61738.382616173265;64045.679771600844;91558.54220728854;92354;92830;93398;93745;11184.496697648789;11324.433778311217;11372.43137843121;11477.598284060017;11757.294562326288;12253.69365765863;12261.38693065361;12460.12779105454;12811.231326120462;12911.612651620466;11024.842391548771;11311.943440282746;12273.631791046282;12312.81530777057;13516.12145210558;11143.554257829921;13439.798403023768;13723.794143087662;13783.035187536776;13835.48224304619;13083.99068214335;13100.654783012586;13294.91562535774;13436.596902092953;13679.31603419845;11150.944245278723;11405.828912566152;11443.771124577628;11461.885381146416;11533.250338727956;8279.668813247403;9489.66786162481;10070.194384449373;10145.847812282675;11469.483873225892 09:44:07 INFO - PROCESS | 1645 | __end_tp_report 09:44:07 INFO - PROCESS | 1645 | __start_cc_report 09:44:07 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1953 09:44:07 INFO - PROCESS | 1645 | __end_cc_report 09:44:07 INFO - PROCESS | 1645 | __startTimestamp1476290647769__endTimestamp 09:44:07 INFO - PROCESS | 1645 | 09:44:07 INFO - PROCESS | 1645 | ------- Summary: start ------- 09:44:07 INFO - PROCESS | 1645 | Number of tests: 6 09:44:07 INFO - PROCESS | 1645 | 09:44:07 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5721.17 Median:5910.53 stddev:625.65 (10.6%) stddev-sans-first:598.69 09:44:07 INFO - PROCESS | 1645 | Values: 3325.9 3328.2 3332.7 3357.2 3387.0 5512.8 5629.5 5689.1 5722.3 5755.8 5627.7 5664.4 5691.7 5752.3 5802.1 5137.7 5176.4 5195.4 5203.6 5222.6 5178.6 5275.8 5285.7 5292.1 5334.5 5110.6 5232.1 5235.6 5265.1 5295.3 5133.4 5218.4 5223.8 5227.4 5233.6 5112.6 5159.5 5184.6 5191.8 5203.3 5636.9 5664.5 5665.4 5666.9 5671.7 6095.5 6102.4 6103.5 6109.2 6138.5 6136.9 6175.4 6188.3 6207.5 6208.0 5642.2 5713.0 5747.6 5761.2 5786.9 6276.9 6290.0 6297.0 6303.6 6327.7 6115.1 6122.6 6124.1 6134.4 6139.5 6045.3 6107.6 6109.2 6114.6 6125.2 6165.4 6198.7 6207.5 6214.9 6222.2 6240.1 6243.3 6249.7 6252.0 6259.9 4829.3 4891.6 4892.0 4917.6 4972.6 4372.5 4414.5 4431.8 4443.7 4528.0 5708.7 5725.6 5729.6 5731.7 5736.9 6089.3 6183.6 6287.0 6326.3 6338.5 5632.9 5691.6 5716.1 5737.5 5759.3 5415.8 5416.6 5427.7 5436.6 5467.5 6291.6 6304.9 6307.9 6319.3 6323.1 6098.2 6102.5 6158.4 6222.1 6272.9 5413.9 6196.6 6244.4 6269.0 6313.7 6160.9 6166.3 6180.2 6193.1 6194.8 6075.8 6101.8 6243.0 6295.2 6315.3 5971.2 6040.8 6046.4 6083.6 6109.0 6031.4 6071.2 6097.4 6100.1 6136.8 5892.0 5912.6 5923.6 5925.2 5951.0 5910.5 6006.8 6012.3 6067.3 6080.1 5871.0 5876.3 5879.0 5879.8 5883.7 09:44:07 INFO - PROCESS | 1645 | 09:44:07 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:67564.94 Median:38369.00 stddev:150932.59 (393.4%) stddev-sans-first:151271.99 09:44:07 INFO - PROCESS | 1645 | Values: 494.8 496.9 516.2 521.4 547.5 24561.8 31077.2 40702.0 41531.0 41912.0 39282.6 39596.0 39610.4 39641.2 39706.4 8136.5 9384.4 9514.0 9537.9 9540.0 9349.8 9363.9 9450.9 9451.9 9490.1 8101.2 9440.5 9493.7 9496.6 9522.8 9447.7 9475.6 9484.1 9487.6 9489.1 8439.5 9400.9 9472.8 9474.9 9495.1 38492.0 38689.8 38730.2 38762.0 38774.8 3188.0 3265.1 3267.7 3503.9 3726.4 29400.7 29590.6 29886.3 29913.4 31041.8 3116.2 3171.3 3184.2 3233.0 3265.7 406245.0 406735.0 407200.0 410225.0 410907.0 54491.0 54769.9 54771.0 54798.0 54830.5 33046.2 33575.8 33630.5 34562.0 56556.7 15525.7 15841.8 15872.4 15891.5 15895.3 12141.5 12234.8 12235.0 12247.9 12257.9 17663.9 17772.0 17774.1 17781.6 17812.0 6363.8 7112.4 7540.3 7681.9 7761.7 969.8 991.5 1008.7 1041.4 1054.8 29032.3 29172.6 29432.0 29728.7 29785.6 999.6 1002.1 1021.6 1051.8 1067.9 14524.7 14991.3 15059.9 15459.7 15463.8 638033.0 673670.6 674162.0 674868.0 675060.0 54715.5 55210.4 55336.0 55342.0 55446.4 1049.6 1124.3 1249.6 1349.4 1361.3 24522.6 26896.0 27217.9 29049.4 30213.4 52269.0 52998.5 53198.0 53223.7 53274.0 579433.0 581116.0 583792.0 585823.0 586192.7 31642.2 33749.3 36467.6 41009.6 41531.5 41364.4 43609.7 43883.1 43980.8 44689.8 30937.0 36807.4 36916.6 38187.0 38246.0 36194.0 36592.5 37197.5 37399.8 37495.4 35699.5 35841.3 36573.3 36733.3 37080.1 30219.8 31420.1 32705.8 32812.8 32883.2 21590.7 24275.8 24498.9 25116.9 25187.5 09:44:07 INFO - PROCESS | 1645 | 09:44:07 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:35101.11 Median:16427.75 stddev:95453.86 (581.1%) stddev-sans-first:95685.88 09:44:07 INFO - PROCESS | 1645 | Values: 305.7 352.7 366.8 379.3 408.3 14843.4 15350.7 17643.6 19467.4 19662.0 16829.6 19820.8 21017.1 21747.9 22036.8 6172.8 6735.3 6786.8 6791.3 6802.6 6534.0 6721.3 6764.7 6783.2 6820.4 6544.7 6565.9 6809.7 6811.3 6816.0 6489.3 6803.3 6862.8 6867.3 6872.2 6623.0 6635.1 6638.9 6820.5 7208.3 27680.7 28298.3 28483.6 28540.7 28858.9 2361.5 2453.2 2474.6 2516.8 2958.5 14917.8 16420.9 16474.6 16952.5 17373.0 1916.9 1926.1 2034.0 2034.4 2041.9 119568.0 133685.0 138739.0 141432.0 141802.3 16515.3 20294.5 20914.2 21013.4 21125.7 27853.9 29389.0 29477.0 30668.7 32502.8 10040.1 10383.7 10503.5 10512.8 10736.5 8452.0 8627.0 8638.6 8824.7 8840.6 7356.5 8584.8 9222.6 9314.9 9444.7 3077.1 3573.6 3699.6 3709.3 3718.7 384.9 708.7 818.1 954.2 989.5 10988.3 11682.4 12035.2 12063.9 12127.9 430.9 841.2 890.6 913.0 948.7 10336.9 10678.9 10697.7 10764.3 10775.9 558208.2 564388.0 568475.0 576923.0 579545.0 120019.0 120713.0 120802.4 124460.4 125744.0 949.1 962.7 979.8 980.8 984.3 17966.5 18003.7 18043.0 18055.5 18166.5 42924.4 51456.2 51469.7 51763.4 52880.7 58292.0 76535.5 77040.0 77763.6 78296.4 6576.7 7764.8 7966.6 8038.1 8040.5 9731.4 11933.6 12051.6 12486.3 12514.7 10644.4 10724.7 10927.5 11040.1 11076.6 10121.6 10429.4 10450.1 10699.3 11132.0 5558.1 7419.7 10038.6 10932.6 11033.8 7752.1 7965.9 7992.6 8059.9 8195.9 8120.0 8639.0 9976.8 10834.2 11033.7 09:44:07 INFO - PROCESS | 1645 | 09:44:07 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5600.51 Median:4907.67 stddev:3148.12 (64.1%) stddev-sans-first:3140.53 09:44:07 INFO - PROCESS | 1645 | Values: 1322.3 1521.1 1658.6 1789.4 1878.5 8324.3 8788.4 8789.0 8794.7 8803.9 7754.1 8013.2 8035.3 8402.9 8561.3 2300.9 2339.2 2340.5 2340.8 2342.9 2290.2 2313.3 2317.0 2336.8 2337.5 2291.2 2306.2 2314.6 2317.0 2331.0 2281.2 2296.1 2301.4 2301.7 2303.7 1927.8 2024.5 2275.5 2317.6 2318.2 8514.4 8704.6 8714.8 8716.1 8723.4 5114.2 5260.7 5268.8 5279.4 5279.7 3094.6 3344.6 3464.8 3545.3 3579.7 1074.3 1074.8 1075.7 1093.2 1093.9 11293.2 11426.5 11429.0 11433.0 11467.9 4480.1 4522.5 4700.2 4727.6 4743.8 9748.4 9765.7 9767.5 9777.0 9813.8 5235.2 5254.2 5255.4 5260.1 5263.3 4318.1 4327.5 4779.5 4806.7 4827.9 3027.6 3777.8 3874.4 3891.8 3929.4 1229.2 1236.2 1238.2 1247.4 1261.2 722.6 831.9 895.0 895.8 934.7 5461.3 5735.5 5759.2 5946.9 6076.4 923.9 927.7 929.4 947.8 989.3 3650.1 3713.9 3899.2 3925.9 3935.8 9130.6 10344.4 10662.5 10686.5 10756.7 9903.1 10485.1 10492.8 10675.9 10705.7 7983.0 8213.0 8216.5 8221.8 8225.7 5748.6 5757.0 5770.5 5967.1 6118.1 9674.2 10002.3 10017.4 10022.8 10037.0 9967.6 10257.5 10260.8 10267.1 10272.0 6589.3 6825.0 6847.0 7415.8 7559.9 7603.4 7661.4 8237.0 8322.0 8400.1 7158.6 7221.5 7231.1 7290.2 7386.7 7052.5 7126.9 7308.6 7315.0 7356.0 6787.4 6870.5 6902.2 6953.1 6954.8 4750.9 4775.0 4824.5 4834.3 4948.0 4867.4 4948.8 4980.9 5032.1 5051.0 09:44:07 INFO - PROCESS | 1645 | 09:44:07 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4660.44 Median:5303.62 stddev:1489.96 (28.1%) stddev-sans-first:1457.84 09:44:07 INFO - PROCESS | 1645 | Values: 305.6 309.3 316.9 321.8 325.1 5142.7 5282.7 5522.6 5529.3 5554.2 5169.3 5208.9 5308.4 5365.5 5435.0 3624.9 3661.6 3705.0 4116.5 4126.4 3802.9 3804.6 3973.1 4099.2 4109.7 3546.5 3572.5 3607.8 3750.6 4105.7 3750.4 3918.7 4082.2 4121.2 4126.9 3200.7 3383.6 3563.1 3572.2 3599.4 4160.4 4976.4 5283.2 5284.6 5299.5 3987.5 4636.0 4719.9 4720.7 4774.7 5751.7 5752.5 5780.4 5794.3 5798.7 3147.5 3896.6 3898.6 3901.8 3918.6 5361.0 6032.2 6048.6 6066.5 6078.5 3563.4 3638.3 3787.4 3935.1 3963.1 3400.9 3722.1 4039.9 4046.5 4049.5 4070.1 4549.5 4723.7 4740.4 4750.4 5410.3 5505.3 5806.7 5808.8 5888.5 1166.7 1268.9 1351.3 1363.8 1383.9 833.9 834.2 845.2 906.9 921.9 4347.2 4453.9 5278.6 5322.3 5378.7 5775.5 5795.0 5795.6 5801.2 5849.7 4941.8 4954.3 5281.2 5302.5 5304.7 2684.5 3028.5 3066.6 3080.0 3089.3 5770.8 5992.5 6027.4 6037.5 6047.9 5136.2 5490.9 6135.9 6211.8 6255.4 6040.4 6287.5 6301.9 6343.4 6356.2 5541.0 5666.6 5983.7 6050.8 6058.8 5970.3 5971.7 5975.2 5983.4 5985.8 5801.2 5832.0 6265.0 6291.7 6346.3 3942.9 3967.5 3971.5 3989.8 4022.2 5476.9 5533.4 6076.7 6101.6 6120.7 5746.3 5780.3 5814.7 5890.6 5916.5 5350.4 5359.5 5822.7 5832.9 5834.5 5523.4 5659.2 5745.9 5760.5 5779.2 5246.3 5561.6 5829.5 5846.2 5877.7 4330.6 4859.7 4897.7 5628.5 5721.9 09:44:07 INFO - PROCESS | 1645 | 09:44:07 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:23411.19 Median:4224.39 stddev:36743.33 (869.8%) stddev-sans-first:36806.84 09:44:07 INFO - PROCESS | 1645 | Values: 703.6 712.2 715.3 738.4 808.1 14831.3 15519.7 15577.5 15578.7 15601.8 13171.3 13178.1 13185.2 13186.9 13199.7 661.8 680.7 686.2 828.4 852.3 826.6 826.9 848.6 857.1 860.4 879.3 880.5 882.3 882.6 884.2 694.4 708.3 874.8 876.4 876.8 646.6 658.4 661.9 663.6 664.3 14565.7 14573.5 14598.3 14602.4 14605.7 13090.7 13382.4 13563.0 13620.1 13886.6 12195.5 12242.5 12318.0 12398.4 12883.7 4399.2 4447.6 4511.0 4551.6 4639.0 94614.0 112471.0 115343.8 115798.4 118735.0 8840.4 10571.0 10684.8 10740.9 10818.0 20867.7 20869.6 20879.0 20894.0 20911.7 7509.8 7540.8 7747.6 7763.4 7764.7 4222.5 4226.3 4247.3 4289.2 4433.8 3336.1 3401.5 3448.3 3452.3 3456.8 601.8 605.2 613.1 616.8 622.6 590.3 601.4 604.3 605.8 631.9 8653.8 8670.6 8756.5 8814.5 8997.8 499.7 502.3 616.4 625.5 644.6 3918.4 4376.8 4530.0 4540.4 4549.2 82386.9 86670.6 113218.0 123887.4 144458.0 123463.0 123931.4 125449.0 128858.0 131781.7 103189.5 108134.0 108351.0 109591.0 110997.0 8324.1 8859.0 8954.4 8987.2 9165.4 58062.7 61122.1 61162.1 61738.4 64045.7 91558.5 92354.0 92830.0 93398.0 93745.0 11184.5 11324.4 11372.4 11477.6 11757.3 12253.7 12261.4 12460.1 12811.2 12911.6 11024.8 11311.9 12273.6 12312.8 13516.1 11143.6 13439.8 13723.8 13783.0 13835.5 13084.0 13100.7 13294.9 13436.6 13679.3 11150.9 11405.8 11443.8 11461.9 11533.3 8279.7 9489.7 10070.2 10145.8 11469.5 09:44:07 INFO - PROCESS | 1645 | -------- Summary: end -------- 09:44:07 INFO - PROCESS | 1645 | 09:44:08 INFO - TEST-INFO | 1645: exit 0 09:44:08 INFO - TEST-OK | dromaeo_css | took 1119424ms 09:44:08 INFO - TEST-START | kraken 09:44:08 INFO - operating with platform_type : mac_ 09:44:08 INFO - Initialising browser for kraken test... 09:44:08 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/tmp7CQXXz/profile http://localhost:49267/getInfo.html) 09:44:10 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 09:44:10 INFO - PROCESS | 1655 | colorDepth:24 09:44:10 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 09:44:10 INFO - PROCESS | 1655 | __metrics 09:44:10 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:44:10 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:44:11 INFO - TEST-INFO | 1655: exit 0 09:44:11 INFO - Browser initialized. 09:44:11 INFO - Running cycle 1/1 for kraken test... 09:44:11 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/tmp7CQXXz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:23 INFO - PROCESS | 1656 | RSS: Main: 243122176 09:44:23 INFO - PROCESS | 1656 | 09:44:26 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 09:44:27 INFO - PROCESS | 1656 | RSS: Main: 293490688 09:44:27 INFO - PROCESS | 1656 | 09:44:30 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 09:44:30 INFO - PROCESS | 1656 | RSS: Main: 293203968 09:44:30 INFO - PROCESS | 1656 | 09:44:34 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 09:44:34 INFO - PROCESS | 1656 | RSS: Main: 383561728 09:44:34 INFO - PROCESS | 1656 | 09:44:36 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 09:44:37 INFO - PROCESS | 1656 | RSS: Main: 283947008 09:44:37 INFO - PROCESS | 1656 | 09:44:39 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:44:40 INFO - PROCESS | 1656 | RSS: Main: 287883264 09:44:40 INFO - PROCESS | 1656 | 09:44:42 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 09:44:43 INFO - PROCESS | 1656 | RSS: Main: 323997696 09:44:43 INFO - PROCESS | 1656 | 09:44:46 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 09:44:47 INFO - PROCESS | 1656 | RSS: Main: 328646656 09:44:47 INFO - PROCESS | 1656 | 09:44:49 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 09:44:50 INFO - PROCESS | 1656 | RSS: Main: 324784128 09:44:50 INFO - PROCESS | 1656 | 09:44:52 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:52 INFO - PROCESS | 1656 | RSS: Main: 300355584 09:44:52 INFO - PROCESS | 1656 | 09:44:54 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:55 INFO - PROCESS | 1656 | RSS: Main: 304115712 09:44:55 INFO - PROCESS | 1656 | 09:44:57 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:44:58 INFO - PROCESS | 1656 | RSS: Main: 308400128 09:44:58 INFO - PROCESS | 1656 | 09:45:01 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:45:01 INFO - PROCESS | 1656 | RSS: Main: 321269760 09:45:01 INFO - PROCESS | 1656 | 09:45:04 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:45:05 INFO - PROCESS | 1656 | RSS: Main: 321036288 09:45:05 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 09:45:07 INFO - PROCESS | 1656 | RSS: Main: 364257280 09:45:07 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | __start_tp_report 09:45:07 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 09:45:07 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 09:45:07 INFO - PROCESS | 1656 | |i|pagename|runs| 09:45:07 INFO - PROCESS | 1656 | |0;ai-astar;112;111;112;112;117;158;165;111;111;112 09:45:07 INFO - PROCESS | 1656 | |1;audio-beat-detection;149;129;138;165;131;141;139;112;143;117 09:45:07 INFO - PROCESS | 1656 | |2;audio-dft;182;183;182;185;182;182;182;181;182;183 09:45:07 INFO - PROCESS | 1656 | |3;audio-fft;80;59;58;88;62;59;57;58;84;75 09:45:07 INFO - PROCESS | 1656 | |4;audio-oscillator;88;69;93;70;69;69;92;65;65;89 09:45:07 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;87;84;87;123;87;84;87;84;86;83 09:45:07 INFO - PROCESS | 1656 | |6;imaging-darkroom;95;97;96;95;96;96;112;160;113;96 09:45:07 INFO - PROCESS | 1656 | |7;imaging-desaturate;86;87;84;84;80;142;131;122;85;85 09:45:07 INFO - PROCESS | 1656 | |8;json-parse-financial;56;54;52;53;54;55;53;54;56;53 09:45:07 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;72;81;66;75;72;71;70;72;71;72 09:45:07 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;86;87;88;85;87;82;85;74;98;108 09:45:07 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;146;144;147;145;146;149;150;157;208;146 09:45:07 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;172;175;171;173;172;170;175;171;171;170 09:45:07 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;69;70;81;86;88;88;70;68;67;69 09:45:07 INFO - PROCESS | 1656 | __end_tp_report 09:45:07 INFO - PROCESS | 1656 | __start_cc_report 09:45:07 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2010 09:45:07 INFO - PROCESS | 1656 | __end_cc_report 09:45:07 INFO - PROCESS | 1656 | __startTimestamp1476290707441__endTimestamp 09:45:07 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | ------- Summary: start ------- 09:45:07 INFO - PROCESS | 1656 | Number of tests: 14 09:45:07 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:122.10 Median:112.00 stddev:20.90 (18.7%) stddev-sans-first:21.85 09:45:07 INFO - PROCESS | 1656 | Values: 112.0 111.0 112.0 112.0 117.0 158.0 165.0 111.0 111.0 112.0 09:45:07 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:140.00 stddev:15.30 (10.9%) stddev-sans-first:15.53 09:45:07 INFO - PROCESS | 1656 | Values: 149.0 129.0 138.0 165.0 131.0 141.0 139.0 112.0 143.0 117.0 09:45:07 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:182.40 Median:182.00 stddev:1.07 (0.6%) stddev-sans-first:1.13 09:45:07 INFO - PROCESS | 1656 | Values: 182.0 183.0 182.0 185.0 182.0 182.0 182.0 181.0 182.0 183.0 09:45:07 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:68.00 Median:68.50 stddev:12.33 (18.0%) stddev-sans-first:12.29 09:45:07 INFO - PROCESS | 1656 | Values: 80.0 59.0 58.0 88.0 62.0 59.0 57.0 58.0 84.0 75.0 09:45:07 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:79.00 stddev:11.90 (15.1%) stddev-sans-first:11.93 09:45:07 INFO - PROCESS | 1656 | Values: 88.0 69.0 93.0 70.0 69.0 69.0 92.0 65.0 65.0 89.0 09:45:07 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:89.20 Median:86.50 stddev:11.98 (13.8%) stddev-sans-first:12.68 09:45:07 INFO - PROCESS | 1656 | Values: 87.0 84.0 87.0 123.0 87.0 84.0 87.0 84.0 86.0 83.0 09:45:07 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:105.60 Median:96.00 stddev:20.34 (21.2%) stddev-sans-first:21.21 09:45:07 INFO - PROCESS | 1656 | Values: 95.0 97.0 96.0 95.0 96.0 96.0 112.0 160.0 113.0 96.0 09:45:07 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:98.60 Median:84.50 stddev:23.37 (27.7%) stddev-sans-first:24.34 09:45:07 INFO - PROCESS | 1656 | Values: 86.0 87.0 84.0 84.0 80.0 142.0 131.0 122.0 85.0 85.0 09:45:07 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.33 (2.5%) stddev-sans-first:1.20 09:45:07 INFO - PROCESS | 1656 | Values: 56.0 54.0 52.0 53.0 54.0 55.0 53.0 54.0 56.0 53.0 09:45:07 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.00 stddev:3.82 (5.3%) stddev-sans-first:4.06 09:45:07 INFO - PROCESS | 1656 | Values: 72.0 81.0 66.0 75.0 72.0 71.0 70.0 72.0 71.0 72.0 09:45:07 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:86.50 stddev:9.17 (10.6%) stddev-sans-first:9.69 09:45:07 INFO - PROCESS | 1656 | Values: 86.0 87.0 88.0 85.0 87.0 82.0 85.0 74.0 98.0 108.0 09:45:07 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:153.80 Median:148.00 stddev:19.40 (13.1%) stddev-sans-first:20.37 09:45:07 INFO - PROCESS | 1656 | Values: 146.0 144.0 147.0 145.0 146.0 149.0 150.0 157.0 208.0 146.0 09:45:07 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.00 stddev:1.83 (1.1%) stddev-sans-first:1.94 09:45:07 INFO - PROCESS | 1656 | Values: 172.0 175.0 171.0 173.0 172.0 170.0 175.0 171.0 171.0 170.0 09:45:07 INFO - PROCESS | 1656 | 09:45:07 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.60 Median:75.50 stddev:8.98 (11.9%) stddev-sans-first:9.21 09:45:07 INFO - PROCESS | 1656 | Values: 69.0 70.0 81.0 86.0 88.0 88.0 70.0 68.0 67.0 69.0 09:45:07 INFO - PROCESS | 1656 | -------- Summary: end -------- 09:45:07 INFO - PROCESS | 1656 | 09:45:08 INFO - TEST-INFO | 1656: exit 0 09:45:08 INFO - TEST-OK | kraken | took 59838ms 09:45:08 INFO - SUITE-END | took 1179s 09:45:08 INFO - Completed test suite (00:19:39) 09:45:08 INFO - javascript benchmark 09:45:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.8503367348467, 3328.184594774281, 3332.683589981957, 3357.1774915145793, 3387.0346951118922, 5512.779488820453, 5629.493345598895, 5689.061304884699, 5722.341930677973, 5755.7697692092315, 5627.7467513961865, 5664.376918538957, 5691.715414229282, 5752.309722833255, 5802.100674395465, 5137.717425541594, 5176.430592634807, 5195.376554813409, 5203.583713302926, 5222.582193424536, 5178.559822415099, 5275.815346462875, 5285.656432331905, 5292.073887069767, 5334.546563542103, 5110.591152707774, 5232.084385232569, 5235.58115350771, 5265.131253343194, 5295.31160949078, 5133.383993920716, 5218.373795144607, 5223.843284701465, 5227.424983251877, 5233.633645644806, 5112.642115051911, 5159.535641792257, 5184.559312458446, 5191.792328306901, 5203.323567936182, 5636.859078523029, 5664.490195882349, 5665.3768085510565, 5666.914996275059, 5671.7164141793155, 6095.515930898297, 6102.368068311564, 6103.489197737734, 6109.16175461965, 6138.539609529258, 6136.886723216021, 6175.382461753788, 6188.288346840126, 6207.534434917354, 6208.0, 5642.181883626851, 5713.0, 5747.56893233005, 5761.222234998306, 5786.913196302059, 6276.874462510724, 6289.968550157311, 6296.968515157395, 6303.590266632654, 6327.715252813635, 6115.113308570232, 6122.571420000646, 6124.11200375943, 6134.417230363198, 6139.47814435769, 6045.274567051894, 6107.636783026228, 6109.175261339751, 6114.631938157225, 6125.17440701618, 6165.414285642857, 6198.690065496708, 6207.534434917399, 6214.906776398358, 6222.222222222223, 6240.095186197976, 6243.344448832898, 6249.7187626556915, 6251.9687401563615, 6259.937400626027, 4829.275608658659, 4891.559759621651, 4891.997140586172, 4917.631177661689, 4972.627052971042, 4372.519022907478, 4414.492333381702, 4431.7562534060935, 4443.7111587746695, 4527.954720452819, 5708.743106560215, 5725.570582206351, 5729.598928074995, 5731.713414329267, 5736.856578585485, 6089.330173680892, 6183.598066125777, 6287.0, 6326.335734747877, 6338.492920566344, 5632.85917852057, 5691.601587888891, 5716.142578613241, 5737.483626473638, 5759.251297331404, 5415.810446634349, 5416.566674666017, 5427.674339539641, 5436.646617969898, 5467.480589344006, 6291.591046581958, 6304.873902522016, 6307.936920630735, 6319.336469670802, 6323.08315294289, 6098.220442830473, 6102.489251635809, 6158.445739883432, 6222.128901953821, 6272.933601287701, 5413.945860541344, 6196.628202307876, 6244.406781355764, 6269.0, 6313.652749098844, 6160.907586386297, 6166.290876549254, 6180.165677633462, 6193.102000209854, 6194.81415557534, 6075.817725468243, 6101.816945491642, 6243.021264981054, 6295.244570651551, 6315.3053164152825, 5971.193888824953, 6040.818775436744, 6046.395360463918, 6083.574149809471, 6109.009944784373, 6031.396860314109, 6071.241094863142, 6097.390260973867, 6100.1459795629535, 6136.815895523141, 5891.970540147272, 5912.556558258062, 5923.644581325134, 5925.200097986716, 5950.9702451487465, 5910.527157827278, 6006.819795406145, 6012.278526576839, 6067.332593414809, 6080.148779170831, 5870.970645146747, 5876.294844618673, 5878.970605147118, 5879.794207202727, 5883.705814709333], "value": 5680.958146073491, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.77982297877435, 496.8583953573232, 516.1998901702361, 521.3691433365627, 547.5400663442708, 24561.75438245617, 31077.20305172534, 40701.98245043875, 41531.0, 41912.0, 39282.60717392825, 39596.010099747524, 39610.40584391236, 39641.20717585646, 39706.404403933964, 8136.471129376601, 9384.390014649043, 9513.952430237874, 9537.903141138753, 9539.952300238489, 9349.81300373992, 9363.859542106873, 9450.905490945072, 9451.905480945206, 9490.145886870181, 8101.230383113624, 9440.480773557452, 9493.715188544355, 9496.620135194584, 9522.80954380912, 9447.716568502956, 9475.620975161055, 9484.14642682155, 9487.573059212318, 9489.098535639103, 8439.493630382196, 9400.858987115198, 9472.810543789086, 9474.857877131848, 9495.097965693249, 38492.0, 38689.80655096735, 38730.22539549221, 38762.0, 38774.80612596947, 3187.9579325125806, 3265.0694552052787, 3267.673232676737, 3503.877364292263, 3726.441033844918, 29400.70599294001, 29590.556141657893, 29886.252843678863, 29913.401731965456, 31041.84479077613, 3116.205367631262, 3171.349873275973, 3184.1561986073707, 3233.0, 3265.6571060038827, 406245.0, 406735.0, 407200.0, 410225.0, 410907.0, 54491.0, 54769.904601908536, 54771.0, 54798.0, 54830.45169548333, 33046.17384565405, 33575.824846130265, 33630.49554256688, 34562.0, 56556.71721641366, 15525.689486210213, 15841.762373564407, 15872.365105395655, 15891.523254302389, 15895.284712187979, 12141.514339426501, 12234.81647775284, 12235.0, 12247.93876030632, 12257.877421225852, 17663.911680441517, 17772.022538760233, 17774.111294435228, 17781.555461113316, 17812.0, 6363.7772677956045, 7112.395446387115, 7540.3213710766295, 7681.884771728429, 7761.713012459925, 969.8157350103598, 991.5389343955095, 1008.7326858382535, 1041.4324193314662, 1054.8259537176434, 29032.274193144916, 29172.562411563842, 29432.0, 29728.702712973027, 29785.553216701766, 999.575180548264, 1002.0630710285906, 1021.5709402051008, 1051.8369652703843, 1067.8932106789414, 14524.709505810037, 14991.250437478082, 15059.924700376429, 15459.690806183813, 15463.768043479356, 638033.0, 673670.6316468484, 674162.0, 674868.0, 675060.0, 54715.45284547183, 55210.447895521334, 55336.0, 55342.0, 55446.44553554413, 1049.5906596427399, 1124.3366413815888, 1249.5876360800914, 1349.3860293566404, 1361.3329468560335, 24522.63216051725, 26896.0, 27217.911283549227, 29049.402282873798, 30213.37494161283, 52268.95462090813, 52998.470015300896, 53198.0, 53223.73388133034, 53274.0, 579433.0, 581116.0, 583792.0, 585823.0, 586192.656881177, 31642.208944776565, 33749.325013500085, 36467.63532364643, 41009.564665236576, 41531.54639587721, 41364.379534306405, 43609.731876861966, 43883.122337552435, 43980.78009609931, 44689.77655111704, 30937.0, 36807.44788828223, 36916.63083369132, 38187.0, 38246.0, 36194.0, 36592.45111323385, 37197.51209951572, 37399.813000934824, 37495.43756843595, 35699.46450803188, 35841.28317433585, 36573.26853462862, 36733.26533469369, 37080.07299817526, 30219.79120835142, 31420.057398278088, 32705.836470817492, 32812.83593582017, 32883.19142447189, 21590.676139858228, 24275.757242428055, 24498.87750561236, 25116.869740862072, 25187.496250075263], "value": 19171.18894684644, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.71110300765775, 352.65616024376254, 366.8074261012968, 379.3020841651361, 408.3018039153048, 14843.40626374945, 15350.692986140271, 17643.647127057466, 19467.415977520697, 19662.0, 16829.579260518494, 19820.81075135493, 21017.054232559534, 21747.891260543714, 22036.779632203674, 6172.753089876411, 6735.259121496656, 6786.8303292417595, 6791.252962174181, 6802.625855577966, 6533.967330163343, 6721.260661327275, 6764.6617669116595, 6783.152105986752, 6820.352066553694, 6544.723778863124, 6565.934340656604, 6809.6595170241535, 6811.284815094394, 6816.045753594501, 6489.31862154474, 6803.319668033207, 6862.7598034068815, 6867.278935711728, 6872.175338959357, 6623.013096071208, 6635.13743213384, 6638.900416493757, 6820.488463365218, 7208.315210055036, 27680.723192768015, 28298.29254268639, 28483.57274640882, 28540.714592854012, 28858.855705721548, 2361.468669549338, 2453.1659235859715, 2474.6040633498556, 2516.7860731837814, 2958.4970555005702, 14917.776233356508, 16420.917895410566, 16474.588135296595, 16952.491425257263, 17373.0, 1916.8849869007904, 1926.1428664244418, 2034.043999320317, 2034.3591768592846, 2041.9285325013552, 119568.0, 133685.0, 138739.0, 141432.0, 141802.29098854543, 16515.28406108616, 20294.49263768388, 20914.16343346249, 21013.369598912057, 21125.68311475329, 27853.86073069622, 29389.0, 29477.0, 30668.693313066582, 32502.83748581242, 10040.14658754014, 10383.650125483638, 10503.474826258656, 10512.789744205073, 10736.516856741466, 8451.957740211383, 8626.95686521576, 8638.568071596395, 8824.691135810215, 8840.602172902234, 7356.498790411286, 8584.828303434022, 9222.631094756134, 9314.86027709585, 9444.669436569688, 3077.1230199393513, 3573.5533058367705, 3699.5560532735703, 3709.276691045274, 3718.727519782574, 384.9441830934499, 708.6669265445232, 818.059231883339, 954.19370631816, 989.5250279865704, 10988.285761425483, 11682.415879206006, 12035.217710848767, 12063.879361206451, 12127.878721212852, 430.87504623659413, 841.1504380575662, 890.5636238243344, 912.977175570616, 948.7011591348703, 10336.896631033593, 10678.893211067945, 10697.732556685989, 10764.277715565471, 10775.946120269506, 558208.2089589526, 564388.0, 568475.0, 576923.0, 579545.0, 120019.0, 120713.0, 120802.3959880195, 124460.37769811093, 125744.0, 949.0983565612696, 962.6582563190107, 979.7893452907659, 980.8283550378655, 984.3257368702461, 17966.461006169837, 18003.72994405059, 18043.0, 18055.548611284823, 18166.5458363542, 42924.42453452678, 51456.22815657693, 51469.742651286506, 51763.35734542879, 52880.73559632177, 58292.0, 76535.46929061499, 77040.0, 77763.61118194372, 78296.4340713194, 6576.704048317742, 7764.84470310602, 7966.641501132347, 8038.075621303391, 8040.477368970998, 9731.367461115005, 11933.641990740292, 12051.638450846489, 12486.313252771184, 12514.687132821387, 10644.414557199429, 10724.678259652223, 10927.45362731876, 11040.116790656888, 11076.5569377224, 10121.645742398981, 10429.374237545771, 10450.059494645518, 10699.251052426256, 11131.998120169224, 5558.082916318924, 7419.666115024729, 10038.598456061676, 10932.617358392736, 11033.779324413626, 7752.14726380109, 7965.880511792212, 7992.560409177551, 8059.879101813361, 8195.918040819754, 8119.959400202961, 8639.029724624765, 9976.800463990825, 10834.241603087708, 11033.668989930315], "value": 10251.895453653702, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.3190057120582, 1521.0949485056394, 1658.56048147241, 1789.3558319005165, 1878.5303674081472, 8324.33405327574, 8788.428752131107, 8789.0, 8794.6921857735, 8803.867941980876, 7754.108277548084, 8013.158618345077, 8035.276825085741, 8402.91597084029, 8561.272291855184, 2300.919467818627, 2339.228054741931, 2340.473393486469, 2340.8010319122895, 2342.8594284342907, 2290.1526435218907, 2313.3175713164574, 2316.9652455213186, 2336.778006089419, 2337.520808234308, 2291.186628746796, 2306.215886598556, 2314.6296592545195, 2317.0, 2330.96503552446, 2281.2243837095302, 2296.115995341797, 2301.390131615123, 2301.6662583925236, 2303.6890019847274, 1927.787943326233, 2024.4533975826444, 2275.5107651854933, 2317.6060069788177, 2318.2349824557855, 8514.403991720583, 8704.564771761387, 8714.782130446789, 8716.128387161296, 8723.38936274461, 5114.181730923035, 5260.684358938438, 5268.762905669216, 5279.44565820591, 5279.70961597112, 3094.582231398755, 3344.5986481622117, 3464.7574669773126, 3545.3441113393847, 3579.7470885189973, 1074.3231763988715, 1074.8441475986017, 1075.704181350127, 1093.1582681335328, 1093.912487001046, 11293.15301352402, 11426.485808138654, 11429.02853257474, 11433.0, 11467.942660286728, 4480.14877173336, 4522.479914809839, 4700.224462963641, 4727.550882666142, 4743.762811859462, 9748.366356186825, 9765.707028789147, 9767.51162441875, 9777.0, 9813.754656133653, 5235.214717792285, 5254.185601231815, 5255.39562950258, 5260.053190425683, 5263.26314315996, 4318.1363727254675, 4327.459067616548, 4779.498152693986, 4806.687565308243, 4827.889585395308, 3027.576139340494, 3777.792221427848, 3874.3994680824517, 3891.801132360264, 3929.410588411704, 1229.1518851992275, 1236.1532350340046, 1238.2013601227338, 1247.3700781105483, 1261.1928365845865, 722.609790713009, 831.9126491718404, 894.9507777072323, 895.7805337692307, 934.6588495199203, 5461.2627295315415, 5735.483806457355, 5759.1649210865025, 5946.940530594725, 6076.361981991916, 923.8614207868874, 927.6614035876856, 929.4284015330658, 947.7914858731068, 989.3272574649163, 3650.142216579102, 3713.9071523211596, 3899.161680238762, 3925.862594809168, 3935.7726664135707, 9130.589123489459, 10344.37933723979, 10662.466876656135, 10686.519106640064, 10756.677299681021, 9903.059209375098, 10485.056344928993, 10492.790144197073, 10675.87903270161, 10705.678829635124, 7982.960085199653, 8213.014438267446, 8216.507009579444, 8221.753347399588, 8225.71210007647, 5748.568857335633, 5757.0, 5770.451807078321, 5967.134765458897, 6118.051701986199, 9674.226061915171, 10002.349847259904, 10017.449040302854, 10022.849657255292, 10037.046480584333, 9967.601295948081, 10257.487125643538, 10260.846087308548, 10267.127294180078, 10272.024157705006, 6589.308122647245, 6825.0, 6847.0, 7415.777526674208, 7559.924400755922, 7603.391728661583, 7661.387089032975, 8237.0, 8322.0, 8400.075991641037, 7158.606276654834, 7221.53060051095, 7231.059962204879, 7290.161631412456, 7386.704531818882, 7052.471064670273, 7126.857462850818, 7308.634568271672, 7315.012473316035, 7356.043714317105, 6787.423069039187, 6870.484713646397, 6902.240753517009, 6953.061336719478, 6954.756583519553, 4750.857474275777, 4775.044991001744, 4824.541668541483, 4834.250691142878, 4947.975260123676, 4867.367242258484, 4948.752562371795, 4980.925286120639, 5032.094223039741, 5051.040302342543], "value": 4498.724732330461, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.57372465410754, 309.288636136885, 316.90809665197094, 321.78762017068726, 325.08812780151663, 5142.662907644011, 5282.709450980195, 5522.5581953443725, 5529.3230002048585, 5554.1946417769395, 5169.30214421053, 5208.921866172011, 5308.416074231832, 5365.517103460697, 5435.0, 3624.9125262421167, 3661.5972243053375, 3705.0, 4116.485439320078, 4126.42230087788, 3802.9429558556503, 3804.6385593368723, 3973.1457736586626, 4099.200655872106, 4109.671226301889, 3546.5034895114577, 3572.4641303804506, 3607.8196090195515, 3750.5686846012786, 4105.712600117993, 3750.3811871041516, 3918.686505079601, 4082.1631565528996, 4121.196366708493, 4126.938095928564, 3200.7119359257545, 3383.5601371821754, 3563.0914116900285, 3572.160542272564, 3599.42409214527, 4160.43834082398, 4976.402831660188, 5283.1546952487415, 5284.550813180885, 5299.482745695802, 3987.501562304712, 4635.976820115911, 4719.905601887943, 4720.693154944917, 4774.689645173053, 5751.654900705971, 5752.482276595085, 5780.364159942403, 5794.304683437972, 5798.666306749429, 3147.4734753644466, 3896.5908579599018, 3898.6101389860787, 3901.8244179012013, 3918.608139186087, 5361.035013697533, 6032.160191141744, 6048.637081775108, 6066.514678825683, 6078.513718902477, 3563.376409128444, 3638.290533346025, 3787.4318852172396, 3935.0949281665376, 3963.088489647397, 3400.9489857652156, 3722.1439069014277, 4039.939400908989, 4046.5144182697677, 4049.493813273341, 4070.104576993057, 4549.545045495424, 4723.6929599575915, 4740.431148262231, 4750.358701575312, 5410.323709536308, 5505.3114413343155, 5806.709664516842, 5808.767649294065, 5888.499477544457, 1166.7258194324327, 1268.9340953599021, 1351.3445978700322, 1363.8158848555518, 1383.8823699985412, 833.9499630022218, 834.1658341658342, 845.1590667285967, 906.9319801014818, 921.9354645174908, 4347.174186841534, 4453.910921781546, 5278.630495865329, 5322.281491998608, 5378.677279363251, 5775.451332123442, 5794.971025144847, 5795.594308398372, 5801.156034710979, 5849.6782676952325, 4941.777620007108, 4954.331165292711, 5281.20781882713, 5302.522772950453, 5304.708241046779, 2684.463107378532, 3028.4851575232265, 3066.5553494743135, 3079.969200307968, 3089.335792804513, 5770.835936523804, 5992.471919660458, 6027.38356985805, 6037.486813620892, 6047.850908327404, 5136.152534831711, 5490.890182196414, 6135.877282454326, 6211.782587609412, 6255.40573645503, 6040.426159514839, 6287.49700023997, 6301.905471417932, 6343.365663433804, 6356.2054743157105, 5540.972295138659, 5666.563377747608, 5983.700814959322, 6050.757969681164, 6058.787942421994, 5970.283565972111, 5971.701414929149, 5975.193348897843, 5983.37174596661, 5985.820425387245, 5801.158831969426, 5832.008558544972, 6264.968675156595, 6291.716872740829, 6346.333634968262, 3942.9408558872215, 3967.523897132247, 3971.5035620547433, 3989.840406383712, 4022.235775202702, 5476.91784623223, 5533.418991006048, 6076.6961651916345, 6101.572889897665, 6120.724567394389, 5746.339170995389, 5780.30636323627, 5814.709264536672, 5890.617109887844, 5916.467517923407, 5350.448369972664, 5359.464053594766, 5822.650640961556, 5832.883342333044, 5834.474897259267, 5523.4200408956485, 5659.207710920557, 5745.913811292918, 5760.452756988079, 5779.190913272061, 5246.31797866275, 5561.582881283839, 5829.47534721877, 5846.193826963166, 5877.706114694333, 4330.631896288724, 4859.708417494961, 4897.7061376316105, 5628.465295796893, 5721.8569535761935], "value": 4181.682659635614, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.5532436902566, 712.2236761929496, 715.2811424518359, 738.3908275672571, 808.1312588966861, 14831.258437078144, 15519.689606207869, 15577.532674019769, 15578.688426231483, 15601.843981560181, 13171.341432928362, 13178.077534572583, 13185.208887466759, 13186.868131318684, 13199.6700082498, 661.8080756580586, 680.6800803622315, 686.2485578291762, 828.3952714518405, 852.2755657690975, 826.6156237349661, 826.9173082691743, 848.6053984897021, 857.1128881607538, 860.4407135362034, 879.2614204068581, 880.4937161132342, 882.2853488674162, 882.5543100734152, 884.2086332732201, 694.3924066441863, 708.2740191303903, 874.8206617643432, 876.4040452492303, 876.8158686675838, 646.5861848417017, 658.3811217455624, 661.9040239165342, 663.5686803577665, 664.3124366280877, 14565.708685826225, 14573.489927852474, 14598.34307456167, 14602.415903363853, 14605.70788584233, 13090.672733181651, 13382.397792099378, 13563.0, 13620.114692545052, 13886.583402497941, 12195.512179512809, 12242.520202548263, 12318.0, 12398.442070106867, 12883.742325153444, 4399.174342647797, 4447.577480139382, 4510.977445112753, 4551.590356867898, 4638.9536104638855, 94614.0, 112471.0, 115343.84656153416, 115798.42100789526, 118735.0, 8840.381173317806, 10571.015630044289, 10684.839727404094, 10740.892591073989, 10818.0, 20867.686984695243, 20869.582608347748, 20879.0, 20894.0, 20911.68632470514, 7509.774706758806, 7540.773776786705, 7747.573883436352, 7763.417743669247, 7764.728234511765, 4222.469498867367, 4226.302660061056, 4247.299195632748, 4289.206496798102, 4433.800478978454, 3336.0992532016703, 3401.523786669868, 3448.275862068994, 3452.2577645806273, 3456.792592444461, 601.7683191971123, 605.1769593353036, 613.1262950295811, 616.7594638091148, 622.6077571130159, 590.2945979554391, 601.392593480579, 604.2627993847499, 605.8485378655337, 631.8831016261914, 8653.826923461496, 8670.609822558, 8756.511711138464, 8814.51520166397, 8997.775055623531, 499.6702176563451, 502.3444405051443, 616.3805375597495, 625.5158765675146, 644.6196743921109, 3918.3730603103368, 4376.803043863034, 4530.0, 4540.388162202436, 4549.249373853278, 82386.94032649232, 86670.56664716636, 113218.0, 123887.38056309841, 144458.0, 123463.0, 123931.38034309771, 125449.0, 128858.0, 131781.68218317695, 103189.48405258075, 108134.0, 108351.0, 109591.0, 110997.0, 8324.125966773401, 8859.0, 8954.417962832395, 8987.236084932592, 9165.404248723811, 58062.7096864513, 61122.083168753394, 61162.082568762395, 61738.382616173265, 64045.679771600844, 91558.54220728854, 92354.0, 92830.0, 93398.0, 93745.0, 11184.496697648789, 11324.433778311217, 11372.43137843121, 11477.598284060017, 11757.294562326288, 12253.69365765863, 12261.38693065361, 12460.12779105454, 12811.231326120462, 12911.612651620466, 11024.842391548771, 11311.943440282746, 12273.631791046282, 12312.81530777057, 13516.12145210558, 11143.554257829921, 13439.798403023768, 13723.794143087662, 13783.035187536776, 13835.48224304619, 13083.99068214335, 13100.654783012586, 13294.91562535774, 13436.596902092953, 13679.31603419845, 11150.944245278723, 11405.828912566152, 11443.771124577628, 11461.885381146416, 11533.250338727956, 8279.668813247403, 9489.66786162481, 10070.194384449373, 10145.847812282675, 11469.483873225892], "value": 7475.8596215151665, "unit": "score"}], "name": "dromaeo_css", "value": 7345.19961223195, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 112.0, 112.0, 117.0, 158.0, 165.0, 111.0, 111.0, 112.0], "value": 122.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 129.0, 138.0, 165.0, 131.0, 141.0, 139.0, 112.0, 143.0, 117.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 182.0, 185.0, 182.0, 182.0, 182.0, 181.0, 182.0, 183.0], "value": 182.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 88.0, 62.0, 59.0, 57.0, 58.0, 84.0, 75.0], "value": 68.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 93.0, 70.0, 69.0, 69.0, 92.0, 65.0, 65.0, 89.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 123.0, 87.0, 84.0, 87.0, 84.0, 86.0, 83.0], "value": 89.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 95.0, 96.0, 96.0, 112.0, 160.0, 113.0, 96.0], "value": 105.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 84.0, 84.0, 80.0, 142.0, 131.0, 122.0, 85.0, 85.0], "value": 98.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 52.0, 53.0, 54.0, 55.0, 53.0, 54.0, 56.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 81.0, 66.0, 75.0, 72.0, 71.0, 70.0, 72.0, 71.0, 72.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 88.0, 85.0, 87.0, 82.0, 85.0, 74.0, 98.0, 108.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 144.0, 147.0, 145.0, 146.0, 149.0, 150.0, 157.0, 208.0, 146.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 171.0, 173.0, 172.0, 170.0, 175.0, 171.0, 171.0, 170.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 81.0, 86.0, 88.0, 88.0, 70.0, 68.0, 67.0, 69.0], "value": 75.6, "unit": "score"}], "name": "kraken", "value": 1494.8, "alertThreshold": 2.0}]} 09:45:08 INFO - Return code: 0 09:45:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:45:08 INFO - # TBPL SUCCESS # 09:45:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:45:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:45:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:45:08 INFO - 2016-10-12 09:45:08.785 screenresolution[1660:9768] starting screenresolution argv=screenresolution get 09:45:08 INFO - 2016-10-12 09:45:08.787 screenresolution[1660:9768] Display 0: 1600x1200x32@60 09:45:08 INFO - 2016-10-12 09:45:08.793 screenresolution[1661:9771] starting screenresolution argv=screenresolution list 09:45:08 INFO - Available Modes on Display 0 09:45:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:45:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:45:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:45:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:45:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:45:09 INFO - Intel Iris: 09:45:09 INFO - Chipset Model: Intel Iris 09:45:09 INFO - Type: GPU 09:45:09 INFO - Bus: Built-In 09:45:09 INFO - VRAM (Dynamic, Max): 1536 MB 09:45:09 INFO - Vendor: Intel (0x8086) 09:45:09 INFO - Device ID: 0x0a2e 09:45:09 INFO - Revision ID: 0x0009 09:45:09 INFO - Displays: 09:45:09 INFO - Display: 09:45:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:45:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:45:09 INFO - Display Serial Number: 1600x1200 60 09:45:09 INFO - Main Display: Yes 09:45:09 INFO - Mirror: Off 09:45:09 INFO - Online: Yes 09:45:09 INFO - Rotation: Supported 09:45:09 INFO - Return code: 0 09:45:09 INFO - Running post-action listener: _resource_record_post_action 09:45:09 INFO - [mozharness: 2016-10-12 16:45:09.031365Z] Finished run-tests step (success) 09:45:09 INFO - Running post-run listener: _resource_record_post_run 09:45:09 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 37311488; Write bytes: 707920384; Read time: 243; Write time: 1981 09:45:09 INFO - TinderboxPrint: CPU usage
53.7% 09:45:09 INFO - TinderboxPrint: I/O read bytes / time
37,311,488 / 243 09:45:09 INFO - TinderboxPrint: I/O write bytes / time
707,920,384 / 1,981 09:45:09 INFO - TinderboxPrint: CPU idle
2,247.5 (46.3%) 09:45:09 INFO - TinderboxPrint: CPU system
975.8 (20.1%) 09:45:09 INFO - TinderboxPrint: CPU user
1,634.4 (33.6%) 09:45:09 INFO - TinderboxPrint: Swap in / out
444,514,304 / 0 09:45:09 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 397558272; Write bytes: 391480832; Read time: 29658; Write time: 803 09:45:09 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 35296256; Write bytes: 297458688; Read time: 223; Write time: 1125 09:45:09 INFO - Running post-run listener: _upload_blobber_files 09:45:09 INFO - Blob upload gear active. 09:45:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:45:09 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:45:09 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:45:09 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:45:09 INFO - (blobuploader) - INFO - Open directory for files ... 09:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:45:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:11 INFO - (blobuploader) - INFO - Done attempting. 09:45:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:45:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:45:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:12 INFO - (blobuploader) - INFO - Done attempting. 09:45:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:45:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:45:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:15 INFO - (blobuploader) - INFO - Done attempting. 09:45:15 INFO - (blobuploader) - INFO - Iteration through files over. 09:45:15 INFO - Return code: 0 09:45:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:45:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:45:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5ee455b7a343b1c2829b97013098134cc1700f9c51f52de8d662efd962c5342485515df898301fad8ea69aa6810ce2da491a1111f5e5648ea595a0aba25d8ef5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2695e4179530476736fc4570d783eded3d3b799643686ca086c4a4b16a922a50003c0ed258fc298ae85dd96ae5a2c295417fb1a03d85a8222edf722331e06310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/622c09a536e4da2c55fc1d776d2f6acb0b365a596c04fd6f20995cd52f878f7962a1cfe0860c87db900c1cdd5db9f8f6bfd6ed9cd3c87f7b5e99a9e19162d372"} 09:45:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:45:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:45:15 INFO - Contents: 09:45:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5ee455b7a343b1c2829b97013098134cc1700f9c51f52de8d662efd962c5342485515df898301fad8ea69aa6810ce2da491a1111f5e5648ea595a0aba25d8ef5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2695e4179530476736fc4570d783eded3d3b799643686ca086c4a4b16a922a50003c0ed258fc298ae85dd96ae5a2c295417fb1a03d85a8222edf722331e06310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/622c09a536e4da2c55fc1d776d2f6acb0b365a596c04fd6f20995cd52f878f7962a1cfe0860c87db900c1cdd5db9f8f6bfd6ed9cd3c87f7b5e99a9e19162d372"} 09:45:15 INFO - Running post-run listener: copy_logs_to_upload_dir 09:45:15 INFO - Copying logs to upload dir... 09:45:15 INFO - mkdir: /builds/slave/test/build/upload/logs 09:45:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.121672 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-12 09:45:15.686757) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 09:45:15.690478) ========= 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.KX9OszNHzd/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.RDmbKrAXjv/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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/Autoland/sha512/5ee455b7a343b1c2829b97013098134cc1700f9c51f52de8d662efd962c5342485515df898301fad8ea69aa6810ce2da491a1111f5e5648ea595a0aba25d8ef5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2695e4179530476736fc4570d783eded3d3b799643686ca086c4a4b16a922a50003c0ed258fc298ae85dd96ae5a2c295417fb1a03d85a8222edf722331e06310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/622c09a536e4da2c55fc1d776d2f6acb0b365a596c04fd6f20995cd52f878f7962a1cfe0860c87db900c1cdd5db9f8f6bfd6ed9cd3c87f7b5e99a9e19162d372"} build_url:https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011078 build_url: 'https://queue.taskcluster.net/v1/task/JEXpzco3RbuMVrmnIWfR-A/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5ee455b7a343b1c2829b97013098134cc1700f9c51f52de8d662efd962c5342485515df898301fad8ea69aa6810ce2da491a1111f5e5648ea595a0aba25d8ef5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/2695e4179530476736fc4570d783eded3d3b799643686ca086c4a4b16a922a50003c0ed258fc298ae85dd96ae5a2c295417fb1a03d85a8222edf722331e06310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/622c09a536e4da2c55fc1d776d2f6acb0b365a596c04fd6f20995cd52f878f7962a1cfe0860c87db900c1cdd5db9f8f6bfd6ed9cd3c87f7b5e99a9e19162d372"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 09:45:15.727779) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 09:45:15.728151) ========= 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.KX9OszNHzd/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.RDmbKrAXjv/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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.005005 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 09:45:15.776796) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 09:45:15.777101) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 09:45:15.777431) ========= ========= Total master_lag: 0.18 =========