builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0091 starttime: 1474260443.44 results: success (0) buildid: 20160918194717 builduid: e5fb9675baaa4fd8a309675e8e362394 revision: d3e3c644160a6d527045d377f894e98d70060d46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-18 21:47:23.444736) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-18 21:47:23.445313) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-18 21:47:23.445658) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-18 21:47:23.800302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 21:47:23.800952) ========= 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.OhC7Rv0DTq/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.6UaRA9zTex/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-18 21:47:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 170M=0s 2016-09-18 21:47:23 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150213 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 21:47:23.989012) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 21:47:23.989733) ========= 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.OhC7Rv0DTq/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.6UaRA9zTex/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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.028249 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 21:47:24.043258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-18 21:47:24.044080) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d3e3c644160a6d527045d377f894e98d70060d46 --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 d3e3c644160a6d527045d377f894e98d70060d46 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OhC7Rv0DTq/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.6UaRA9zTex/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-18 21:47:24,129 truncating revision to first 12 chars 2016-09-18 21:47:24,129 Setting DEBUG logging. 2016-09-18 21:47:24,129 attempt 1/10 2016-09-18 21:47:24,129 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d3e3c644160a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-18 21:47:24,936 unpacking tar archive at: autoland-d3e3c644160a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.064260 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-18 21:47:25.169452) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-18 21:47:25.169778) ========= script_repo_revision: d3e3c644160a6d527045d377f894e98d70060d46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-18 21:47:25.170181) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-18 21:47:25.170496) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-18 21:47:25.200156) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-18 21:47:25.200793) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--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.OhC7Rv0DTq/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.6UaRA9zTex/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 21:47:25 INFO - MultiFileLogger online at 20160918 21:47:25 in /builds/slave/test 21:47:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:47:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:47:25 INFO - {'append_to_log': False, 21:47:25 INFO - 'base_work_dir': '/builds/slave/test', 21:47:25 INFO - 'blob_upload_branch': 'Autoland', 21:47:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:47:25 INFO - 'branch': 'Autoland', 21:47:25 INFO - 'buildbot_json_path': 'buildprops.json', 21:47:25 INFO - 'config_files': ('talos/mac_config.py',), 21:47:25 INFO - 'default_actions': ('clobber', 21:47:25 INFO - 'read-buildbot-config', 21:47:25 INFO - 'download-and-extract', 21:47:25 INFO - 'populate-webroot', 21:47:25 INFO - 'create-virtualenv', 21:47:25 INFO - 'install', 21:47:25 INFO - 'run-tests'), 21:47:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:47:25 INFO - 'download_minidump_stackwalk': True, 21:47:25 INFO - 'download_symbols': 'ondemand', 21:47:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:47:25 INFO - 'tooltool.py': '/tools/tooltool.py', 21:47:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:47:25 INFO - '/tools/misc-python/virtualenv.py')}, 21:47:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:47:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:47:25 INFO - 'installer_path': 'installer.exe', 21:47:25 INFO - 'log_level': 'info', 21:47:25 INFO - 'log_name': 'talos', 21:47:25 INFO - 'log_to_console': True, 21:47:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:47:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:47:25 INFO - 'opt_config_files': (), 21:47:25 INFO - 'pip_index': False, 21:47:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:47:25 INFO - 'cmd': ('bash', 21:47:25 INFO - '-c', 21:47:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:47:25 INFO - 'enabled': True, 21:47:25 INFO - 'halt_on_failure': False, 21:47:25 INFO - 'name': 'check_screen_resolution'},), 21:47:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:47:25 INFO - 'cmd': ('bash', 21:47:25 INFO - '-c', 21:47:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:47:25 INFO - 'enabled': True, 21:47:25 INFO - 'halt_on_failure': False, 21:47:25 INFO - 'name': 'check_screen_resolution'},), 21:47:25 INFO - 'run_cmd_checks_enabled': True, 21:47:25 INFO - 'sps_profile': False, 21:47:25 INFO - 'sps_profile_interval': 0, 21:47:25 INFO - 'suite': 'dromaeojs-e10s', 21:47:25 INFO - 'system_bits': '32', 21:47:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:47:25 INFO - 'title': 't-yosemite-r7-0091', 21:47:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:47:25 INFO - 'use_talos_json': True, 21:47:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:47:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:47:25 INFO - 'work_dir': 'build'} 21:47:25 INFO - [mozharness: 2016-09-19 04:47:25.406491Z] Running clobber step. 21:47:25 INFO - Running pre-action listener: _resource_record_pre_action 21:47:25 INFO - Running main action method: clobber 21:47:25 INFO - rmtree: /builds/slave/test/build 21:47:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:47:27 INFO - Running post-action listener: _resource_record_post_action 21:47:27 INFO - [mozharness: 2016-09-19 04:47:27.577985Z] Finished clobber step (success) 21:47:27 INFO - [mozharness: 2016-09-19 04:47:27.578166Z] Running read-buildbot-config step. 21:47:27 INFO - Running pre-action listener: _resource_record_pre_action 21:47:27 INFO - Running main action method: read_buildbot_config 21:47:27 INFO - Using buildbot properties: 21:47:27 INFO - { 21:47:27 INFO - "project": "", 21:47:27 INFO - "product": "firefox", 21:47:27 INFO - "script_repo_revision": "production", 21:47:27 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 21:47:27 INFO - "repository": "", 21:47:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 21:47:27 INFO - "buildid": "20160918194717", 21:47:27 INFO - "pgo_build": "False", 21:47:27 INFO - "basedir": "/builds/slave/test", 21:47:27 INFO - "buildnumber": 119, 21:47:27 INFO - "slavename": "t-yosemite-r7-0091", 21:47:27 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 21:47:27 INFO - "platform": "yosemite_r7", 21:47:27 INFO - "scheduler": "tests-autoland-macosx64-talos-8-3600", 21:47:27 INFO - "branch": "autoland", 21:47:27 INFO - "repo_path": "integration/autoland", 21:47:27 INFO - "revision": "d3e3c644160a6d527045d377f894e98d70060d46", 21:47:27 INFO - "stage_platform": "macosx64", 21:47:27 INFO - "builduid": "e5fb9675baaa4fd8a309675e8e362394", 21:47:27 INFO - "slavebuilddir": "test" 21:47:27 INFO - } 21:47:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 21:47:27 INFO - Running post-action listener: _resource_record_post_action 21:47:27 INFO - [mozharness: 2016-09-19 04:47:27.581263Z] Finished read-buildbot-config step (success) 21:47:27 INFO - [mozharness: 2016-09-19 04:47:27.581373Z] Running download-and-extract step. 21:47:27 INFO - Running pre-action listener: _resource_record_pre_action 21:47:27 INFO - Running main action method: download_and_extract 21:47:27 INFO - mkdir: /builds/slave/test/build/tests 21:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:27 INFO - trying https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 21:47:27 INFO - Downloading https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 21:47:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 21:47:28 INFO - Downloaded 1199 bytes. 21:47:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 21:47:28 INFO - Using the following test package requirements: 21:47:28 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 21:47:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:47:28 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 21:47:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:47:28 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 21:47:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:47:28 INFO - u'jsshell-mac.zip'], 21:47:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:47:28 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 21:47:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 21:47:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:47:28 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 21:47:28 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:47:28 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 21:47:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:47:28 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 21:47:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:47:28 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 21:47:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:47:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:47:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:47:28 INFO - Fetch https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip into memory 21:47:28 INFO - Expected file size: 16427360 21:47:35 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:47:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:47:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:47:35 INFO - Fetch https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip into memory 21:47:36 INFO - Expected file size: 16427360 21:47:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 21:47:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:47:43 INFO - Fetch https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip into memory 21:47:45 INFO - Expected file size: 14414048 21:47: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')]} 21:47:46 INFO - trying https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:47:46 INFO - Downloading https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 21:47:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 21:47:49 INFO - Downloaded 111269628 bytes. 21:47:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:47:49 INFO - mkdir: /builds/slave/test/properties 21:47:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:47:49 INFO - Writing to file /builds/slave/test/properties/build_url 21:47:49 INFO - Contents: 21:47:49 INFO - build_url:https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:47:50 INFO - Running post-action listener: _resource_record_post_action 21:47:50 INFO - Running post-action listener: set_extra_try_arguments 21:47:50 INFO - [mozharness: 2016-09-19 04:47:50.114997Z] Finished download-and-extract step (success) 21:47:50 INFO - [mozharness: 2016-09-19 04:47:50.115091Z] Running populate-webroot step. 21:47:50 INFO - Running pre-action listener: _resource_record_pre_action 21:47:50 INFO - Running main action method: populate_webroot 21:47:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:47:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:47:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:47:50 INFO - '--tppagecycles', 21:47:50 INFO - '7'], 21:47:50 INFO - 'tests': ['tsvgm']}}, 21:47:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:47:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:47:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:47:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:47:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:47:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:47:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:50 INFO - 'talos_options': ['--disable-e10s'], 21:47:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:47:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:47:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:50 INFO - 'talos_options': ['--disable-e10s'], 21:47:50 INFO - 'tests': ['damp', 'tps']}, 21:47:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:50 INFO - 'tests': ['damp', 'tps']}, 21:47:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:47:50 INFO - 'tests': ['dromaeo_dom']}, 21:47:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:47:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:47:50 INFO - 'tests': ['basic_compositor_video']}, 21:47:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:47:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:47:50 INFO - 'tests': ['a11yr', 21:47:50 INFO - 'ts_paint', 21:47:50 INFO - 'tpaint', 21:47:50 INFO - 'sessionrestore', 21:47:50 INFO - 'sessionrestore_no_auto_restore', 21:47:50 INFO - 'tabpaint']}, 21:47:50 INFO - 'other-e10s': {'tests': ['a11yr', 21:47:50 INFO - 'ts_paint', 21:47:50 INFO - 'tpaint', 21:47:50 INFO - 'sessionrestore', 21:47:50 INFO - 'sessionrestore_no_auto_restore', 21:47:50 INFO - 'tabpaint']}, 21:47:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:47:50 INFO - 'ts_paint', 21:47:50 INFO - 'tpaint', 21:47:50 INFO - 'sessionrestore', 21:47:50 INFO - 'sessionrestore_no_auto_restore', 21:47:50 INFO - 'tabpaint']}, 21:47:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:47:50 INFO - 'ts_paint', 21:47:50 INFO - 'tpaint', 21:47:50 INFO - 'sessionrestore', 21:47:50 INFO - 'sessionrestore_no_auto_restore', 21:47:50 INFO - 'tabpaint']}, 21:47:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:47:50 INFO - 'tests': ['a11yr', 21:47:50 INFO - 'ts_paint', 21:47:50 INFO - 'tpaint', 21:47:50 INFO - 'sessionrestore', 21:47:50 INFO - 'sessionrestore_no_auto_restore', 21:47:50 INFO - 'tabpaint']}, 21:47:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:47:50 INFO - 'tests': ['a11yr', 21:47:50 INFO - 'ts_paint', 21:47:50 INFO - 'tpaint', 21:47:50 INFO - 'sessionrestore', 21:47:50 INFO - 'sessionrestore_no_auto_restore', 21:47:50 INFO - 'tabpaint']}, 21:47:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:47:50 INFO - 'tests': ['tsvgx', 21:47:50 INFO - 'tsvgr_opacity', 21:47:50 INFO - 'tart', 21:47:50 INFO - 'tscrollx', 21:47:50 INFO - 'cart']}, 21:47:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:47:50 INFO - 'tsvgr_opacity', 21:47:50 INFO - 'tart', 21:47:50 INFO - 'tscrollx', 21:47:50 INFO - 'cart']}, 21:47:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:50 INFO - 'talos_options': ['--disable-e10s'], 21:47:50 INFO - 'tests': ['tp5o']}, 21:47:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:50 INFO - 'tests': ['tp5o']}, 21:47:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:50 INFO - 'talos_options': ['--disable-e10s', 21:47:50 INFO - '--xperf_path', 21:47:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:47:50 INFO - 'tests': ['tp5n']}, 21:47:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:50 INFO - 'talos_options': ['--xperf_path', 21:47:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:47:50 INFO - 'tests': ['tp5n']}}, 21:47:50 INFO - 'talos.zip': {'path': '', 21:47:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:47:50 INFO - Running post-action listener: _resource_record_post_action 21:47:50 INFO - [mozharness: 2016-09-19 04:47:50.133737Z] Finished populate-webroot step (success) 21:47:50 INFO - [mozharness: 2016-09-19 04:47:50.133848Z] Running create-virtualenv step. 21:47:50 INFO - Running pre-action listener: _resource_record_pre_action 21:47:50 INFO - Running main action method: create_virtualenv 21:47:50 INFO - Creating virtualenv /builds/slave/test/build/venv 21:47:50 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 21:47:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:47:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:47:50 INFO - Using real prefix '/tools/python27' 21:47:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:47:50 INFO - Installing distribute.............................................................................................................................................................................................done. 21:47:53 INFO - Installing pip.................done. 21:47:53 INFO - Return code: 0 21:47:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:47: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')]} 21:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47: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')]} 21:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea99490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea0f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc861c83cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8add30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8a5b20>, '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.OhC7Rv0DTq/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.6UaRA9zTex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 21:47: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', 'pip>=1.5'] in /builds/slave/test/build 21:47: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 pip>=1.5 21:47:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OhC7Rv0DTq/Render', 21:47:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:53 INFO - 'HOME': '/Users/cltbld', 21:47:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:53 INFO - 'LOGNAME': 'cltbld', 21:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:53 INFO - 'MOZ_NO_REMOTE': '1', 21:47:53 INFO - 'NO_EM_RESTART': '1', 21:47:53 INFO - 'PAGER': '/bin/cat', 21:47:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:53 INFO - 'PWD': '/builds/slave/test', 21:47:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:53 INFO - 'SHELL': '/bin/bash', 21:47:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6UaRA9zTex/Listeners', 21:47:53 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 21:47:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:53 INFO - 'USER': 'cltbld', 21:47:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:53 INFO - 'XPC_FLAGS': '0x0', 21:47:53 INFO - 'XPC_SERVICE_NAME': '0', 21:47:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:54 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 21:47:54 INFO - Cleaning up... 21:47:54 INFO - Return code: 0 21:47:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:47:54 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')]} 21:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:54 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')]} 21:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:54 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 0x10ea99490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea0f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc861c83cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8add30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8a5b20>, '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.OhC7Rv0DTq/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.6UaRA9zTex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 21:47:54 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 21:47:54 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 21:47:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OhC7Rv0DTq/Render', 21:47:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:54 INFO - 'HOME': '/Users/cltbld', 21:47:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:54 INFO - 'LOGNAME': 'cltbld', 21:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:54 INFO - 'MOZ_NO_REMOTE': '1', 21:47:54 INFO - 'NO_EM_RESTART': '1', 21:47:54 INFO - 'PAGER': '/bin/cat', 21:47:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:54 INFO - 'PWD': '/builds/slave/test', 21:47:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:54 INFO - 'SHELL': '/bin/bash', 21:47:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6UaRA9zTex/Listeners', 21:47:54 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 21:47:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:54 INFO - 'USER': 'cltbld', 21:47:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:54 INFO - 'XPC_FLAGS': '0x0', 21:47:54 INFO - 'XPC_SERVICE_NAME': '0', 21:47:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:54 INFO - Downloading/unpacking psutil>=3.1.1 21:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:47:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:47:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:47:57 INFO - Installing collected packages: psutil 21:47:57 INFO - Running setup.py install for psutil 21:47:57 INFO - building 'psutil._psutil_osx' extension 21:47:57 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 21:47:58 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 21:47:58 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 21:47:58 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 21:47:58 INFO - building 'psutil._psutil_posix' extension 21:47:58 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 21:47:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:47:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:47:58 INFO - ^ 21:47:58 INFO - 1 warning generated. 21:47:58 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 21:47:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:47:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:47:59 INFO - Successfully installed psutil 21:47:59 INFO - Cleaning up... 21:47:59 INFO - Return code: 0 21:47:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:59 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 0x10ea99490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea0f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc861c83cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8add30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8a5b20>, '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.OhC7Rv0DTq/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.6UaRA9zTex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 21:47:59 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 21:47:59 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 21:47:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OhC7Rv0DTq/Render', 21:47:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:59 INFO - 'HOME': '/Users/cltbld', 21:47:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:59 INFO - 'LOGNAME': 'cltbld', 21:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:59 INFO - 'MOZ_NO_REMOTE': '1', 21:47:59 INFO - 'NO_EM_RESTART': '1', 21:47:59 INFO - 'PAGER': '/bin/cat', 21:47:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:59 INFO - 'PWD': '/builds/slave/test', 21:47:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:59 INFO - 'SHELL': '/bin/bash', 21:47:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6UaRA9zTex/Listeners', 21:47:59 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 21:47:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:59 INFO - 'USER': 'cltbld', 21:47:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:59 INFO - 'XPC_FLAGS': '0x0', 21:47:59 INFO - 'XPC_SERVICE_NAME': '0', 21:47:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:47:59 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 21:47:59 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 21:47:59 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 21:47:59 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 21:47:59 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 21:47:59 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 21:48:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:48:01 INFO - Installing collected packages: mozsystemmonitor 21:48:01 INFO - Running setup.py install for mozsystemmonitor 21:48:02 INFO - Successfully installed mozsystemmonitor 21:48:02 INFO - Cleaning up... 21:48:02 INFO - Return code: 0 21:48:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:48:02 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')]} 21:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:02 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')]} 21:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:02 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 0x10ea99490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea0f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc861c83cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8add30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8a5b20>, '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.OhC7Rv0DTq/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.6UaRA9zTex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 21:48:02 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 21:48:02 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 21:48:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OhC7Rv0DTq/Render', 21:48:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:02 INFO - 'HOME': '/Users/cltbld', 21:48:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:02 INFO - 'LOGNAME': 'cltbld', 21:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:02 INFO - 'MOZ_NO_REMOTE': '1', 21:48:02 INFO - 'NO_EM_RESTART': '1', 21:48:02 INFO - 'PAGER': '/bin/cat', 21:48:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:02 INFO - 'PWD': '/builds/slave/test', 21:48:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:02 INFO - 'SHELL': '/bin/bash', 21:48:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6UaRA9zTex/Listeners', 21:48:02 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 21:48:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:02 INFO - 'USER': 'cltbld', 21:48:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:02 INFO - 'XPC_FLAGS': '0x0', 21:48:02 INFO - 'XPC_SERVICE_NAME': '0', 21:48:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:02 INFO - Downloading/unpacking jsonschema==2.5.1 21:48:02 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 21:48:02 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 21:48:02 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 21:48:02 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 21:48:02 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 21:48:02 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 21:48:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:48:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:48:04 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 21:48:04 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 21:48:04 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 21:48:04 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 21:48:04 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 21:48:04 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 21:48:05 INFO - Downloading functools32-3.2.3-2.tar.gz 21:48:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:48:05 INFO - warning: no files found matching '*.txt' 21:48:05 INFO - no previously-included directories found matching 'build' 21:48:05 INFO - no previously-included directories found matching 'dist' 21:48:05 INFO - no previously-included directories found matching '.git*' 21:48:05 INFO - Installing collected packages: jsonschema, functools32 21:48:05 INFO - Running setup.py install for functools32 21:48:05 INFO - warning: no files found matching '*.txt' 21:48:05 INFO - no previously-included directories found matching 'build' 21:48:05 INFO - no previously-included directories found matching 'dist' 21:48:05 INFO - no previously-included directories found matching '.git*' 21:48:05 INFO - Successfully installed jsonschema functools32 21:48:05 INFO - Cleaning up... 21:48:05 INFO - Return code: 0 21:48:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ea99490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea0f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc861c83cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8add30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8a5b20>, '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.OhC7Rv0DTq/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.6UaRA9zTex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 21:48:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:48:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OhC7Rv0DTq/Render', 21:48:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:05 INFO - 'HOME': '/Users/cltbld', 21:48:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:05 INFO - 'LOGNAME': 'cltbld', 21:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:05 INFO - 'MOZ_NO_REMOTE': '1', 21:48:05 INFO - 'NO_EM_RESTART': '1', 21:48:05 INFO - 'PAGER': '/bin/cat', 21:48:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:05 INFO - 'PWD': '/builds/slave/test', 21:48:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:05 INFO - 'SHELL': '/bin/bash', 21:48:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6UaRA9zTex/Listeners', 21:48:05 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 21:48:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:05 INFO - 'USER': 'cltbld', 21:48:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:05 INFO - 'XPC_FLAGS': '0x0', 21:48:05 INFO - 'XPC_SERVICE_NAME': '0', 21:48:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:48:05 INFO - Cleaning up... 21:48:05 INFO - Return code: 0 21:48:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ea99490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea0f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc861c83cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8add30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8a5b20>, '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.OhC7Rv0DTq/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.6UaRA9zTex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 21:48:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:48:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OhC7Rv0DTq/Render', 21:48:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:05 INFO - 'HOME': '/Users/cltbld', 21:48:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:05 INFO - 'LOGNAME': 'cltbld', 21:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:05 INFO - 'MOZ_NO_REMOTE': '1', 21:48:05 INFO - 'NO_EM_RESTART': '1', 21:48:05 INFO - 'PAGER': '/bin/cat', 21:48:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:05 INFO - 'PWD': '/builds/slave/test', 21:48:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:05 INFO - 'SHELL': '/bin/bash', 21:48:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6UaRA9zTex/Listeners', 21:48:05 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 21:48:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:05 INFO - 'USER': 'cltbld', 21:48:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:05 INFO - 'XPC_FLAGS': '0x0', 21:48:05 INFO - 'XPC_SERVICE_NAME': '0', 21:48:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:06 INFO - Downloading/unpacking blobuploader==1.2.4 21:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:48:08 INFO - Downloading blobuploader-1.2.4.tar.gz 21:48:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:48:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:48:08 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 21:48:08 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 21:48:08 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 21:48:08 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 21:48:08 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 21:48:08 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 21:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:48:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:48:09 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 21:48:09 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 21:48:09 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 21:48:09 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 21:48:09 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 21:48:09 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 21:48:09 INFO - Downloading docopt-0.6.1.tar.gz 21:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:48:09 INFO - Installing collected packages: blobuploader, requests, docopt 21:48:09 INFO - Running setup.py install for blobuploader 21:48:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:48:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:48:09 INFO - Running setup.py install for requests 21:48:10 INFO - Running setup.py install for docopt 21:48:10 INFO - Successfully installed blobuploader requests docopt 21:48:10 INFO - Cleaning up... 21:48:10 INFO - Return code: 0 21:48:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:10 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 0x10ea99490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea0f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc861c83cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8add30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8a5b20>, '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.OhC7Rv0DTq/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.6UaRA9zTex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 21:48:10 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 21:48:10 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 21:48:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OhC7Rv0DTq/Render', 21:48:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:10 INFO - 'HOME': '/Users/cltbld', 21:48:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:10 INFO - 'LOGNAME': 'cltbld', 21:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:10 INFO - 'MOZ_NO_REMOTE': '1', 21:48:10 INFO - 'NO_EM_RESTART': '1', 21:48:10 INFO - 'PAGER': '/bin/cat', 21:48:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:10 INFO - 'PWD': '/builds/slave/test', 21:48:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:10 INFO - 'SHELL': '/bin/bash', 21:48:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6UaRA9zTex/Listeners', 21:48:10 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 21:48:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:10 INFO - 'USER': 'cltbld', 21:48:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:10 INFO - 'XPC_FLAGS': '0x0', 21:48:10 INFO - 'XPC_SERVICE_NAME': '0', 21:48:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:48:10 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-u7iZAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:48:11 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-z8qJAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:48:11 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-ytPjoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:48:11 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-EGhLs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:48:11 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-2QxmUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:48:11 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-cLadsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:48:11 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-UlAd93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:48:11 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-RqhrIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:48:11 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-pC8hrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:48:11 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-XoXx8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:48:12 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-EyAR6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:48:12 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-4WhKgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:48:12 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-jcV3wO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:48:12 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-shMhVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:48:12 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-R4WxR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:48:12 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-m8Og04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:48:12 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-wJhHDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:48:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:48:12 INFO - Running setup.py install for manifestparser 21:48:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:48:12 INFO - Running setup.py install for mozcrash 21:48:13 INFO - Running setup.py install for mozdebug 21:48:13 INFO - Running setup.py install for mozdevice 21:48:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:48:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:48:13 INFO - Running setup.py install for mozfile 21:48:13 INFO - Running setup.py install for mozhttpd 21:48:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:48:13 INFO - Running setup.py install for mozinfo 21:48:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:48:13 INFO - Running setup.py install for mozInstall 21:48:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:48:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:48:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:48:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:48:13 INFO - Running setup.py install for mozleak 21:48:14 INFO - Running setup.py install for mozlog 21:48:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:48:14 INFO - Running setup.py install for moznetwork 21:48:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:48:14 INFO - Running setup.py install for mozprocess 21:48:14 INFO - Running setup.py install for mozprofile 21:48:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:48:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:48:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:48:14 INFO - Running setup.py install for mozrunner 21:48:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:48:14 INFO - Running setup.py install for mozscreenshot 21:48:15 INFO - Running setup.py install for moztest 21:48:15 INFO - Running setup.py install for mozversion 21:48:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:48:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:48:15 INFO - Cleaning up... 21:48:15 INFO - Return code: 0 21:48:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:48:15 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')]} 21:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:15 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')]} 21:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:15 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 0x10ea99490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea0f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc861c83cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8add30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8a5b20>, '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.OhC7Rv0DTq/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.6UaRA9zTex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 21:48:15 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 21:48:15 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 21:48:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OhC7Rv0DTq/Render', 21:48:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:15 INFO - 'HOME': '/Users/cltbld', 21:48:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:15 INFO - 'LOGNAME': 'cltbld', 21:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:15 INFO - 'MOZ_NO_REMOTE': '1', 21:48:15 INFO - 'NO_EM_RESTART': '1', 21:48:15 INFO - 'PAGER': '/bin/cat', 21:48:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:15 INFO - 'PWD': '/builds/slave/test', 21:48:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:15 INFO - 'SHELL': '/bin/bash', 21:48:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6UaRA9zTex/Listeners', 21:48:15 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 21:48:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:15 INFO - 'USER': 'cltbld', 21:48:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:15 INFO - 'XPC_FLAGS': '0x0', 21:48:15 INFO - 'XPC_SERVICE_NAME': '0', 21:48:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:48:15 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-S6WHPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:48:15 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)) 21:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:48:15 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-2WN6pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:48:15 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)) 21:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:48:15 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-otjqGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:48:15 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)) 21:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:48:15 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-wWjtfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:48:16 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)) 21:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:48:16 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-ZcHDNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:48:16 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)) 21:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:48:16 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-gvvDD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:48:16 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)) 21:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:48:16 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-UNXcSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:48:16 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)) 21:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:48:16 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-Q7i0Wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:48:16 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)) 21:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:48:16 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-6tC8gY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:48:16 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)) 21:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:48:16 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-PkpB_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:48:16 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)) 21:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:48:16 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-kKK0tK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:48:16 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)) 21:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:48:16 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-DPSl6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:48:16 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)) 21:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:48:16 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-LmX1f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:48:17 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)) 21:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:48:17 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-g2XLv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:48:17 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)) 21:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:48:17 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-ZjzVuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:48:17 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)) 21:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:48:17 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-v3IHru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:48:17 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)) 21:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:48:17 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-qEUBdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:48:17 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)) 21:48:17 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)) 21:48:17 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)) 21:48:17 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)) 21:48:17 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)) 21:48:17 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)) 21:48:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:48:17 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 21:48:17 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 21:48:17 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 21:48:17 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 21:48:17 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 21:48:17 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 21:48:19 INFO - Downloading blessings-1.6.tar.gz 21:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:48:19 INFO - Installing collected packages: blessings 21:48:19 INFO - Running setup.py install for blessings 21:48:20 INFO - Successfully installed blessings 21:48:20 INFO - Cleaning up... 21:48:20 INFO - Return code: 0 21:48:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:48:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:48:20 INFO - Reading from file tmpfile_stdout 21:48:20 INFO - Current package versions: 21:48:20 INFO - blessings == 1.6 21:48:20 INFO - blobuploader == 1.2.4 21:48:20 INFO - docopt == 0.6.1 21:48:20 INFO - functools32 == 3.2.3-2 21:48:20 INFO - jsonschema == 2.5.1 21:48:20 INFO - manifestparser == 1.1 21:48:20 INFO - mozInstall == 1.12 21:48:20 INFO - mozcrash == 0.17 21:48:20 INFO - mozdebug == 0.1 21:48:20 INFO - mozdevice == 0.48 21:48:20 INFO - mozfile == 1.2 21:48:20 INFO - mozhttpd == 0.7 21:48:20 INFO - mozinfo == 0.9 21:48:20 INFO - mozleak == 0.1 21:48:20 INFO - mozlog == 3.4 21:48:20 INFO - moznetwork == 0.27 21:48:20 INFO - mozprocess == 0.23 21:48:20 INFO - mozprofile == 0.28 21:48:20 INFO - mozrunner == 6.12 21:48:20 INFO - mozscreenshot == 0.1 21:48:20 INFO - mozsystemmonitor == 0.3 21:48:20 INFO - moztest == 0.7 21:48:20 INFO - mozversion == 1.4 21:48:20 INFO - psutil == 3.1.1 21:48:20 INFO - requests == 1.2.3 21:48:20 INFO - wsgiref == 0.1.2 21:48:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:48:20 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')]} 21:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:20 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')]} 21:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:20 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 0x10ea99490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea0f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc861c83cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8add30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8a5b20>, '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.OhC7Rv0DTq/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.6UaRA9zTex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 21:48:20 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 21:48:20 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 21:48:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OhC7Rv0DTq/Render', 21:48:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:20 INFO - 'HOME': '/Users/cltbld', 21:48:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:20 INFO - 'LOGNAME': 'cltbld', 21:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:20 INFO - 'MOZ_NO_REMOTE': '1', 21:48:20 INFO - 'NO_EM_RESTART': '1', 21:48:20 INFO - 'PAGER': '/bin/cat', 21:48:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:20 INFO - 'PWD': '/builds/slave/test', 21:48:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:20 INFO - 'SHELL': '/bin/bash', 21:48:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6UaRA9zTex/Listeners', 21:48:20 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 21:48:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:20 INFO - 'USER': 'cltbld', 21:48:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:20 INFO - 'XPC_FLAGS': '0x0', 21:48:20 INFO - 'XPC_SERVICE_NAME': '0', 21:48:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:20 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)) 21:48:20 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)) 21:48:20 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)) 21:48:20 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)) 21:48:20 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)) 21:48:20 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)) 21:48:20 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)) 21:48:20 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)) 21:48:20 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)) 21:48:20 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)) 21:48:20 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)) 21:48:20 INFO - Cleaning up... 21:48:20 INFO - Return code: 0 21:48:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:48:20 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')]} 21:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:20 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')]} 21:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:48:20 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 0x10ea99490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea0f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc861c83cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8add30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8a5b20>, '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.OhC7Rv0DTq/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.6UaRA9zTex/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 21:48:20 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 21:48:20 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 21:48:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OhC7Rv0DTq/Render', 21:48:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:20 INFO - 'HOME': '/Users/cltbld', 21:48:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:20 INFO - 'LOGNAME': 'cltbld', 21:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:20 INFO - 'MOZ_NO_REMOTE': '1', 21:48:20 INFO - 'NO_EM_RESTART': '1', 21:48:20 INFO - 'PAGER': '/bin/cat', 21:48:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:20 INFO - 'PWD': '/builds/slave/test', 21:48:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:20 INFO - 'SHELL': '/bin/bash', 21:48:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6UaRA9zTex/Listeners', 21:48:20 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 21:48:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:20 INFO - 'USER': 'cltbld', 21:48:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:20 INFO - 'XPC_FLAGS': '0x0', 21:48:20 INFO - 'XPC_SERVICE_NAME': '0', 21:48:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:48:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:48:21 INFO - Cleaning up... 21:48:21 INFO - Return code: 0 21:48:21 INFO - Running post-action listener: _resource_record_post_action 21:48:21 INFO - Running post-action listener: _start_resource_monitoring 21:48:21 INFO - Starting resource monitoring. 21:48:21 INFO - [mozharness: 2016-09-19 04:48:21.070716Z] Finished create-virtualenv step (success) 21:48:21 INFO - [mozharness: 2016-09-19 04:48:21.071744Z] Running install step. 21:48:21 INFO - Running pre-action listener: _resource_record_pre_action 21:48:21 INFO - Running main action method: install 21:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:48:21 INFO - Reading from file tmpfile_stdout 21:48:21 INFO - Detecting whether we're running mozinstall >=1.0... 21:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:48:21 INFO - Reading from file tmpfile_stdout 21:48:21 INFO - Output received: 21:48:21 INFO - Usage: mozinstall [options] installer 21:48:21 INFO - Options: 21:48:21 INFO - -h, --help show this help message and exit 21:48:21 INFO - -d DEST, --destination=DEST 21:48:21 INFO - Directory to install application into. [default: 21:48:21 INFO - "/builds/slave/test"] 21:48:21 INFO - --app=APP Application being installed. [default: firefox] 21:48:21 INFO - mkdir: /builds/slave/test/build/application 21:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:48:55 INFO - Reading from file tmpfile_stdout 21:48:55 INFO - Output received: 21:48:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:48:55 INFO - Running post-action listener: _resource_record_post_action 21:48:55 INFO - [mozharness: 2016-09-19 04:48:55.933786Z] Finished install step (success) 21:48:55 INFO - [mozharness: 2016-09-19 04:48:55.933934Z] Running run-tests step. 21:48:55 INFO - Running pre-action listener: _resource_record_pre_action 21:48:55 INFO - Running main action method: run_tests 21:48:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:48:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:48:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:48:55 INFO - 2016-09-18 21:48:55.948 screenresolution[1652:8354] starting screenresolution argv=screenresolution get 21:48:55 INFO - 2016-09-18 21:48:55.951 screenresolution[1652:8354] Display 0: 1600x1200x32@60 21:48:55 INFO - 2016-09-18 21:48:55.958 screenresolution[1653:8356] starting screenresolution argv=screenresolution list 21:48:55 INFO - Available Modes on Display 0 21:48:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:48:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:48:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:48:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:48:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:48:56 INFO - Intel Iris: 21:48:56 INFO - Chipset Model: Intel Iris 21:48:56 INFO - Type: GPU 21:48:56 INFO - Bus: Built-In 21:48:56 INFO - VRAM (Dynamic, Max): 1536 MB 21:48:56 INFO - Vendor: Intel (0x8086) 21:48:56 INFO - Device ID: 0x0a2e 21:48:56 INFO - Revision ID: 0x0009 21:48:56 INFO - Displays: 21:48:56 INFO - Display: 21:48:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:48:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:48:56 INFO - Display Serial Number: 1600x1200 60 21:48:56 INFO - Main Display: Yes 21:48:56 INFO - Mirror: Off 21:48:56 INFO - Online: Yes 21:48:56 INFO - Rotation: Supported 21:48:56 INFO - Return code: 0 21:48:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:48:56 INFO - Python 2.7.3 21:48:56 INFO - Return code: 0 21:48:56 INFO - grabbing minidump binary from tooltool 21:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:48:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8add30>, '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 0x10e6d3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8a5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:48:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:48:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 21:48:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:48:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:48:56 INFO - Return code: 0 21:48:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:48:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:48:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:48:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:48:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:48:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0091', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0091 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:48:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OhC7Rv0DTq/Render', 21:48:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:56 INFO - 'HOME': '/Users/cltbld', 21:48:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:56 INFO - 'LOGNAME': 'cltbld', 21:48:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:48:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:56 INFO - 'MOZ_NO_REMOTE': '1', 21:48:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:48:56 INFO - 'NO_EM_RESTART': '1', 21:48:56 INFO - 'PAGER': '/bin/cat', 21:48:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:56 INFO - 'PWD': '/builds/slave/test', 21:48:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:48:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:56 INFO - 'SHELL': '/bin/bash', 21:48:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6UaRA9zTex/Listeners', 21:48:56 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 21:48:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:56 INFO - 'USER': 'cltbld', 21:48:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:56 INFO - 'XPC_FLAGS': '0x0', 21:48:56 INFO - 'XPC_SERVICE_NAME': '0', 21:48:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0091', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:48:56 INFO - mozversion application_buildid: 20160918194717 21:48:56 INFO - mozversion application_changeset: d3e3c644160a6d527045d377f894e98d70060d46 21:48:56 INFO - mozversion application_display_name: Nightly 21:48:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:48:56 INFO - mozversion application_name: Firefox 21:48:56 INFO - mozversion application_remotingname: firefox 21:48:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:48:56 INFO - mozversion application_vendor: Mozilla 21:48:56 INFO - mozversion application_version: 51.0a1 21:48:56 INFO - mozversion platform_buildid: 20160918194717 21:48:56 INFO - mozversion platform_changeset: d3e3c644160a6d527045d377f894e98d70060d46 21:48:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:48:56 INFO - mozversion platform_version: 51.0a1 21:48:56 INFO - using testdate: 1474260536 21:48:56 INFO - actual date: 1474260536 21:48:56 INFO - starting webserver on 'localhost:49271' 21:48:56 INFO - SUITE-START | Running 2 tests 21:48:56 INFO - TEST-START | dromaeo_css 21:48:56 INFO - operating with platform_type : mac_ 21:48:56 INFO - Initialising browser for dromaeo_css test... 21:48:56 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/tmpOUKFOc/profile http://localhost:49271/getInfo.html) 21:48:59 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 21:48:59 INFO - PROCESS | 1663 | colorDepth:24 21:48:59 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 21:48:59 INFO - PROCESS | 1663 | __metrics 21:48:59 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 21:49:00 INFO - TEST-INFO | 1663: exit 0 21:49:00 INFO - Browser initialized. 21:49:00 INFO - Running cycle 1/1 for dromaeo_css test... 21:49:00 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/tmpOUKFOc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:49:12 INFO - PROCESS | 1667 | RSS: Main: 238948352 21:49:12 INFO - PROCESS | 1667 | 21:50:01 INFO - PROCESS | 1667 | 1474260601910 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] 21:52:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 21:52:16 INFO - PROCESS | 1667 | RSS: Main: 255463424 21:52:16 INFO - PROCESS | 1667 | 21:55:18 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 21:55:19 INFO - PROCESS | 1667 | RSS: Main: 266063872 21:55:19 INFO - PROCESS | 1667 | 21:58:20 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 21:58:21 INFO - PROCESS | 1667 | RSS: Main: 268533760 21:58:21 INFO - PROCESS | 1667 | 22:01:23 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 22:01:24 INFO - PROCESS | 1667 | RSS: Main: 268414976 22:01:24 INFO - PROCESS | 1667 | 22:04:26 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 22:04:27 INFO - PROCESS | 1667 | RSS: Main: 273813504 22:04:27 INFO - PROCESS | 1667 | 22:07:30 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 22:07:30 INFO - PROCESS | 1667 | RSS: Main: 276508672 22:07:30 INFO - PROCESS | 1667 | 22:07:30 INFO - PROCESS | 1667 | __start_tp_report 22:07:30 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 22:07:30 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 22:07:30 INFO - PROCESS | 1667 | |i|pagename|runs| 22:07:30 INFO - PROCESS | 1667 | |0;dojo.html;3156.5164372744807;3189.6331921828987;3342.231286804035;3360.92450415867;3447.6035255945576;5649.12438572021;5665.688387138705;5692.715364231787;5695.487406133447;5772.45161709638;5663.971680141603;5665.1785491103765;5701.315842098944;5812.157237200603;5832.504237139849;5165.147750621143;5182.352205974254;5247.39654939683;5280.3663560372615;5305.787768489276;5319.787208511674;5324.227986941891;5329.813456529022;5355.464453554633;5361.919571206435;5106.821261255838;5135.589152867761;5149.0731668299695;5186.403563590197;5275.525202731773;5201.9479805201845;5217.3217481727515;5219.295395121686;5223.947760522384;5258.789648414059;5164.173732202867;5202.2196670499725;5224.164133738584;5238.135707608279;5240.764165612557;4260.8721738347585;5648.4633959773755;5683.147527870811;5749.223854779593;5758.021136406821;6223.346548612376;6242.781502647431;6263.87472250557;6274.686265686697;6277.905831412532;6270.184875966095;6293.244810622708;6294.433500984887;6296.87406251877;6316.08416779569;5766.769329226826;5792.797252096157;5803.970980145156;5867.589268751189;5884.705764711747;5064.898702025939;5219.9217011744095;6342.904856427157;6352.555321127569;6384.553081284265;6046.667433291212;6157.784477543264;6195.597286176384;6209.96895015522;6213.1922850029205;6079.665618391031;6155.753769849156;6181.8454538636;6264.684416272543;6294.276158241769;6171.9691401542705;6234.470070044006;6276.215473065867;6284.183056202664;6285.717142728588;6212.844678882973;6232.688365581703;6246.781362652286;6259.4679452246155;6265.185525881698;3988.4017397390044;4856.39295088114;4914.36113305268;4921.9507804922205;4956.430010548833;4426.513083560806;4440.200763862471;4447.488538818013;4500.324951257272;4502.909941801211;5747.626404283792;5775.249217601685;5832.571020100103;5864.794732184353;5890.734916928748;6161;6210;6214.1921550198185;6275.341089185661;6295;5753.367129615739;5807.767689292381;5860.501857342174;5870.060790273621;5908.675022873697;5403.189521571717;5427.83716488506;5431.2396264522995;5436.021516127135;5457.126859702428;6229.750809967551;6427.839304017343;6431.646259455775;6453.386928241809;6463.903041454476;6214.5028397727165;6217.751289948352;6219.942609756262;6267.0286105653695;6280.7487700491465;6397.520185985976;6418.390252925965;6420.6468644225015;6435.710393032418;6442.259140198749;6142.385761423822;6156.015037594143;6167.074938759042;6192.164057852132;6272.2159730033745;6208;6245.937540624535;6247.843803904939;6272.278687950944;6279.372062793684;5967.6121052131475;6201.503879689704;6203.976343903206;6221.906671399842;6266.871963046513;5892.381299963442;5958.433948774859;6204.13142160089;6208.627482351073;6209.565330426827;4802.591779698765;5127.948720512747;5949.702514874326;6127.678242056309;6131.386861313833;6118.418750218722;6126.816195514141;6136.447719705248;6143.154692370071;6188.597741146811;5900.232969713909;6067.453929146398;6082.847928801815;6091.8781624366375;6116.480099191618 22:07:30 INFO - PROCESS | 1667 | |1;ext.html;480.39470267462997;483.9733814640193;485.75712143928035;524.1901262549361;527.9836315093444;39229.60770392295;40563.18873622526;40705.59294407055;40769.59230407695;40825.387619185734;39870.80064599673;41661.50030998135;42139.789301053526;42167.578324216745;42269.57730422695;9726.221902247838;9873.506324683773;9923.454210018446;9936.552855121501;9948;9775.755606109833;9851.90148098517;9858.802823943517;9891.25815563832;9912.752181195492;9923.603055877757;9925.156361709263;9957.601695932153;9960.800783984316;9982.35114717541;9889.307748457612;9924.206063514937;9925.553350099262;9942.403455792602;9948.303618746691;9807.509624518745;9818.067283608047;9858.063483969012;9895.109440150422;9918.553665085088;38955;39362.015949601206;39704;39799.20401591952;39850.202995940206;3389.1696534348994;3392.23674673199;3411.3347897160065;3427.1774774054297;3473.4616134499192;24475.877620611962;30413;30662.386752265054;30662.84668576665;31248.21879453009;3023.2290765854787;3150.8408900251675;3175.841207939594;3186.6972637599392;3238.3037646906027;369943;436281;436381;440146;440163.7991810052;59576.70211649001;59904.40095599076;60020;60052.09921851176;60149.496262593784;33727.83136084304;34713.479297810554;34855.302893942484;63574;63825.36174638194;16178.27197776103;16462.917685411736;16473.258703358137;16498.505044848673;16505.752413713803;12763.042771792152;12793.808092878615;12837.753393156161;12861.742765144645;12887.355632218352;18955.526111847314;18956.715649265272;18978.43064708061;19026.143823527975;19042.42872713821;7705.961470192613;7744.109427415807;7782.416318776114;7803;7873.606319684108;723.7937187901529;862.6290695001085;928.8621438737492;995.2286977592424;1055.8416237564427;25236.747632523806;28438.289042773682;29435.411291774046;29745;29835.403291934475;842.8819965204876;1037.5642230263309;1066.0192622787054;1068.7007637861411;1137.2266858536275;14843.777343339858;15165.772513412086;15437.858108141676;15541.06753594788;15765.369385224692;640769;646702;648762.756186216;649052;650085;53676.463235367926;55013;55177.72411137919;55373.72313138489;55459.445405546234;1306.1314226039767;1346.9057165998481;1360.5102163221231;1360.7074478986867;1370.2737549098993;28394.574081389208;29040.56439153372;29302.56046159352;29892.103236902927;29954.85022574873;47673;48195.5180448191;48387;48444.788880276865;48514.27228591503;564819;566319;567985;569564;569595;25813.741862581133;25959.870200648875;26324.605130922668;26338.156329056783;26352.34119147037;44791.328130077425;44869.55130448654;45868.08263834771;45868.54131458776;45997;38277.23445531018;38496.422553661156;39053.609463905;39431.80284098676;39648.60351396449;37103;37616.24767504689;37693.28833895763;38697;38774;37002;37025;37108;37513;37513.437298439996;28517.714822851507;29605.9637912672;32535;33994;34027;22334.21830235934;22385.552288953804;22556.984935677607;23255.3023409298;25557.105501307364 22:07:30 INFO - PROCESS | 1667 | |2;jquery.html;334.5182936571337;360.1374707575359;369.78552439585036;372.19791349641497;372.52875112982076;17166;19198.040097995097;19660.606787864235;20360.490987725316;20828.271010514636;13891.583252502416;20265.392038238875;20303;20789.272375466862;20803.37589872306;5973.910391344144;5995.13070604762;6117.418845209698;6244.968775156118;6255.530835187379;5973.372795856416;6177.073438984144;6180.320164781893;6181.721822517975;6187.4431301182885;5867.618604790697;6034.969825150868;6093.573449858512;6141.293751218623;6159.137720719081;6055.9697201514155;6102.20671312731;6110.2056732624915;6164.568480206387;6171.166892469504;4447.310666846644;5086.720230387327;5146.202338637479;5230.973845130788;5303.496167864047;23254.883725581432;23443.71059591722;24509.774511274365;25550.488990220092;25810;2385.8210634202505;2387.3434805428474;2767.5433553463654;3040.1639549123947;3101.457244982119;9589.808203835953;9842.557084931195;10189.439580823126;10377.533011014522;10439.582416703322;1905.1522072677665;1912.6079153773444;1933.1204302042536;1950.5903760210372;1981.9108140133728;122937;127990;127991.36004320013;128475.99999999907;130492;9074.863877041718;10719.732006699895;11047.668569942914;11112.999490137618;11136.944315278372;14012.789808152886;14094.154350738989;14140.85859141416;14175.78736318956;14184.503542376173;8366;8526.914730852612;8575.156341386508;8583.0987746287;8703.869441958375;8525.914740852637;8539.74380768578;8561.914380856111;8705.956470217609;8717.171868672465;3665.395209790408;4093.570175131628;4456.398386217884;4481.126180394792;4491.88770280739;1587.857092861648;1911.4074636862617;1916.1319206088476;1927.6433859735994;1928.3154480159621;830.3772170871846;869.7999460124207;897.264243320471;967.709687093869;994.2493417469908;19800.128981297632;20457.386278411373;20487.69268460974;20722;20799.792002079786;881.8985816631041;913.1781396742851;917.8714979902819;924.523870206844;933.6825479337058;7263.455240856852;10764.085052770446;10939.28894621863;10941.015308622103;10994.230403871652;574659;581447;588755;591751;592434;134340;135799;138913;140718;155233;967.8644989701447;994.3636072913341;1008.5864795433984;1011.9949400252951;1014.9644762433427;18073.18670659797;18874.43376698701;18968.43094707161;19029.14368853377;19064.33274835374;58376;59024.52438689067;59063;60353.39646603478;60852.08721869264;84092.57953710436;87989;90175.54912225397;90243;90337;5805.738741756715;6393.264774550986;6631.972044333136;7022.08712867324;7068.893966590403;9495.572699228689;11302;12921.547745828851;13013.414396351998;13357.465701371837;9490.813648293963;11153.776924461303;11265.380404077854;11491.195616307112;11539.423028848356;8922.018577956289;9650.7587310315;9901.118787430365;10332.328398654063;10822;11248.83126753083;11435;11581.88418115808;11752.76494470123;11910.404479776149;6051.636901785907;6912.308769123048;7233.493655444068;7484.952106704956;7544.396448284015;9317.44095354281;11173.106151507698;11241.775164496828;11252.26860254081;11583.131265155316 22:07:30 INFO - PROCESS | 1667 | |3;mootools.html;1295.766761982843;1500.4598344595943;1673.6485338079003;1817.127778666241;1861.888286702798;7917.406194535419;8154.469959452646;8490.490570565771;8927.196552310299;8940.329475289354;7407.8888816667795;8442;8659.263962563175;8815;8821.338399620023;2373.8100951923807;2386.272186982974;2386.6658667786523;2409.5662780699467;2410.252821625293;2370.4429459077105;2384.7138343398815;2394.964075538868;2408.7832095111435;2422.200673777658;2378.4886249456363;2399;2403.9399015024587;2407.939801504968;2413.5052314275617;2371.5019845832394;2374.8812559371963;2378.857268563883;2385.5705972924866;2388.379021454417;2357.6817129687443;2363.5981883079917;2369.6327069304284;2379.559781440439;2392.1627430399394;8804.47173169612;8835.116488351177;8895.866562001574;8908.153725396078;8959.641614335418;5205.583553315726;5345.091334473149;5345.812896548641;5353.839384818461;5354.705491197982;3652.6712595866497;3654.104744337628;3687.4468829675493;3701.3152566775234;3729.776213427203;1097.8243481043075;1098.0447011100393;1104.7845670094334;1112.1158678850334;1117.2961034548264;11631.243969141979;11691.532338706442;11730.765384692259;11781.469833857496;11810.468528916219;3854.49891514107;4537.274036154199;4837.661363704507;4858.198397264412;4870.951290487121;9904;10004.049615286536;10010.749731256632;10019.849702254473;10030.598776048877;5319.28189694394;5335.306410166731;5337.733113344395;5353.652012619167;5365.517103460707;4378.715383500063;4526.275795872644;4748.216544270157;4876.097921884463;4879.926801097916;3881.8261773406985;3931.2923673739;3996.140829721624;4020.0753826619457;4040.1515681706583;1282.6344491819787;1287.1569122224957;1287.4335292471283;1298.2340419152556;1301.6810881334134;812.3257696112213;860.7632900952289;900.7297810656777;908.418612088264;913.6025828764376;5812.593118481665;5853.297604287428;5966.791162309299;6014.1580178775;6082.908756368658;416.11575402270176;427.81390095308643;450.0795872440866;452.4751288505318;453.58950150114197;3779.4141908004303;3885.9028524286555;4033.6773058155277;4201.495820501559;4295.6778241632;10728.249022568501;10798.51406686701;10839.729006774736;10888.510017049093;10902.890971090346;9373.953130234306;10560.049595536439;10563.207759418074;10713.83929241062;10849.566017359217;8055.154208808108;8135.227153420416;8240.381971352053;8257.83484330322;8274.172582741678;5940.495057920125;6025.367336429612;6056.545759068;6148.47737942262;6160.630362178284;9816.558254878404;10106.393616382746;10123.696289111338;10127.544260508443;10143.188544916242;9789.923108457922;10210.540525676512;10283.897161028593;10380.584776609154;10408.427536485566;7007.019017337475;7188.820279493055;7382.187959324363;7582.090149182133;7717.382609391348;8241.093479717107;8568.14318568163;8572.485650860968;8573.22840944318;8575.356848236532;7253.165885922976;7461.962690186731;7601.505902116345;7689.3464055555905;7699.307062364414;7170.247124052108;7372.520786148883;7408.185099638928;7435.92564074374;7597.278258565428;5698.857528561819;7055.223925368308;7065.894011589933;7071.646417679199;7074.398676112588;4927.852164435073;5000.67495612784;5054.69671819692;5108.361454818148;5128.564072053917;4958.8760280993265;5006.170973130222;5123.795048198031;5158.845234642967;5208.453112423141 22:07:30 INFO - PROCESS | 1667 | |4;prototype.html;294.752407977299;301.93206528531084;308.6342683919556;309.35036423510616;313.76467649263054;4545.454545454541;5092.872678183047;5703.657780533165;5716.314042314918;5754.74103665335;4817.518248175181;5323.334583177103;5511.862203444916;5583.748731307091;5584.21820945068;3923.823427945735;4255.468066491689;4258.659307255428;4260.446142001551;4262.231174062768;3942.4283478895545;4235.428217190686;4249.936250956238;4264.296391095466;4271.359296105594;3678.613745556718;4187.33002719565;4217.283061879488;4225.387318838767;4235.49174099107;3088.3051313454516;3182.236263296792;3877.8836634901;4117.464729585135;4218.3250679891225;2981.761459083268;3078.9230269243226;3584.13980644646;3624.72814538908;3660.3045421369857;5185.948140518584;5411.242426060355;5468.453154684539;5473.507384335429;5478.411260734422;3702.7222958278235;4471.754053527055;4783.712977221343;4809.302651115604;4870.65905386623;4403.075354175627;5682.147677848315;5815.592908496407;6047.879042419171;6060.696965151725;3799.2781371539318;3931.5085614298214;3988.481497405348;3989.2221016901717;4015.156817068419;4994.600431965434;6249.843778900872;6285.842853928642;6296.464800491964;6341.921873281507;3417.79493230407;3576.8926932191557;4069.674426045909;4088.632023117934;4111.76647005897;3413.061408112739;4059.837606495766;4113.424120623115;4118.855840045584;4137.8965525862095;4022.6580740637373;4586.541345865454;4790.640701947368;4795.6163506919365;4810.7113573185725;4937;5354.759035843396;5506.74223568335;5519.006578815852;6081.361457046946;1082.884628832304;1357.3756072206697;1361.4554178328747;1377.7864431013209;1395.7487652222696;810.4003037752021;879.3404946290283;913.6847787513298;917.8164367126468;938.5823308627595;4557.726536407826;5489.313835770528;5505.229267902497;5507.697076660822;5529.834104976857;5259.974305010486;5309.734513274321;5780.884382312414;5781.034448287603;6048.884824315481;4135.648469880094;4521.547845215518;5444.50999410055;5540.279763630702;5562.916556251659;2479.913203037885;3148.795328303653;3172.762042846796;3216.2281052547687;3232.7575431842706;5070.569001634903;6394.808155755335;6397.52018598607;6405.935940640627;6439.581427207217;5974.984252677055;6289.811305660837;6308.337624549448;6319;6362.504811369325;6363.490920726238;6392.872142557123;6397.96801015992;6415.422611964946;6422.325655806167;5758.568107391879;6076.635401875901;6135.883120323481;6141.508679305555;6201.255849298113;5360.973195133999;6066.332703402711;6105.603965145088;6165.6608886509875;6171.63645813024;6221.47117495018;6454.483641308778;6478.319776423407;6483.546151769519;6488.832010238202;3629.25600251953;4099.303118469927;4177.56135605757;4195.307774217342;4195.664346852305;5290.677330667333;5721.914171287517;6145.508359331332;6219.564630475823;6257.374262573706;4464.843730469418;5618.965758490533;5955.702214889325;6061.696915154313;6078.750862181021;6031.406495207103;6059.182010428536;6059.303180134341;6067.635941843503;6077.47784669375;4975.726335051462;5551.666899986014;5787.305523337226;5845.327787304344;5891.970540147272;4513.458384993822;5860.926655974057;5887.470127688529;5990.843296413201;6022.36765139654;4905.669806841865;5396.64921780083;5605.551555875439;5902.7343769531335;5962.850928726816 22:07:30 INFO - PROCESS | 1667 | |5;yui.html;633.1183307077251;696.9163700355958;706.2443185791202;755.5428965475887;809.8823623399708;13836.654083647914;15109.395624175033;15752.84247157528;15765.132917689523;16221.918890405532;12435.632080471163;14821.77767333491;14835.406583736638;14917.104973701586;14942.925285373558;838.2330167896367;852.8251708399763;854.6666799948025;854.799122206281;855.6449073634434;665.4343807763411;684.8150999230205;825.9463134896242;846.5047946951041;856.4561503445326;895.789489469974;896.6054935828247;900.2123142250531;901.6483571407124;903.737916004358;896.9641214351418;898.4474548152872;899.1458114790975;899.3929097858952;899.7075950316141;661.4113439039259;668.2949488289852;668.729164688302;669.4042302350912;669.6517810738388;14861.405543778235;15066.794656427459;15073.849261507354;15090.773638395432;15106.320215590325;11014.779704405866;14447.927760361235;14516.491922782758;14817.18505482198;14849.96050276481;11921.105917056255;11931.582394616147;11963.1625786195;11988.980936620397;12020.939895300555;3296.703296703284;3771.9811400943095;3811.0472381904524;3837.2517359114986;3931.567527571965;106797.46601267022;108741.45629271882;109271.45364273207;109922.45038774755;111727;10858.253902403658;11166.720831979103;11229.55081796719;11256.718582035515;11551.191416600757;17610.64778704419;22614.547709045728;22919;22925.885370573375;22953.655695164587;7963.243491868263;8127.455783401135;8140.674373025013;8314.085450600429;8320.500769953822;4340.782960851945;4451.955480445219;4461.531539188403;4482.663800214997;4493.640508759291;3530.805805680661;3617.909552261162;3666.211764470652;3671.8714844980295;3673.669369756735;636.5289685632691;637.4040272345372;644.336333576417;660.1451120798578;663.1246754284299;481.86266913929364;533.981310654133;600.2347007565302;635.3043417457876;639.7306397306379;7135.357817796424;7151.7854464366155;7474.40204783616;7892.842143157105;9429.717108486619;582.4932308891292;640.8237734622923;659.235287067;663.1611012069735;678.966051697423;3916.4908561886773;4138.172365526907;4189.4344263524645;4340.849674836171;4634.745089020136;93699.50403967666;125341.37329313478;135616;162501;167687;146919;146951;146951.5304846938;147069;149430.50569494383;117529.23706144415;121398;128262.35868820596;129747;130642;7678.359406437409;8640.222379985831;8823.602937867683;8838.823223535364;8859.955700221457;62403.37596623976;62478.750424990336;64859;65832.34167658263;66071.67856642744;47026.52973470221;57211.42788572061;84065.15934840574;98522;99667;11802.468888899848;11856.822147667619;12284.01727861751;12300.261984280973;12546.686332841387;12746.936265318614;12789.872101278868;13274.93362533181;13602.93198534001;13621.931890340486;11925.4037298133;12257.080718945936;12266.632001039983;12517.749645006867;12574.87425125737;10469.842952355873;12220.938895305466;12547.74904501923;12582.18215815969;12593;11791.528338866348;11878.287302761863;12342.382880855741;12433.93783031079;12452.750944980868;10239;10368.792624147323;10413.166946644402;10512.789744205225;10904.781904362027;8688;8987.19115279628;8998.73573959215;10023.649172278936;10025.699229023141 22:07:30 INFO - PROCESS | 1667 | __end_tp_report 22:07:30 INFO - PROCESS | 1667 | __start_cc_report 22:07:30 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,370 22:07:30 INFO - PROCESS | 1667 | __end_cc_report 22:07:30 INFO - PROCESS | 1667 | __startTimestamp1474261650532__endTimestamp 22:07:30 INFO - PROCESS | 1667 | 22:07:30 INFO - PROCESS | 1667 | ------- Summary: start ------- 22:07:30 INFO - PROCESS | 1667 | Number of tests: 6 22:07:30 INFO - PROCESS | 1667 | 22:07:30 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5743.61 Median:5958.43 stddev:682.75 (11.5%) stddev-sans-first:653.98 22:07:30 INFO - PROCESS | 1667 | Values: 3156.5 3189.6 3342.2 3360.9 3447.6 5649.1 5665.7 5692.7 5695.5 5772.5 5664.0 5665.2 5701.3 5812.2 5832.5 5165.1 5182.4 5247.4 5280.4 5305.8 5319.8 5324.2 5329.8 5355.5 5361.9 5106.8 5135.6 5149.1 5186.4 5275.5 5201.9 5217.3 5219.3 5223.9 5258.8 5164.2 5202.2 5224.2 5238.1 5240.8 4260.9 5648.5 5683.1 5749.2 5758.0 6223.3 6242.8 6263.9 6274.7 6277.9 6270.2 6293.2 6294.4 6296.9 6316.1 5766.8 5792.8 5804.0 5867.6 5884.7 5064.9 5219.9 6342.9 6352.6 6384.6 6046.7 6157.8 6195.6 6210.0 6213.2 6079.7 6155.8 6181.8 6264.7 6294.3 6172.0 6234.5 6276.2 6284.2 6285.7 6212.8 6232.7 6246.8 6259.5 6265.2 3988.4 4856.4 4914.4 4922.0 4956.4 4426.5 4440.2 4447.5 4500.3 4502.9 5747.6 5775.2 5832.6 5864.8 5890.7 6161.0 6210.0 6214.2 6275.3 6295.0 5753.4 5807.8 5860.5 5870.1 5908.7 5403.2 5427.8 5431.2 5436.0 5457.1 6229.8 6427.8 6431.6 6453.4 6463.9 6214.5 6217.8 6219.9 6267.0 6280.7 6397.5 6418.4 6420.6 6435.7 6442.3 6142.4 6156.0 6167.1 6192.2 6272.2 6208.0 6245.9 6247.8 6272.3 6279.4 5967.6 6201.5 6204.0 6221.9 6266.9 5892.4 5958.4 6204.1 6208.6 6209.6 4802.6 5127.9 5949.7 6127.7 6131.4 6118.4 6126.8 6136.4 6143.2 6188.6 5900.2 6067.5 6082.8 6091.9 6116.5 22:07:30 INFO - PROCESS | 1667 | 22:07:30 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:67486.06 Median:39540.20 stddev:148270.73 (375.0%) stddev-sans-first:148601.32 22:07:30 INFO - PROCESS | 1667 | Values: 480.4 484.0 485.8 524.2 528.0 39229.6 40563.2 40705.6 40769.6 40825.4 39870.8 41661.5 42139.8 42167.6 42269.6 9726.2 9873.5 9923.5 9936.6 9948.0 9775.8 9851.9 9858.8 9891.3 9912.8 9923.6 9925.2 9957.6 9960.8 9982.4 9889.3 9924.2 9925.6 9942.4 9948.3 9807.5 9818.1 9858.1 9895.1 9918.6 38955.0 39362.0 39704.0 39799.2 39850.2 3389.2 3392.2 3411.3 3427.2 3473.5 24475.9 30413.0 30662.4 30662.8 31248.2 3023.2 3150.8 3175.8 3186.7 3238.3 369943.0 436281.0 436381.0 440146.0 440163.8 59576.7 59904.4 60020.0 60052.1 60149.5 33727.8 34713.5 34855.3 63574.0 63825.4 16178.3 16462.9 16473.3 16498.5 16505.8 12763.0 12793.8 12837.8 12861.7 12887.4 18955.5 18956.7 18978.4 19026.1 19042.4 7706.0 7744.1 7782.4 7803.0 7873.6 723.8 862.6 928.9 995.2 1055.8 25236.7 28438.3 29435.4 29745.0 29835.4 842.9 1037.6 1066.0 1068.7 1137.2 14843.8 15165.8 15437.9 15541.1 15765.4 640769.0 646702.0 648762.8 649052.0 650085.0 53676.5 55013.0 55177.7 55373.7 55459.4 1306.1 1346.9 1360.5 1360.7 1370.3 28394.6 29040.6 29302.6 29892.1 29954.9 47673.0 48195.5 48387.0 48444.8 48514.3 564819.0 566319.0 567985.0 569564.0 569595.0 25813.7 25959.9 26324.6 26338.2 26352.3 44791.3 44869.6 45868.1 45868.5 45997.0 38277.2 38496.4 39053.6 39431.8 39648.6 37103.0 37616.2 37693.3 38697.0 38774.0 37002.0 37025.0 37108.0 37513.0 37513.4 28517.7 29606.0 32535.0 33994.0 34027.0 22334.2 22385.6 22557.0 23255.3 25557.1 22:07:30 INFO - PROCESS | 1667 | 22:07:30 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:35543.72 Median:2017.59 stddev:98745.55 (4894.2%) stddev-sans-first:98987.17 22:07:30 INFO - PROCESS | 1667 | Values: 334.5 360.1 369.8 372.2 372.5 17166.0 19198.0 19660.6 20360.5 20828.3 13891.6 20265.4 20303.0 20789.3 20803.4 5973.9 5995.1 6117.4 6245.0 6255.5 5973.4 6177.1 6180.3 6181.7 6187.4 5867.6 6035.0 6093.6 6141.3 6159.1 6056.0 6102.2 6110.2 6164.6 6171.2 4447.3 5086.7 5146.2 5231.0 5303.5 23254.9 23443.7 24509.8 25550.5 25810.0 2385.8 2387.3 2767.5 3040.2 3101.5 9589.8 9842.6 10189.4 10377.5 10439.6 1905.2 1912.6 1933.1 1950.6 1981.9 122937.0 127990.0 127991.4 128476.0 130492.0 9074.9 10719.7 11047.7 11113.0 11136.9 14012.8 14094.2 14140.9 14175.8 14184.5 8366.0 8526.9 8575.2 8583.1 8703.9 8525.9 8539.7 8561.9 8706.0 8717.2 3665.4 4093.6 4456.4 4481.1 4491.9 1587.9 1911.4 1916.1 1927.6 1928.3 830.4 869.8 897.3 967.7 994.2 19800.1 20457.4 20487.7 20722.0 20799.8 881.9 913.2 917.9 924.5 933.7 7263.5 10764.1 10939.3 10941.0 10994.2 574659.0 581447.0 588755.0 591751.0 592434.0 134340.0 135799.0 138913.0 140718.0 155233.0 967.9 994.4 1008.6 1012.0 1015.0 18073.2 18874.4 18968.4 19029.1 19064.3 58376.0 59024.5 59063.0 60353.4 60852.1 84092.6 87989.0 90175.5 90243.0 90337.0 5805.7 6393.3 6632.0 7022.1 7068.9 9495.6 11302.0 12921.5 13013.4 13357.5 9490.8 11153.8 11265.4 11491.2 11539.4 8922.0 9650.8 9901.1 10332.3 10822.0 11248.8 11435.0 11581.9 11752.8 11910.4 6051.6 6912.3 7233.5 7485.0 7544.4 9317.4 11173.1 11241.8 11252.3 11583.1 22:07:30 INFO - PROCESS | 1667 | 22:07:30 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5719.92 Median:4792.94 stddev:3215.48 (67.1%) stddev-sans-first:3207.31 22:07:30 INFO - PROCESS | 1667 | Values: 1295.8 1500.5 1673.6 1817.1 1861.9 7917.4 8154.5 8490.5 8927.2 8940.3 7407.9 8442.0 8659.3 8815.0 8821.3 2373.8 2386.3 2386.7 2409.6 2410.3 2370.4 2384.7 2395.0 2408.8 2422.2 2378.5 2399.0 2403.9 2407.9 2413.5 2371.5 2374.9 2378.9 2385.6 2388.4 2357.7 2363.6 2369.6 2379.6 2392.2 8804.5 8835.1 8895.9 8908.2 8959.6 5205.6 5345.1 5345.8 5353.8 5354.7 3652.7 3654.1 3687.4 3701.3 3729.8 1097.8 1098.0 1104.8 1112.1 1117.3 11631.2 11691.5 11730.8 11781.5 11810.5 3854.5 4537.3 4837.7 4858.2 4871.0 9904.0 10004.0 10010.7 10019.8 10030.6 5319.3 5335.3 5337.7 5353.7 5365.5 4378.7 4526.3 4748.2 4876.1 4879.9 3881.8 3931.3 3996.1 4020.1 4040.2 1282.6 1287.2 1287.4 1298.2 1301.7 812.3 860.8 900.7 908.4 913.6 5812.6 5853.3 5966.8 6014.2 6082.9 416.1 427.8 450.1 452.5 453.6 3779.4 3885.9 4033.7 4201.5 4295.7 10728.2 10798.5 10839.7 10888.5 10902.9 9374.0 10560.0 10563.2 10713.8 10849.6 8055.2 8135.2 8240.4 8257.8 8274.2 5940.5 6025.4 6056.5 6148.5 6160.6 9816.6 10106.4 10123.7 10127.5 10143.2 9789.9 10210.5 10283.9 10380.6 10408.4 7007.0 7188.8 7382.2 7582.1 7717.4 8241.1 8568.1 8572.5 8573.2 8575.4 7253.2 7462.0 7601.5 7689.3 7699.3 7170.2 7372.5 7408.2 7435.9 7597.3 5698.9 7055.2 7065.9 7071.6 7074.4 4927.9 5000.7 5054.7 5108.4 5128.6 4958.9 5006.2 5123.8 5158.8 5208.5 22:07:30 INFO - PROCESS | 1667 | 22:07:30 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:4750.83 Median:5378.81 stddev:1536.04 (28.6%) stddev-sans-first:1503.49 22:07:30 INFO - PROCESS | 1667 | Values: 294.8 301.9 308.6 309.4 313.8 4545.5 5092.9 5703.7 5716.3 5754.7 4817.5 5323.3 5511.9 5583.7 5584.2 3923.8 4255.5 4258.7 4260.4 4262.2 3942.4 4235.4 4249.9 4264.3 4271.4 3678.6 4187.3 4217.3 4225.4 4235.5 3088.3 3182.2 3877.9 4117.5 4218.3 2981.8 3078.9 3584.1 3624.7 3660.3 5185.9 5411.2 5468.5 5473.5 5478.4 3702.7 4471.8 4783.7 4809.3 4870.7 4403.1 5682.1 5815.6 6047.9 6060.7 3799.3 3931.5 3988.5 3989.2 4015.2 4994.6 6249.8 6285.8 6296.5 6341.9 3417.8 3576.9 4069.7 4088.6 4111.8 3413.1 4059.8 4113.4 4118.9 4137.9 4022.7 4586.5 4790.6 4795.6 4810.7 4937.0 5354.8 5506.7 5519.0 6081.4 1082.9 1357.4 1361.5 1377.8 1395.7 810.4 879.3 913.7 917.8 938.6 4557.7 5489.3 5505.2 5507.7 5529.8 5260.0 5309.7 5780.9 5781.0 6048.9 4135.6 4521.5 5444.5 5540.3 5562.9 2479.9 3148.8 3172.8 3216.2 3232.8 5070.6 6394.8 6397.5 6405.9 6439.6 5975.0 6289.8 6308.3 6319.0 6362.5 6363.5 6392.9 6398.0 6415.4 6422.3 5758.6 6076.6 6135.9 6141.5 6201.3 5361.0 6066.3 6105.6 6165.7 6171.6 6221.5 6454.5 6478.3 6483.5 6488.8 3629.3 4099.3 4177.6 4195.3 4195.7 5290.7 5721.9 6145.5 6219.6 6257.4 4464.8 5619.0 5955.7 6061.7 6078.8 6031.4 6059.2 6059.3 6067.6 6077.5 4975.7 5551.7 5787.3 5845.3 5892.0 4513.5 5860.9 5887.5 5990.8 6022.4 4905.7 5396.6 5605.6 5902.7 5962.9 22:07:30 INFO - PROCESS | 1667 | 22:07:30 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:24822.53 Median:3672.77 stddev:41009.54 (1116.6%) stddev-sans-first:41084.37 22:07:30 INFO - PROCESS | 1667 | Values: 633.1 696.9 706.2 755.5 809.9 13836.7 15109.4 15752.8 15765.1 16221.9 12435.6 14821.8 14835.4 14917.1 14942.9 838.2 852.8 854.7 854.8 855.6 665.4 684.8 825.9 846.5 856.5 895.8 896.6 900.2 901.6 903.7 897.0 898.4 899.1 899.4 899.7 661.4 668.3 668.7 669.4 669.7 14861.4 15066.8 15073.8 15090.8 15106.3 11014.8 14447.9 14516.5 14817.2 14850.0 11921.1 11931.6 11963.2 11989.0 12020.9 3296.7 3772.0 3811.0 3837.3 3931.6 106797.5 108741.5 109271.5 109922.5 111727.0 10858.3 11166.7 11229.6 11256.7 11551.2 17610.6 22614.5 22919.0 22925.9 22953.7 7963.2 8127.5 8140.7 8314.1 8320.5 4340.8 4452.0 4461.5 4482.7 4493.6 3530.8 3617.9 3666.2 3671.9 3673.7 636.5 637.4 644.3 660.1 663.1 481.9 534.0 600.2 635.3 639.7 7135.4 7151.8 7474.4 7892.8 9429.7 582.5 640.8 659.2 663.2 679.0 3916.5 4138.2 4189.4 4340.8 4634.7 93699.5 125341.4 135616.0 162501.0 167687.0 146919.0 146951.0 146951.5 147069.0 149430.5 117529.2 121398.0 128262.4 129747.0 130642.0 7678.4 8640.2 8823.6 8838.8 8860.0 62403.4 62478.8 64859.0 65832.3 66071.7 47026.5 57211.4 84065.2 98522.0 99667.0 11802.5 11856.8 12284.0 12300.3 12546.7 12746.9 12789.9 13274.9 13602.9 13621.9 11925.4 12257.1 12266.6 12517.7 12574.9 10469.8 12220.9 12547.7 12582.2 12593.0 11791.5 11878.3 12342.4 12433.9 12452.8 10239.0 10368.8 10413.2 10512.8 10904.8 8688.0 8987.2 8998.7 10023.6 10025.7 22:07:30 INFO - PROCESS | 1667 | -------- Summary: end -------- 22:07:30 INFO - PROCESS | 1667 | 22:07:31 INFO - TEST-INFO | 1667: exit 0 22:07:31 INFO - TEST-OK | dromaeo_css | took 1114595ms 22:07:31 INFO - TEST-START | kraken 22:07:31 INFO - operating with platform_type : mac_ 22:07:31 INFO - Initialising browser for kraken test... 22:07:31 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/tmpu8dlja/profile http://localhost:49271/getInfo.html) 22:07:33 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 22:07:33 INFO - PROCESS | 1674 | colorDepth:24 22:07:33 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 22:07:33 INFO - PROCESS | 1674 | __metrics 22:07:34 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 22:07:34 INFO - TEST-INFO | 1674: exit 0 22:07:34 INFO - Browser initialized. 22:07:34 INFO - Running cycle 1/1 for kraken test... 22:07:34 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/tmpu8dlja/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:07:46 INFO - PROCESS | 1676 | RSS: Main: 239128576 22:07:46 INFO - PROCESS | 1676 | 22:07:49 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 22:07:50 INFO - PROCESS | 1676 | RSS: Main: 252448768 22:07:50 INFO - PROCESS | 1676 | 22:07:53 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 22:07:54 INFO - PROCESS | 1676 | RSS: Main: 261259264 22:07:54 INFO - PROCESS | 1676 | 22:07:57 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 22:07:58 INFO - PROCESS | 1676 | RSS: Main: 261386240 22:07:58 INFO - PROCESS | 1676 | 22:08:00 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 22:08:00 INFO - PROCESS | 1676 | RSS: Main: 262254592 22:08:00 INFO - PROCESS | 1676 | 22:08:02 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:08:03 INFO - PROCESS | 1676 | RSS: Main: 263835648 22:08:03 INFO - PROCESS | 1676 | 22:08:06 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 22:08:06 INFO - PROCESS | 1676 | RSS: Main: 264740864 22:08:06 INFO - PROCESS | 1676 | 22:08:09 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 22:08:10 INFO - PROCESS | 1676 | RSS: Main: 264966144 22:08:10 INFO - PROCESS | 1676 | 22:08:13 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 22:08:14 INFO - PROCESS | 1676 | RSS: Main: 265109504 22:08:14 INFO - PROCESS | 1676 | 22:08:15 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:08:16 INFO - PROCESS | 1676 | RSS: Main: 264904704 22:08:16 INFO - PROCESS | 1676 | 22:08:18 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:08:19 INFO - PROCESS | 1676 | RSS: Main: 264945664 22:08:19 INFO - PROCESS | 1676 | 22:08:21 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:08:22 INFO - PROCESS | 1676 | RSS: Main: 265089024 22:08:22 INFO - PROCESS | 1676 | 22:08:24 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:08:25 INFO - PROCESS | 1676 | RSS: Main: 265633792 22:08:25 INFO - PROCESS | 1676 | 22:08:28 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:08:29 INFO - PROCESS | 1676 | RSS: Main: 265097216 22:08:29 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 22:08:31 INFO - PROCESS | 1676 | RSS: Main: 266596352 22:08:31 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | __start_tp_report 22:08:31 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 22:08:31 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 22:08:31 INFO - PROCESS | 1676 | |i|pagename|runs| 22:08:31 INFO - PROCESS | 1676 | |0;ai-astar;118;118;120;117;117;129;176;158;117;118 22:08:31 INFO - PROCESS | 1676 | |1;audio-beat-detection;152;140;119;184;150;145;112;111;140;112 22:08:31 INFO - PROCESS | 1676 | |2;audio-dft;207;213;205;199;199;199;198;197;196;200 22:08:31 INFO - PROCESS | 1676 | |3;audio-fft;83;58;59;84;60;62;61;59;81;65 22:08:31 INFO - PROCESS | 1676 | |4;audio-oscillator;87;72;88;73;70;79;108;91;102;122 22:08:31 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;92;125;90;86;90;86;91;88;92;87 22:08:31 INFO - PROCESS | 1676 | |6;imaging-darkroom;96;98;97;107;99;97;96;96;96;153 22:08:31 INFO - PROCESS | 1676 | |7;imaging-desaturate;91;120;143;92;141;144;123;91;94;128 22:08:31 INFO - PROCESS | 1676 | |8;json-parse-financial;51;50;59;52;74;90;88;90;48;46 22:08:31 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;68;78;73;86;78;73;72;62;71;88 22:08:31 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;87;84;89;75;100;107;113;112;108;100 22:08:31 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;138;143;156;154;159;143;145;146;178;144 22:08:31 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;179;173;173;175;177;180;244;240;169;172 22:08:31 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;69;67;71;67;71;68;71;66;69;70 22:08:31 INFO - PROCESS | 1676 | __end_tp_report 22:08:31 INFO - PROCESS | 1676 | __start_cc_report 22:08:31 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,943 22:08:31 INFO - PROCESS | 1676 | __end_cc_report 22:08:31 INFO - PROCESS | 1676 | __startTimestamp1474261711267__endTimestamp 22:08:31 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | ------- Summary: start ------- 22:08:31 INFO - PROCESS | 1676 | Number of tests: 14 22:08:31 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:128.80 Median:119.00 stddev:20.88 (17.6%) stddev-sans-first:21.78 22:08:31 INFO - PROCESS | 1676 | Values: 118.0 118.0 120.0 117.0 117.0 129.0 176.0 158.0 117.0 118.0 22:08:31 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:142.50 stddev:23.41 (16.4%) stddev-sans-first:24.15 22:08:31 INFO - PROCESS | 1676 | Values: 152.0 140.0 119.0 184.0 150.0 145.0 112.0 111.0 140.0 112.0 22:08:31 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:201.30 Median:199.50 stddev:5.36 (2.7%) stddev-sans-first:5.27 22:08:31 INFO - PROCESS | 1676 | Values: 207.0 213.0 205.0 199.0 199.0 199.0 198.0 197.0 196.0 200.0 22:08:31 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:67.20 Median:63.50 stddev:10.87 (17.1%) stddev-sans-first:9.91 22:08:31 INFO - PROCESS | 1676 | Values: 83.0 58.0 59.0 84.0 60.0 62.0 61.0 59.0 81.0 65.0 22:08:31 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:76.00 stddev:17.11 (22.5%) stddev-sans-first:18.13 22:08:31 INFO - PROCESS | 1676 | Values: 87.0 72.0 88.0 73.0 70.0 79.0 108.0 91.0 102.0 122.0 22:08:31 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:92.70 Median:90.00 stddev:11.58 (12.9%) stddev-sans-first:12.28 22:08:31 INFO - PROCESS | 1676 | Values: 92.0 125.0 90.0 86.0 90.0 86.0 91.0 88.0 92.0 87.0 22:08:31 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:103.50 Median:96.50 stddev:17.71 (18.4%) stddev-sans-first:18.57 22:08:31 INFO - PROCESS | 1676 | Values: 96.0 98.0 97.0 107.0 99.0 97.0 96.0 96.0 96.0 153.0 22:08:31 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:116.70 Median:117.50 stddev:22.74 (19.3%) stddev-sans-first:22.13 22:08:31 INFO - PROCESS | 1676 | Values: 91.0 120.0 143.0 92.0 141.0 144.0 123.0 91.0 94.0 128.0 22:08:31 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:66.50 stddev:18.67 (28.1%) stddev-sans-first:19.12 22:08:31 INFO - PROCESS | 1676 | Values: 51.0 50.0 59.0 52.0 74.0 90.0 88.0 90.0 48.0 46.0 22:08:31 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:74.90 Median:75.50 stddev:7.88 (10.4%) stddev-sans-first:7.95 22:08:31 INFO - PROCESS | 1676 | Values: 68.0 78.0 73.0 86.0 78.0 73.0 72.0 62.0 71.0 88.0 22:08:31 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:97.50 Median:94.00 stddev:13.06 (13.9%) stddev-sans-first:13.29 22:08:31 INFO - PROCESS | 1676 | Values: 87.0 84.0 89.0 75.0 100.0 107.0 113.0 112.0 108.0 100.0 22:08:31 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:150.60 Median:150.00 stddev:11.70 (7.8%) stddev-sans-first:11.49 22:08:31 INFO - PROCESS | 1676 | Values: 138.0 143.0 156.0 154.0 159.0 143.0 145.0 146.0 178.0 144.0 22:08:31 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.20 Median:178.00 stddev:28.56 (16.0%) stddev-sans-first:30.10 22:08:31 INFO - PROCESS | 1676 | Values: 179.0 173.0 173.0 175.0 177.0 180.0 244.0 240.0 169.0 172.0 22:08:31 INFO - PROCESS | 1676 | 22:08:31 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.50 stddev:1.85 (2.7%) stddev-sans-first:1.96 22:08:31 INFO - PROCESS | 1676 | Values: 69.0 67.0 71.0 67.0 71.0 68.0 71.0 66.0 69.0 70.0 22:08:31 INFO - PROCESS | 1676 | -------- Summary: end -------- 22:08:31 INFO - PROCESS | 1676 | 22:08:32 INFO - TEST-INFO | 1676: exit 0 22:08:32 INFO - TEST-OK | kraken | took 60921ms 22:08:32 INFO - SUITE-END | took 1175s 22:08:32 INFO - Completed test suite (00:19:35) 22:08:32 INFO - javascript benchmark 22:08:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7322.048407956135, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3156.5164372744807, 3189.6331921828987, 3342.231286804035, 3360.92450415867, 3447.6035255945576, 5649.12438572021, 5665.688387138705, 5692.715364231787, 5695.487406133447, 5772.45161709638, 5663.971680141603, 5665.1785491103765, 5701.315842098944, 5812.157237200603, 5832.504237139849, 5165.147750621143, 5182.352205974254, 5247.39654939683, 5280.3663560372615, 5305.787768489276, 5319.787208511674, 5324.227986941891, 5329.813456529022, 5355.464453554633, 5361.919571206435, 5106.821261255838, 5135.589152867761, 5149.0731668299695, 5186.403563590197, 5275.525202731773, 5201.9479805201845, 5217.3217481727515, 5219.295395121686, 5223.947760522384, 5258.789648414059, 5164.173732202867, 5202.2196670499725, 5224.164133738584, 5238.135707608279, 5240.764165612557, 4260.8721738347585, 5648.4633959773755, 5683.147527870811, 5749.223854779593, 5758.021136406821, 6223.346548612376, 6242.781502647431, 6263.87472250557, 6274.686265686697, 6277.905831412532, 6270.184875966095, 6293.244810622708, 6294.433500984887, 6296.87406251877, 6316.08416779569, 5766.769329226826, 5792.797252096157, 5803.970980145156, 5867.589268751189, 5884.705764711747, 5064.898702025939, 5219.9217011744095, 6342.904856427157, 6352.555321127569, 6384.553081284265, 6046.667433291212, 6157.784477543264, 6195.597286176384, 6209.96895015522, 6213.1922850029205, 6079.665618391031, 6155.753769849156, 6181.8454538636, 6264.684416272543, 6294.276158241769, 6171.9691401542705, 6234.470070044006, 6276.215473065867, 6284.183056202664, 6285.717142728588, 6212.844678882973, 6232.688365581703, 6246.781362652286, 6259.4679452246155, 6265.185525881698, 3988.4017397390044, 4856.39295088114, 4914.36113305268, 4921.9507804922205, 4956.430010548833, 4426.513083560806, 4440.200763862471, 4447.488538818013, 4500.324951257272, 4502.909941801211, 5747.626404283792, 5775.249217601685, 5832.571020100103, 5864.794732184353, 5890.734916928748, 6161.0, 6210.0, 6214.1921550198185, 6275.341089185661, 6295.0, 5753.367129615739, 5807.767689292381, 5860.501857342174, 5870.060790273621, 5908.675022873697, 5403.189521571717, 5427.83716488506, 5431.2396264522995, 5436.021516127135, 5457.126859702428, 6229.750809967551, 6427.839304017343, 6431.646259455775, 6453.386928241809, 6463.903041454476, 6214.5028397727165, 6217.751289948352, 6219.942609756262, 6267.0286105653695, 6280.7487700491465, 6397.520185985976, 6418.390252925965, 6420.6468644225015, 6435.710393032418, 6442.259140198749, 6142.385761423822, 6156.015037594143, 6167.074938759042, 6192.164057852132, 6272.2159730033745, 6208.0, 6245.937540624535, 6247.843803904939, 6272.278687950944, 6279.372062793684, 5967.6121052131475, 6201.503879689704, 6203.976343903206, 6221.906671399842, 6266.871963046513, 5892.381299963442, 5958.433948774859, 6204.13142160089, 6208.627482351073, 6209.565330426827, 4802.591779698765, 5127.948720512747, 5949.702514874326, 6127.678242056309, 6131.386861313833, 6118.418750218722, 6126.816195514141, 6136.447719705248, 6143.154692370071, 6188.597741146811, 5900.232969713909, 6067.453929146398, 6082.847928801815, 6091.8781624366375, 6116.480099191618], "value": 5699.254433629585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.39470267462997, 483.9733814640193, 485.75712143928035, 524.1901262549361, 527.9836315093444, 39229.60770392295, 40563.18873622526, 40705.59294407055, 40769.59230407695, 40825.387619185734, 39870.80064599673, 41661.50030998135, 42139.789301053526, 42167.578324216745, 42269.57730422695, 9726.221902247838, 9873.506324683773, 9923.454210018446, 9936.552855121501, 9948.0, 9775.755606109833, 9851.90148098517, 9858.802823943517, 9891.25815563832, 9912.752181195492, 9923.603055877757, 9925.156361709263, 9957.601695932153, 9960.800783984316, 9982.35114717541, 9889.307748457612, 9924.206063514937, 9925.553350099262, 9942.403455792602, 9948.303618746691, 9807.509624518745, 9818.067283608047, 9858.063483969012, 9895.109440150422, 9918.553665085088, 38955.0, 39362.015949601206, 39704.0, 39799.20401591952, 39850.202995940206, 3389.1696534348994, 3392.23674673199, 3411.3347897160065, 3427.1774774054297, 3473.4616134499192, 24475.877620611962, 30413.0, 30662.386752265054, 30662.84668576665, 31248.21879453009, 3023.2290765854787, 3150.8408900251675, 3175.841207939594, 3186.6972637599392, 3238.3037646906027, 369943.0, 436281.0, 436381.0, 440146.0, 440163.7991810052, 59576.70211649001, 59904.40095599076, 60020.0, 60052.09921851176, 60149.496262593784, 33727.83136084304, 34713.479297810554, 34855.302893942484, 63574.0, 63825.36174638194, 16178.27197776103, 16462.917685411736, 16473.258703358137, 16498.505044848673, 16505.752413713803, 12763.042771792152, 12793.808092878615, 12837.753393156161, 12861.742765144645, 12887.355632218352, 18955.526111847314, 18956.715649265272, 18978.43064708061, 19026.143823527975, 19042.42872713821, 7705.961470192613, 7744.109427415807, 7782.416318776114, 7803.0, 7873.606319684108, 723.7937187901529, 862.6290695001085, 928.8621438737492, 995.2286977592424, 1055.8416237564427, 25236.747632523806, 28438.289042773682, 29435.411291774046, 29745.0, 29835.403291934475, 842.8819965204876, 1037.5642230263309, 1066.0192622787054, 1068.7007637861411, 1137.2266858536275, 14843.777343339858, 15165.772513412086, 15437.858108141676, 15541.06753594788, 15765.369385224692, 640769.0, 646702.0, 648762.756186216, 649052.0, 650085.0, 53676.463235367926, 55013.0, 55177.72411137919, 55373.72313138489, 55459.445405546234, 1306.1314226039767, 1346.9057165998481, 1360.5102163221231, 1360.7074478986867, 1370.2737549098993, 28394.574081389208, 29040.56439153372, 29302.56046159352, 29892.103236902927, 29954.85022574873, 47673.0, 48195.5180448191, 48387.0, 48444.788880276865, 48514.27228591503, 564819.0, 566319.0, 567985.0, 569564.0, 569595.0, 25813.741862581133, 25959.870200648875, 26324.605130922668, 26338.156329056783, 26352.34119147037, 44791.328130077425, 44869.55130448654, 45868.08263834771, 45868.54131458776, 45997.0, 38277.23445531018, 38496.422553661156, 39053.609463905, 39431.80284098676, 39648.60351396449, 37103.0, 37616.24767504689, 37693.28833895763, 38697.0, 38774.0, 37002.0, 37025.0, 37108.0, 37513.0, 37513.437298439996, 28517.714822851507, 29605.9637912672, 32535.0, 33994.0, 34027.0, 22334.21830235934, 22385.552288953804, 22556.984935677607, 23255.3023409298, 25557.105501307364], "value": 19513.177550484597, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.5182936571337, 360.1374707575359, 369.78552439585036, 372.19791349641497, 372.52875112982076, 17166.0, 19198.040097995097, 19660.606787864235, 20360.490987725316, 20828.271010514636, 13891.583252502416, 20265.392038238875, 20303.0, 20789.272375466862, 20803.37589872306, 5973.910391344144, 5995.13070604762, 6117.418845209698, 6244.968775156118, 6255.530835187379, 5973.372795856416, 6177.073438984144, 6180.320164781893, 6181.721822517975, 6187.4431301182885, 5867.618604790697, 6034.969825150868, 6093.573449858512, 6141.293751218623, 6159.137720719081, 6055.9697201514155, 6102.20671312731, 6110.2056732624915, 6164.568480206387, 6171.166892469504, 4447.310666846644, 5086.720230387327, 5146.202338637479, 5230.973845130788, 5303.496167864047, 23254.883725581432, 23443.71059591722, 24509.774511274365, 25550.488990220092, 25810.0, 2385.8210634202505, 2387.3434805428474, 2767.5433553463654, 3040.1639549123947, 3101.457244982119, 9589.808203835953, 9842.557084931195, 10189.439580823126, 10377.533011014522, 10439.582416703322, 1905.1522072677665, 1912.6079153773444, 1933.1204302042536, 1950.5903760210372, 1981.9108140133728, 122937.0, 127990.0, 127991.36004320013, 128475.99999999907, 130492.0, 9074.863877041718, 10719.732006699895, 11047.668569942914, 11112.999490137618, 11136.944315278372, 14012.789808152886, 14094.154350738989, 14140.85859141416, 14175.78736318956, 14184.503542376173, 8366.0, 8526.914730852612, 8575.156341386508, 8583.0987746287, 8703.869441958375, 8525.914740852637, 8539.74380768578, 8561.914380856111, 8705.956470217609, 8717.171868672465, 3665.395209790408, 4093.570175131628, 4456.398386217884, 4481.126180394792, 4491.88770280739, 1587.857092861648, 1911.4074636862617, 1916.1319206088476, 1927.6433859735994, 1928.3154480159621, 830.3772170871846, 869.7999460124207, 897.264243320471, 967.709687093869, 994.2493417469908, 19800.128981297632, 20457.386278411373, 20487.69268460974, 20722.0, 20799.792002079786, 881.8985816631041, 913.1781396742851, 917.8714979902819, 924.523870206844, 933.6825479337058, 7263.455240856852, 10764.085052770446, 10939.28894621863, 10941.015308622103, 10994.230403871652, 574659.0, 581447.0, 588755.0, 591751.0, 592434.0, 134340.0, 135799.0, 138913.0, 140718.0, 155233.0, 967.8644989701447, 994.3636072913341, 1008.5864795433984, 1011.9949400252951, 1014.9644762433427, 18073.18670659797, 18874.43376698701, 18968.43094707161, 19029.14368853377, 19064.33274835374, 58376.0, 59024.52438689067, 59063.0, 60353.39646603478, 60852.08721869264, 84092.57953710436, 87989.0, 90175.54912225397, 90243.0, 90337.0, 5805.738741756715, 6393.264774550986, 6631.972044333136, 7022.08712867324, 7068.893966590403, 9495.572699228689, 11302.0, 12921.547745828851, 13013.414396351998, 13357.465701371837, 9490.813648293963, 11153.776924461303, 11265.380404077854, 11491.195616307112, 11539.423028848356, 8922.018577956289, 9650.7587310315, 9901.118787430365, 10332.328398654063, 10822.0, 11248.83126753083, 11435.0, 11581.88418115808, 11752.76494470123, 11910.404479776149, 6051.636901785907, 6912.308769123048, 7233.493655444068, 7484.952106704956, 7544.396448284015, 9317.44095354281, 11173.106151507698, 11241.775164496828, 11252.26860254081, 11583.131265155316], "value": 9489.076797827049, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1295.766761982843, 1500.4598344595943, 1673.6485338079003, 1817.127778666241, 1861.888286702798, 7917.406194535419, 8154.469959452646, 8490.490570565771, 8927.196552310299, 8940.329475289354, 7407.8888816667795, 8442.0, 8659.263962563175, 8815.0, 8821.338399620023, 2373.8100951923807, 2386.272186982974, 2386.6658667786523, 2409.5662780699467, 2410.252821625293, 2370.4429459077105, 2384.7138343398815, 2394.964075538868, 2408.7832095111435, 2422.200673777658, 2378.4886249456363, 2399.0, 2403.9399015024587, 2407.939801504968, 2413.5052314275617, 2371.5019845832394, 2374.8812559371963, 2378.857268563883, 2385.5705972924866, 2388.379021454417, 2357.6817129687443, 2363.5981883079917, 2369.6327069304284, 2379.559781440439, 2392.1627430399394, 8804.47173169612, 8835.116488351177, 8895.866562001574, 8908.153725396078, 8959.641614335418, 5205.583553315726, 5345.091334473149, 5345.812896548641, 5353.839384818461, 5354.705491197982, 3652.6712595866497, 3654.104744337628, 3687.4468829675493, 3701.3152566775234, 3729.776213427203, 1097.8243481043075, 1098.0447011100393, 1104.7845670094334, 1112.1158678850334, 1117.2961034548264, 11631.243969141979, 11691.532338706442, 11730.765384692259, 11781.469833857496, 11810.468528916219, 3854.49891514107, 4537.274036154199, 4837.661363704507, 4858.198397264412, 4870.951290487121, 9904.0, 10004.049615286536, 10010.749731256632, 10019.849702254473, 10030.598776048877, 5319.28189694394, 5335.306410166731, 5337.733113344395, 5353.652012619167, 5365.517103460707, 4378.715383500063, 4526.275795872644, 4748.216544270157, 4876.097921884463, 4879.926801097916, 3881.8261773406985, 3931.2923673739, 3996.140829721624, 4020.0753826619457, 4040.1515681706583, 1282.6344491819787, 1287.1569122224957, 1287.4335292471283, 1298.2340419152556, 1301.6810881334134, 812.3257696112213, 860.7632900952289, 900.7297810656777, 908.418612088264, 913.6025828764376, 5812.593118481665, 5853.297604287428, 5966.791162309299, 6014.1580178775, 6082.908756368658, 416.11575402270176, 427.81390095308643, 450.0795872440866, 452.4751288505318, 453.58950150114197, 3779.4141908004303, 3885.9028524286555, 4033.6773058155277, 4201.495820501559, 4295.6778241632, 10728.249022568501, 10798.51406686701, 10839.729006774736, 10888.510017049093, 10902.890971090346, 9373.953130234306, 10560.049595536439, 10563.207759418074, 10713.83929241062, 10849.566017359217, 8055.154208808108, 8135.227153420416, 8240.381971352053, 8257.83484330322, 8274.172582741678, 5940.495057920125, 6025.367336429612, 6056.545759068, 6148.47737942262, 6160.630362178284, 9816.558254878404, 10106.393616382746, 10123.696289111338, 10127.544260508443, 10143.188544916242, 9789.923108457922, 10210.540525676512, 10283.897161028593, 10380.584776609154, 10408.427536485566, 7007.019017337475, 7188.820279493055, 7382.187959324363, 7582.090149182133, 7717.382609391348, 8241.093479717107, 8568.14318568163, 8572.485650860968, 8573.22840944318, 8575.356848236532, 7253.165885922976, 7461.962690186731, 7601.505902116345, 7689.3464055555905, 7699.307062364414, 7170.247124052108, 7372.520786148883, 7408.185099638928, 7435.92564074374, 7597.278258565428, 5698.857528561819, 7055.223925368308, 7065.894011589933, 7071.646417679199, 7074.398676112588, 4927.852164435073, 5000.67495612784, 5054.69671819692, 5108.361454818148, 5128.564072053917, 4958.8760280993265, 5006.170973130222, 5123.795048198031, 5158.845234642967, 5208.453112423141], "value": 4523.536207056118, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.752407977299, 301.93206528531084, 308.6342683919556, 309.35036423510616, 313.76467649263054, 4545.454545454541, 5092.872678183047, 5703.657780533165, 5716.314042314918, 5754.74103665335, 4817.518248175181, 5323.334583177103, 5511.862203444916, 5583.748731307091, 5584.21820945068, 3923.823427945735, 4255.468066491689, 4258.659307255428, 4260.446142001551, 4262.231174062768, 3942.4283478895545, 4235.428217190686, 4249.936250956238, 4264.296391095466, 4271.359296105594, 3678.613745556718, 4187.33002719565, 4217.283061879488, 4225.387318838767, 4235.49174099107, 3088.3051313454516, 3182.236263296792, 3877.8836634901, 4117.464729585135, 4218.3250679891225, 2981.761459083268, 3078.9230269243226, 3584.13980644646, 3624.72814538908, 3660.3045421369857, 5185.948140518584, 5411.242426060355, 5468.453154684539, 5473.507384335429, 5478.411260734422, 3702.7222958278235, 4471.754053527055, 4783.712977221343, 4809.302651115604, 4870.65905386623, 4403.075354175627, 5682.147677848315, 5815.592908496407, 6047.879042419171, 6060.696965151725, 3799.2781371539318, 3931.5085614298214, 3988.481497405348, 3989.2221016901717, 4015.156817068419, 4994.600431965434, 6249.843778900872, 6285.842853928642, 6296.464800491964, 6341.921873281507, 3417.79493230407, 3576.8926932191557, 4069.674426045909, 4088.632023117934, 4111.76647005897, 3413.061408112739, 4059.837606495766, 4113.424120623115, 4118.855840045584, 4137.8965525862095, 4022.6580740637373, 4586.541345865454, 4790.640701947368, 4795.6163506919365, 4810.7113573185725, 4937.0, 5354.759035843396, 5506.74223568335, 5519.006578815852, 6081.361457046946, 1082.884628832304, 1357.3756072206697, 1361.4554178328747, 1377.7864431013209, 1395.7487652222696, 810.4003037752021, 879.3404946290283, 913.6847787513298, 917.8164367126468, 938.5823308627595, 4557.726536407826, 5489.313835770528, 5505.229267902497, 5507.697076660822, 5529.834104976857, 5259.974305010486, 5309.734513274321, 5780.884382312414, 5781.034448287603, 6048.884824315481, 4135.648469880094, 4521.547845215518, 5444.50999410055, 5540.279763630702, 5562.916556251659, 2479.913203037885, 3148.795328303653, 3172.762042846796, 3216.2281052547687, 3232.7575431842706, 5070.569001634903, 6394.808155755335, 6397.52018598607, 6405.935940640627, 6439.581427207217, 5974.984252677055, 6289.811305660837, 6308.337624549448, 6319.0, 6362.504811369325, 6363.490920726238, 6392.872142557123, 6397.96801015992, 6415.422611964946, 6422.325655806167, 5758.568107391879, 6076.635401875901, 6135.883120323481, 6141.508679305555, 6201.255849298113, 5360.973195133999, 6066.332703402711, 6105.603965145088, 6165.6608886509875, 6171.63645813024, 6221.47117495018, 6454.483641308778, 6478.319776423407, 6483.546151769519, 6488.832010238202, 3629.25600251953, 4099.303118469927, 4177.56135605757, 4195.307774217342, 4195.664346852305, 5290.677330667333, 5721.914171287517, 6145.508359331332, 6219.564630475823, 6257.374262573706, 4464.843730469418, 5618.965758490533, 5955.702214889325, 6061.696915154313, 6078.750862181021, 6031.406495207103, 6059.182010428536, 6059.303180134341, 6067.635941843503, 6077.47784669375, 4975.726335051462, 5551.666899986014, 5787.305523337226, 5845.327787304344, 5891.970540147272, 4513.458384993822, 5860.926655974057, 5887.470127688529, 5990.843296413201, 6022.36765139654, 4905.669806841865, 5396.64921780083, 5605.551555875439, 5902.7343769531335, 5962.850928726816], "value": 4258.186466073257, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.1183307077251, 696.9163700355958, 706.2443185791202, 755.5428965475887, 809.8823623399708, 13836.654083647914, 15109.395624175033, 15752.84247157528, 15765.132917689523, 16221.918890405532, 12435.632080471163, 14821.77767333491, 14835.406583736638, 14917.104973701586, 14942.925285373558, 838.2330167896367, 852.8251708399763, 854.6666799948025, 854.799122206281, 855.6449073634434, 665.4343807763411, 684.8150999230205, 825.9463134896242, 846.5047946951041, 856.4561503445326, 895.789489469974, 896.6054935828247, 900.2123142250531, 901.6483571407124, 903.737916004358, 896.9641214351418, 898.4474548152872, 899.1458114790975, 899.3929097858952, 899.7075950316141, 661.4113439039259, 668.2949488289852, 668.729164688302, 669.4042302350912, 669.6517810738388, 14861.405543778235, 15066.794656427459, 15073.849261507354, 15090.773638395432, 15106.320215590325, 11014.779704405866, 14447.927760361235, 14516.491922782758, 14817.18505482198, 14849.96050276481, 11921.105917056255, 11931.582394616147, 11963.1625786195, 11988.980936620397, 12020.939895300555, 3296.703296703284, 3771.9811400943095, 3811.0472381904524, 3837.2517359114986, 3931.567527571965, 106797.46601267022, 108741.45629271882, 109271.45364273207, 109922.45038774755, 111727.0, 10858.253902403658, 11166.720831979103, 11229.55081796719, 11256.718582035515, 11551.191416600757, 17610.64778704419, 22614.547709045728, 22919.0, 22925.885370573375, 22953.655695164587, 7963.243491868263, 8127.455783401135, 8140.674373025013, 8314.085450600429, 8320.500769953822, 4340.782960851945, 4451.955480445219, 4461.531539188403, 4482.663800214997, 4493.640508759291, 3530.805805680661, 3617.909552261162, 3666.211764470652, 3671.8714844980295, 3673.669369756735, 636.5289685632691, 637.4040272345372, 644.336333576417, 660.1451120798578, 663.1246754284299, 481.86266913929364, 533.981310654133, 600.2347007565302, 635.3043417457876, 639.7306397306379, 7135.357817796424, 7151.7854464366155, 7474.40204783616, 7892.842143157105, 9429.717108486619, 582.4932308891292, 640.8237734622923, 659.235287067, 663.1611012069735, 678.966051697423, 3916.4908561886773, 4138.172365526907, 4189.4344263524645, 4340.849674836171, 4634.745089020136, 93699.50403967666, 125341.37329313478, 135616.0, 162501.0, 167687.0, 146919.0, 146951.0, 146951.5304846938, 147069.0, 149430.50569494383, 117529.23706144415, 121398.0, 128262.35868820596, 129747.0, 130642.0, 7678.359406437409, 8640.222379985831, 8823.602937867683, 8838.823223535364, 8859.955700221457, 62403.37596623976, 62478.750424990336, 64859.0, 65832.34167658263, 66071.67856642744, 47026.52973470221, 57211.42788572061, 84065.15934840574, 98522.0, 99667.0, 11802.468888899848, 11856.822147667619, 12284.01727861751, 12300.261984280973, 12546.686332841387, 12746.936265318614, 12789.872101278868, 13274.93362533181, 13602.93198534001, 13621.931890340486, 11925.4037298133, 12257.080718945936, 12266.632001039983, 12517.749645006867, 12574.87425125737, 10469.842952355873, 12220.938895305466, 12547.74904501923, 12582.18215815969, 12593.0, 11791.528338866348, 11878.287302761863, 12342.382880855741, 12433.93783031079, 12452.750944980868, 10239.0, 10368.792624147323, 10413.166946644402, 10512.789744205225, 10904.781904362027, 8688.0, 8987.19115279628, 8998.73573959215, 10023.649172278936, 10025.699229023141], "value": 7580.174411469219, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 120.0, 117.0, 117.0, 129.0, 176.0, 158.0, 117.0, 118.0], "value": 128.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 140.0, 119.0, 184.0, 150.0, 145.0, 112.0, 111.0, 140.0, 112.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 213.0, 205.0, 199.0, 199.0, 199.0, 198.0, 197.0, 196.0, 200.0], "value": 201.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 59.0, 84.0, 60.0, 62.0, 61.0, 59.0, 81.0, 65.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 88.0, 73.0, 70.0, 79.0, 108.0, 91.0, 102.0, 122.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 125.0, 90.0, 86.0, 90.0, 86.0, 91.0, 88.0, 92.0, 87.0], "value": 92.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 97.0, 107.0, 99.0, 97.0, 96.0, 96.0, 96.0, 153.0], "value": 103.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 120.0, 143.0, 92.0, 141.0, 144.0, 123.0, 91.0, 94.0, 128.0], "value": 116.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 59.0, 52.0, 74.0, 90.0, 88.0, 90.0, 48.0, 46.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 78.0, 73.0, 86.0, 78.0, 73.0, 72.0, 62.0, 71.0, 88.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 89.0, 75.0, 100.0, 107.0, 113.0, 112.0, 108.0, 100.0], "value": 97.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 143.0, 156.0, 154.0, 159.0, 143.0, 145.0, 146.0, 178.0, 144.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 173.0, 173.0, 175.0, 177.0, 180.0, 244.0, 240.0, 169.0, 172.0], "value": 188.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 71.0, 67.0, 71.0, 68.0, 71.0, 66.0, 69.0, 70.0], "value": 68.9, "unit": "score"}]}]} 22:08:32 INFO - Return code: 0 22:08:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:08:32 ERROR - # TBPL SUCCESS # 22:08:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:08:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:08:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:08:32 INFO - 2016-09-18 22:08:32.574 screenresolution[1681:11066] starting screenresolution argv=screenresolution get 22:08:32 INFO - 2016-09-18 22:08:32.577 screenresolution[1681:11066] Display 0: 1600x1200x32@60 22:08:32 INFO - 2016-09-18 22:08:32.583 screenresolution[1682:11069] starting screenresolution argv=screenresolution list 22:08:32 INFO - Available Modes on Display 0 22:08:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:08:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:08:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:08:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:08:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:08:32 INFO - Intel Iris: 22:08:32 INFO - Chipset Model: Intel Iris 22:08:32 INFO - Type: GPU 22:08:32 INFO - Bus: Built-In 22:08:32 INFO - VRAM (Dynamic, Max): 1536 MB 22:08:32 INFO - Vendor: Intel (0x8086) 22:08:32 INFO - Device ID: 0x0a2e 22:08:32 INFO - Revision ID: 0x0009 22:08:32 INFO - Displays: 22:08:32 INFO - Display: 22:08:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:08:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:08:32 INFO - Display Serial Number: 1600x1200 60 22:08:32 INFO - Main Display: Yes 22:08:32 INFO - Mirror: Off 22:08:32 INFO - Online: Yes 22:08:32 INFO - Rotation: Supported 22:08:32 INFO - Return code: 0 22:08:32 INFO - Running post-action listener: _resource_record_post_action 22:08:32 INFO - [mozharness: 2016-09-19 05:08:32.817870Z] Finished run-tests step (success) 22:08:32 INFO - Running post-run listener: _resource_record_post_run 22:08:32 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 33029120; Write bytes: 709143040; Read time: 310; Write time: 2113 22:08:32 INFO - TinderboxPrint: CPU usage
54.2% 22:08:32 INFO - TinderboxPrint: I/O read bytes / time
33,029,120 / 310 22:08:32 INFO - TinderboxPrint: I/O write bytes / time
709,143,040 / 2,113 22:08:32 INFO - TinderboxPrint: CPU idle
2,220.9 (45.8%) 22:08:32 INFO - TinderboxPrint: CPU system
976.5 (20.2%) 22:08:32 INFO - TinderboxPrint: CPU user
1,648.3 (34.0%) 22:08:32 INFO - TinderboxPrint: Swap in / out
433,618,944 / 0 22:08:32 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 387084800; Write bytes: 381203968; Read time: 29069; Write time: 881 22:08:32 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 32082944; Write bytes: 301601792; Read time: 296; Write time: 1180 22:08:33 INFO - Running post-run listener: _upload_blobber_files 22:08:33 INFO - Blob upload gear active. 22:08:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:08:33 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 22:08:33 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'] 22:08:33 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 22:08:33 INFO - (blobuploader) - INFO - Open directory for files ... 22:08:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:08:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:08:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:34 INFO - (blobuploader) - INFO - Done attempting. 22:08:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:08:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:08:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:35 INFO - (blobuploader) - INFO - Done attempting. 22:08:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:08:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:08:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:38 INFO - (blobuploader) - INFO - Done attempting. 22:08:38 INFO - (blobuploader) - INFO - Iteration through files over. 22:08:38 INFO - Return code: 0 22:08:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:08:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:08:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/903aae9d11e9a1c45c36e62b0054d307840541824dcaf76b493e98d903e88fa547edff4dfb2e5ef10aa47ffd4a429cb4698f04c76ddad9bf39c92ffc18637f80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/06beb245443b74af446527530e2afe00b2f8452187af3f35ff2837f1deb981d36dffc80843858d8cb6ce6affd676f0de734f9c197d095836d628f54e7104b6b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1f9c86882b2078e090bf15f8bfc4927e78487223c1de1114d08010de558e908c275f86ba7b35bc93301a90f3068c04e24801c89f22e109075be24767b3e529e6"} 22:08:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:08:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:08:38 INFO - Contents: 22:08:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/903aae9d11e9a1c45c36e62b0054d307840541824dcaf76b493e98d903e88fa547edff4dfb2e5ef10aa47ffd4a429cb4698f04c76ddad9bf39c92ffc18637f80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/06beb245443b74af446527530e2afe00b2f8452187af3f35ff2837f1deb981d36dffc80843858d8cb6ce6affd676f0de734f9c197d095836d628f54e7104b6b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1f9c86882b2078e090bf15f8bfc4927e78487223c1de1114d08010de558e908c275f86ba7b35bc93301a90f3068c04e24801c89f22e109075be24767b3e529e6"} 22:08:38 INFO - Running post-run listener: copy_logs_to_upload_dir 22:08:38 INFO - Copying logs to upload dir... 22:08:38 INFO - mkdir: /builds/slave/test/build/upload/logs 22:08:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.170664 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-09-18 22:08:38.430678) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-18 22:08:38.434353) ========= 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.OhC7Rv0DTq/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.6UaRA9zTex/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/903aae9d11e9a1c45c36e62b0054d307840541824dcaf76b493e98d903e88fa547edff4dfb2e5ef10aa47ffd4a429cb4698f04c76ddad9bf39c92ffc18637f80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/06beb245443b74af446527530e2afe00b2f8452187af3f35ff2837f1deb981d36dffc80843858d8cb6ce6affd676f0de734f9c197d095836d628f54e7104b6b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1f9c86882b2078e090bf15f8bfc4927e78487223c1de1114d08010de558e908c275f86ba7b35bc93301a90f3068c04e24801c89f22e109075be24767b3e529e6"} build_url:https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011594 build_url: 'https://queue.taskcluster.net/v1/task/dMmPPrfoSDyQYy6isfFA4A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/903aae9d11e9a1c45c36e62b0054d307840541824dcaf76b493e98d903e88fa547edff4dfb2e5ef10aa47ffd4a429cb4698f04c76ddad9bf39c92ffc18637f80", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/06beb245443b74af446527530e2afe00b2f8452187af3f35ff2837f1deb981d36dffc80843858d8cb6ce6affd676f0de734f9c197d095836d628f54e7104b6b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1f9c86882b2078e090bf15f8bfc4927e78487223c1de1114d08010de558e908c275f86ba7b35bc93301a90f3068c04e24801c89f22e109075be24767b3e529e6"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-18 22:08:38.473278) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 22:08:38.473692) ========= 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.OhC7Rv0DTq/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.6UaRA9zTex/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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.005380 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-18 22:08:38.522638) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-18 22:08:38.522996) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-18 22:08:38.523359) ========= ========= Total master_lag: 0.25 =========