builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0247 starttime: 1473792900.26 results: success (0) buildid: 20160913100607 builduid: 602b419078a94c8f998b3a42ec1067a0 revision: 0154cd83212689f344562d3ae83f7c2623e72019 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 11:55:00.260212) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-13 11:55:00.260684) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 11:55:00.261074) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-13 11:55:00.287290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 11:55:00.287605) ========= 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.f53NzvB05X/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.HRVDdEl3k1/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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-13 11:55:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.5M=0s 2016-09-13 11:55:00 (29.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115621 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 11:55:00.426279) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 11:55:00.426633) ========= 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.f53NzvB05X/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.HRVDdEl3k1/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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.025820 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 11:55:00.475069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-13 11:55:00.475457) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 0154cd83212689f344562d3ae83f7c2623e72019 --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 0154cd83212689f344562d3ae83f7c2623e72019 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.f53NzvB05X/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.HRVDdEl3k1/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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-13 11:55:00,561 truncating revision to first 12 chars 2016-09-13 11:55:00,562 Setting DEBUG logging. 2016-09-13 11:55:00,562 attempt 1/10 2016-09-13 11:55:00,562 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/0154cd832126?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-13 11:55:01,811 unpacking tar archive at: autoland-0154cd832126/testing/mozharness/ program finished with exit code 0 elapsedTime=1.517281 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-13 11:55:02.015157) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 11:55:02.015460) ========= script_repo_revision: 0154cd83212689f344562d3ae83f7c2623e72019 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-13 11:55:02.015837) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 11:55:02.016113) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-13 11:55:02.034779) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-13 11:55:02.035189) ========= /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.f53NzvB05X/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.HRVDdEl3k1/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 11:55:02 INFO - MultiFileLogger online at 20160913 11:55:02 in /builds/slave/test 11:55:02 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 11:55:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:55:02 INFO - {'append_to_log': False, 11:55:02 INFO - 'base_work_dir': '/builds/slave/test', 11:55:02 INFO - 'blob_upload_branch': 'Autoland', 11:55:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:55:02 INFO - 'branch': 'Autoland', 11:55:02 INFO - 'buildbot_json_path': 'buildprops.json', 11:55:02 INFO - 'config_files': ('talos/mac_config.py',), 11:55:02 INFO - 'default_actions': ('clobber', 11:55:02 INFO - 'read-buildbot-config', 11:55:02 INFO - 'download-and-extract', 11:55:02 INFO - 'populate-webroot', 11:55:02 INFO - 'create-virtualenv', 11:55:02 INFO - 'install', 11:55:02 INFO - 'run-tests'), 11:55:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:55:02 INFO - 'download_minidump_stackwalk': True, 11:55:02 INFO - 'download_symbols': 'ondemand', 11:55:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:55:02 INFO - 'tooltool.py': '/tools/tooltool.py', 11:55:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:55:02 INFO - '/tools/misc-python/virtualenv.py')}, 11:55:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:55:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:55:02 INFO - 'installer_path': 'installer.exe', 11:55:02 INFO - 'log_level': 'info', 11:55:02 INFO - 'log_name': 'talos', 11:55:02 INFO - 'log_to_console': True, 11:55:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:55:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:55:02 INFO - 'opt_config_files': (), 11:55:02 INFO - 'pip_index': False, 11:55:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:55:02 INFO - 'cmd': ('bash', 11:55:02 INFO - '-c', 11:55:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:55:02 INFO - 'enabled': True, 11:55:02 INFO - 'halt_on_failure': False, 11:55:02 INFO - 'name': 'check_screen_resolution'},), 11:55:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:55:02 INFO - 'cmd': ('bash', 11:55:02 INFO - '-c', 11:55:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:55:02 INFO - 'enabled': True, 11:55:02 INFO - 'halt_on_failure': False, 11:55:02 INFO - 'name': 'check_screen_resolution'},), 11:55:02 INFO - 'run_cmd_checks_enabled': True, 11:55:02 INFO - 'sps_profile': False, 11:55:02 INFO - 'sps_profile_interval': 0, 11:55:02 INFO - 'suite': 'dromaeojs-e10s', 11:55:02 INFO - 'system_bits': '32', 11:55:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:55:02 INFO - 'title': 't-yosemite-r7-0247', 11:55:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:55:02 INFO - 'use_talos_json': True, 11:55:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:55:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:55:02 INFO - 'work_dir': 'build'} 11:55:02 INFO - [mozharness: 2016-09-13 18:55:02.233785Z] Running clobber step. 11:55:02 INFO - Running pre-action listener: _resource_record_pre_action 11:55:02 INFO - Running main action method: clobber 11:55:02 INFO - rmtree: /builds/slave/test/build 11:55:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:55:04 INFO - Running post-action listener: _resource_record_post_action 11:55:04 INFO - [mozharness: 2016-09-13 18:55:04.285331Z] Finished clobber step (success) 11:55:04 INFO - [mozharness: 2016-09-13 18:55:04.285450Z] Running read-buildbot-config step. 11:55:04 INFO - Running pre-action listener: _resource_record_pre_action 11:55:04 INFO - Running main action method: read_buildbot_config 11:55:04 INFO - Using buildbot properties: 11:55:04 INFO - { 11:55:04 INFO - "project": "", 11:55:04 INFO - "product": "firefox", 11:55:04 INFO - "script_repo_revision": "production", 11:55:04 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 11:55:04 INFO - "repository": "", 11:55:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 11:55:04 INFO - "buildid": "20160913100607", 11:55:04 INFO - "pgo_build": "False", 11:55:04 INFO - "basedir": "/builds/slave/test", 11:55:04 INFO - "buildnumber": 17, 11:55:04 INFO - "slavename": "t-yosemite-r7-0247", 11:55:04 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:55:04 INFO - "platform": "yosemite_r7", 11:55:04 INFO - "scheduler": "tests-autoland-macosx64-talos-8-3600", 11:55:04 INFO - "branch": "autoland", 11:55:04 INFO - "repo_path": "integration/autoland", 11:55:04 INFO - "revision": "0154cd83212689f344562d3ae83f7c2623e72019", 11:55:04 INFO - "stage_platform": "macosx64", 11:55:04 INFO - "builduid": "602b419078a94c8f998b3a42ec1067a0", 11:55:04 INFO - "slavebuilddir": "test" 11:55:04 INFO - } 11:55:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:55:04 INFO - Running post-action listener: _resource_record_post_action 11:55:04 INFO - [mozharness: 2016-09-13 18:55:04.288753Z] Finished read-buildbot-config step (success) 11:55:04 INFO - [mozharness: 2016-09-13 18:55:04.288873Z] Running download-and-extract step. 11:55:04 INFO - Running pre-action listener: _resource_record_pre_action 11:55:04 INFO - Running main action method: download_and_extract 11:55:04 INFO - mkdir: /builds/slave/test/build/tests 11:55:04 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')]} 11:55:04 INFO - trying https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:55:04 INFO - Downloading https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/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 11:55:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/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 11:55:05 INFO - Downloaded 1199 bytes. 11:55:05 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:55:05 INFO - Using the following test package requirements: 11:55:05 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:55:05 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:05 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:55:05 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:05 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:55:05 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:05 INFO - u'jsshell-mac.zip'], 11:55:05 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:05 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:55:05 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:55:05 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:05 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:55:05 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:05 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:55:05 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:05 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:55:05 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:55:05 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:55:05 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:55:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:55:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:55:05 INFO - Fetch https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip into memory 11:55:06 INFO - Expected file size: 16424620 11:55:13 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 11:55:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:55:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:55:13 INFO - Fetch https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip into memory 11:55:13 INFO - Expected file size: 16424620 11:55:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:55:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:55:20 INFO - Fetch https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip into memory 11:55:21 INFO - Expected file size: 14414048 11:55:22 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')]} 11:55:22 INFO - trying https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:55:22 INFO - Downloading https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:55:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/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 11:55:25 INFO - Downloaded 111434363 bytes. 11:55:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:55:25 INFO - mkdir: /builds/slave/test/properties 11:55:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:55:25 INFO - Writing to file /builds/slave/test/properties/build_url 11:55:25 INFO - Contents: 11:55:25 INFO - build_url:https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:55:25 INFO - Running post-action listener: _resource_record_post_action 11:55:25 INFO - Running post-action listener: set_extra_try_arguments 11:55:25 INFO - [mozharness: 2016-09-13 18:55:25.821413Z] Finished download-and-extract step (success) 11:55:25 INFO - [mozharness: 2016-09-13 18:55:25.821557Z] Running populate-webroot step. 11:55:25 INFO - Running pre-action listener: _resource_record_pre_action 11:55:25 INFO - Running main action method: populate_webroot 11:55:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:55:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:55:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:55:25 INFO - '--tppagecycles', 11:55:25 INFO - '7'], 11:55:25 INFO - 'tests': ['tsvgm']}}, 11:55:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:55:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:55:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:55:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:55:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:55:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:55:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:25 INFO - 'talos_options': ['--disable-e10s'], 11:55:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:55:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:55:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:25 INFO - 'talos_options': ['--disable-e10s'], 11:55:25 INFO - 'tests': ['damp', 'tps']}, 11:55:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:25 INFO - 'tests': ['damp', 'tps']}, 11:55:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:55:25 INFO - 'tests': ['dromaeo_dom']}, 11:55:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:55:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:55:25 INFO - 'tests': ['basic_compositor_video']}, 11:55:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:55:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:55:25 INFO - 'tests': ['a11yr', 11:55:25 INFO - 'ts_paint', 11:55:25 INFO - 'tpaint', 11:55:25 INFO - 'sessionrestore', 11:55:25 INFO - 'sessionrestore_no_auto_restore', 11:55:25 INFO - 'tabpaint']}, 11:55:25 INFO - 'other-e10s': {'tests': ['a11yr', 11:55:25 INFO - 'ts_paint', 11:55:25 INFO - 'tpaint', 11:55:25 INFO - 'sessionrestore', 11:55:25 INFO - 'sessionrestore_no_auto_restore', 11:55:25 INFO - 'tabpaint']}, 11:55:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:55:25 INFO - 'ts_paint', 11:55:25 INFO - 'tpaint', 11:55:25 INFO - 'sessionrestore', 11:55:25 INFO - 'sessionrestore_no_auto_restore', 11:55:25 INFO - 'tabpaint']}, 11:55:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:55:25 INFO - 'ts_paint', 11:55:25 INFO - 'tpaint', 11:55:25 INFO - 'sessionrestore', 11:55:25 INFO - 'sessionrestore_no_auto_restore', 11:55:25 INFO - 'tabpaint']}, 11:55:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:55:25 INFO - 'tests': ['a11yr', 11:55:25 INFO - 'ts_paint', 11:55:25 INFO - 'tpaint', 11:55:25 INFO - 'sessionrestore', 11:55:25 INFO - 'sessionrestore_no_auto_restore', 11:55:25 INFO - 'tabpaint']}, 11:55:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:55:25 INFO - 'tests': ['a11yr', 11:55:25 INFO - 'ts_paint', 11:55:25 INFO - 'tpaint', 11:55:25 INFO - 'sessionrestore', 11:55:25 INFO - 'sessionrestore_no_auto_restore', 11:55:25 INFO - 'tabpaint']}, 11:55:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:55:25 INFO - 'tests': ['tsvgx', 11:55:25 INFO - 'tsvgr_opacity', 11:55:25 INFO - 'tart', 11:55:25 INFO - 'tscrollx', 11:55:25 INFO - 'cart']}, 11:55:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:55:25 INFO - 'tsvgr_opacity', 11:55:25 INFO - 'tart', 11:55:25 INFO - 'tscrollx', 11:55:25 INFO - 'cart']}, 11:55:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:25 INFO - 'talos_options': ['--disable-e10s'], 11:55:25 INFO - 'tests': ['tp5o']}, 11:55:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:25 INFO - 'tests': ['tp5o']}, 11:55:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:25 INFO - 'talos_options': ['--disable-e10s', 11:55:25 INFO - '--xperf_path', 11:55:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:55:25 INFO - 'tests': ['tp5n']}, 11:55:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:55:25 INFO - 'talos_options': ['--xperf_path', 11:55:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:55:25 INFO - 'tests': ['tp5n']}}, 11:55:25 INFO - 'talos.zip': {'path': '', 11:55:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:55:25 INFO - Running post-action listener: _resource_record_post_action 11:55:25 INFO - [mozharness: 2016-09-13 18:55:25.840104Z] Finished populate-webroot step (success) 11:55:25 INFO - [mozharness: 2016-09-13 18:55:25.840206Z] Running create-virtualenv step. 11:55:25 INFO - Running pre-action listener: _resource_record_pre_action 11:55:25 INFO - Running main action method: create_virtualenv 11:55:25 INFO - Creating virtualenv /builds/slave/test/build/venv 11:55:25 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 11:55:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:55:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:55:25 INFO - Using real prefix '/tools/python27' 11:55:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:55:26 INFO - Installing distribute.............................................................................................................................................................................................done. 11:55:29 INFO - Installing pip.................done. 11:55:29 INFO - Return code: 0 11:55:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:55:29 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')]} 11:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:29 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')]} 11:55:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:29 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 0x10da1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba73c7bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d830d30>, '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 0x10d656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d828b20>, '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.f53NzvB05X/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.HRVDdEl3k1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 11:55:29 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 11:55:29 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 11:55:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f53NzvB05X/Render', 11:55:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:29 INFO - 'HOME': '/Users/cltbld', 11:55:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:29 INFO - 'LOGNAME': 'cltbld', 11:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:29 INFO - 'MOZ_NO_REMOTE': '1', 11:55:29 INFO - 'NO_EM_RESTART': '1', 11:55:29 INFO - 'PAGER': '/bin/cat', 11:55:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:29 INFO - 'PWD': '/builds/slave/test', 11:55:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:29 INFO - 'SHELL': '/bin/bash', 11:55:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HRVDdEl3k1/Listeners', 11:55:29 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 11:55:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:29 INFO - 'USER': 'cltbld', 11:55:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:29 INFO - 'XPC_FLAGS': '0x0', 11:55:29 INFO - 'XPC_SERVICE_NAME': '0', 11:55:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:29 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 11:55:29 INFO - Cleaning up... 11:55:29 INFO - Return code: 0 11:55:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:55:29 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')]} 11:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:29 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')]} 11:55:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:29 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 0x10da1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba73c7bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d830d30>, '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 0x10d656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d828b20>, '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.f53NzvB05X/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.HRVDdEl3k1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 11:55:29 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 11:55:29 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 11:55:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f53NzvB05X/Render', 11:55:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:29 INFO - 'HOME': '/Users/cltbld', 11:55:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:29 INFO - 'LOGNAME': 'cltbld', 11:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:29 INFO - 'MOZ_NO_REMOTE': '1', 11:55:29 INFO - 'NO_EM_RESTART': '1', 11:55:29 INFO - 'PAGER': '/bin/cat', 11:55:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:29 INFO - 'PWD': '/builds/slave/test', 11:55:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:29 INFO - 'SHELL': '/bin/bash', 11:55:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HRVDdEl3k1/Listeners', 11:55:29 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 11:55:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:29 INFO - 'USER': 'cltbld', 11:55:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:29 INFO - 'XPC_FLAGS': '0x0', 11:55:29 INFO - 'XPC_SERVICE_NAME': '0', 11:55:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:30 INFO - Downloading/unpacking psutil>=3.1.1 11:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:55:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:55:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:55:33 INFO - Installing collected packages: psutil 11:55:33 INFO - Running setup.py install for psutil 11:55:33 INFO - building 'psutil._psutil_osx' extension 11:55:33 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 11:55:34 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 11:55:34 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 11:55:34 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 11:55:34 INFO - building 'psutil._psutil_posix' extension 11:55:34 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 11:55:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:55:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:55:34 INFO - ^ 11:55:34 INFO - 1 warning generated. 11:55:34 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 11:55:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:55:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:55:34 INFO - Successfully installed psutil 11:55:34 INFO - Cleaning up... 11:55:34 INFO - Return code: 0 11:55:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:55:34 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')]} 11:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:34 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')]} 11:55:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba73c7bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d830d30>, '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 0x10d656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d828b20>, '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.f53NzvB05X/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.HRVDdEl3k1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 11:55:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:55:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:55:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f53NzvB05X/Render', 11:55:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:34 INFO - 'HOME': '/Users/cltbld', 11:55:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:34 INFO - 'LOGNAME': 'cltbld', 11:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:34 INFO - 'MOZ_NO_REMOTE': '1', 11:55:34 INFO - 'NO_EM_RESTART': '1', 11:55:34 INFO - 'PAGER': '/bin/cat', 11:55:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:34 INFO - 'PWD': '/builds/slave/test', 11:55:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:34 INFO - 'SHELL': '/bin/bash', 11:55:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HRVDdEl3k1/Listeners', 11:55:34 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 11:55:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:34 INFO - 'USER': 'cltbld', 11:55:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:34 INFO - 'XPC_FLAGS': '0x0', 11:55:34 INFO - 'XPC_SERVICE_NAME': '0', 11:55:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:55:34 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 11:55:34 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 11:55:34 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 11:55:34 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 11:55:34 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 11:55:34 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 11:55:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:55:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:55:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:55:37 INFO - Installing collected packages: mozsystemmonitor 11:55:37 INFO - Running setup.py install for mozsystemmonitor 11:55:37 INFO - Successfully installed mozsystemmonitor 11:55:37 INFO - Cleaning up... 11:55:37 INFO - Return code: 0 11:55:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10da1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba73c7bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d830d30>, '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 0x10d656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d828b20>, '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.f53NzvB05X/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.HRVDdEl3k1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 11:55:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:55:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f53NzvB05X/Render', 11:55:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:37 INFO - 'HOME': '/Users/cltbld', 11:55:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:37 INFO - 'LOGNAME': 'cltbld', 11:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:37 INFO - 'MOZ_NO_REMOTE': '1', 11:55:37 INFO - 'NO_EM_RESTART': '1', 11:55:37 INFO - 'PAGER': '/bin/cat', 11:55:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:37 INFO - 'PWD': '/builds/slave/test', 11:55:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:37 INFO - 'SHELL': '/bin/bash', 11:55:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HRVDdEl3k1/Listeners', 11:55:37 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 11:55:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:37 INFO - 'USER': 'cltbld', 11:55:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:37 INFO - 'XPC_FLAGS': '0x0', 11:55:37 INFO - 'XPC_SERVICE_NAME': '0', 11:55:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:37 INFO - Downloading/unpacking jsonschema==2.5.1 11:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:55:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:40 INFO - Downloading functools32-3.2.3-2.tar.gz 11:55:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:55:40 INFO - warning: no files found matching '*.txt' 11:55:40 INFO - no previously-included directories found matching 'build' 11:55:40 INFO - no previously-included directories found matching 'dist' 11:55:40 INFO - no previously-included directories found matching '.git*' 11:55:40 INFO - Installing collected packages: jsonschema, functools32 11:55:40 INFO - Running setup.py install for functools32 11:55:40 INFO - warning: no files found matching '*.txt' 11:55:40 INFO - no previously-included directories found matching 'build' 11:55:40 INFO - no previously-included directories found matching 'dist' 11:55:40 INFO - no previously-included directories found matching '.git*' 11:55:41 INFO - Successfully installed jsonschema functools32 11:55:41 INFO - Cleaning up... 11:55:41 INFO - Return code: 0 11:55:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:41 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 0x10da1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba73c7bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d830d30>, '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 0x10d656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d828b20>, '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.f53NzvB05X/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.HRVDdEl3k1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 11:55:41 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 11:55:41 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 11:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f53NzvB05X/Render', 11:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:41 INFO - 'HOME': '/Users/cltbld', 11:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:41 INFO - 'LOGNAME': 'cltbld', 11:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:41 INFO - 'MOZ_NO_REMOTE': '1', 11:55:41 INFO - 'NO_EM_RESTART': '1', 11:55:41 INFO - 'PAGER': '/bin/cat', 11:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:41 INFO - 'PWD': '/builds/slave/test', 11:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:41 INFO - 'SHELL': '/bin/bash', 11:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HRVDdEl3k1/Listeners', 11:55:41 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 11:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:41 INFO - 'USER': 'cltbld', 11:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:41 INFO - 'XPC_FLAGS': '0x0', 11:55:41 INFO - 'XPC_SERVICE_NAME': '0', 11:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:55:41 INFO - Cleaning up... 11:55:41 INFO - Return code: 0 11:55:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:41 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 0x10da1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba73c7bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d830d30>, '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 0x10d656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d828b20>, '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.f53NzvB05X/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.HRVDdEl3k1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 11:55:41 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 11:55:41 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 11:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f53NzvB05X/Render', 11:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:41 INFO - 'HOME': '/Users/cltbld', 11:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:41 INFO - 'LOGNAME': 'cltbld', 11:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:41 INFO - 'MOZ_NO_REMOTE': '1', 11:55:41 INFO - 'NO_EM_RESTART': '1', 11:55:41 INFO - 'PAGER': '/bin/cat', 11:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:41 INFO - 'PWD': '/builds/slave/test', 11:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:41 INFO - 'SHELL': '/bin/bash', 11:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HRVDdEl3k1/Listeners', 11:55:41 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 11:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:41 INFO - 'USER': 'cltbld', 11:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:41 INFO - 'XPC_FLAGS': '0x0', 11:55:41 INFO - 'XPC_SERVICE_NAME': '0', 11:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:41 INFO - Downloading/unpacking blobuploader==1.2.4 11:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:55:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:55:44 INFO - Downloading blobuploader-1.2.4.tar.gz 11:55:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:55:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:55:44 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 11:55:44 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 11:55:44 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 11:55:44 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 11:55:44 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 11:55:44 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 11:55:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:55:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:55:44 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 11:55:44 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 11:55:44 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 11:55:44 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 11:55:44 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 11:55:44 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 11:55:45 INFO - Downloading docopt-0.6.1.tar.gz 11:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:55:45 INFO - Installing collected packages: blobuploader, requests, docopt 11:55:45 INFO - Running setup.py install for blobuploader 11:55:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:55:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:55:45 INFO - Running setup.py install for requests 11:55:46 INFO - Running setup.py install for docopt 11:55:46 INFO - Successfully installed blobuploader requests docopt 11:55:46 INFO - Cleaning up... 11:55:46 INFO - Return code: 0 11:55:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55: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')]} 11:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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')]} 11:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:46 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 0x10da1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba73c7bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d830d30>, '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 0x10d656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d828b20>, '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.f53NzvB05X/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.HRVDdEl3k1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 11:55:46 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 11:55:46 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 11:55:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f53NzvB05X/Render', 11:55:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:46 INFO - 'HOME': '/Users/cltbld', 11:55:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:46 INFO - 'LOGNAME': 'cltbld', 11:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:46 INFO - 'MOZ_NO_REMOTE': '1', 11:55:46 INFO - 'NO_EM_RESTART': '1', 11:55:46 INFO - 'PAGER': '/bin/cat', 11:55:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:46 INFO - 'PWD': '/builds/slave/test', 11:55:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:46 INFO - 'SHELL': '/bin/bash', 11:55:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HRVDdEl3k1/Listeners', 11:55:46 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 11:55:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:46 INFO - 'USER': 'cltbld', 11:55:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:46 INFO - 'XPC_FLAGS': '0x0', 11:55:46 INFO - 'XPC_SERVICE_NAME': '0', 11:55:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:46 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-egqlnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:46 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-JstmXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:46 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-fPIwky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:46 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-eJUALB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:47 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-RqzEKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:47 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-1HkWgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:47 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-onl_Dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:47 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-W1e9c5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:47 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-FikFNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:47 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-38UgF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:47 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-uQnKsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:47 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-mnzWD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:47 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-PweiAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:48 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-9XT7zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:48 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-mBYRIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:48 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-BkjVjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:48 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-yMb1ZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:55:48 INFO - Running setup.py install for manifestparser 11:55:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:55:48 INFO - Running setup.py install for mozcrash 11:55:48 INFO - Running setup.py install for mozdebug 11:55:48 INFO - Running setup.py install for mozdevice 11:55:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:55:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:55:49 INFO - Running setup.py install for mozfile 11:55:49 INFO - Running setup.py install for mozhttpd 11:55:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:55:49 INFO - Running setup.py install for mozinfo 11:55:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:55:49 INFO - Running setup.py install for mozInstall 11:55:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:55:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:55:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:55:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:55:49 INFO - Running setup.py install for mozleak 11:55:49 INFO - Running setup.py install for mozlog 11:55:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:55:49 INFO - Running setup.py install for moznetwork 11:55:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:55:50 INFO - Running setup.py install for mozprocess 11:55:50 INFO - Running setup.py install for mozprofile 11:55:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:55:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:55:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:55:50 INFO - Running setup.py install for mozrunner 11:55:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:55:50 INFO - Running setup.py install for mozscreenshot 11:55:50 INFO - Running setup.py install for moztest 11:55:50 INFO - Running setup.py install for mozversion 11:55:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:55:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:55:50 INFO - Cleaning up... 11:55:50 INFO - Return code: 0 11:55:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55:50 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')]} 11:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:50 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')]} 11:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:50 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 0x10da1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba73c7bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d830d30>, '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 0x10d656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d828b20>, '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.f53NzvB05X/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.HRVDdEl3k1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 11:55:50 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 11:55:50 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 11:55:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f53NzvB05X/Render', 11:55:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:50 INFO - 'HOME': '/Users/cltbld', 11:55:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:50 INFO - 'LOGNAME': 'cltbld', 11:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:50 INFO - 'MOZ_NO_REMOTE': '1', 11:55:50 INFO - 'NO_EM_RESTART': '1', 11:55:50 INFO - 'PAGER': '/bin/cat', 11:55:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:50 INFO - 'PWD': '/builds/slave/test', 11:55:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:50 INFO - 'SHELL': '/bin/bash', 11:55:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HRVDdEl3k1/Listeners', 11:55:50 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 11:55:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:50 INFO - 'USER': 'cltbld', 11:55:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:50 INFO - 'XPC_FLAGS': '0x0', 11:55:50 INFO - 'XPC_SERVICE_NAME': '0', 11:55:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:55:51 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-zaIOvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:55:51 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)) 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:55:51 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-2uxegR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:55:51 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)) 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:55:51 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-qD4edb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:55:51 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)) 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:55:51 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-4lVhoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:55:51 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)) 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:55:51 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-tEHNTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:55:51 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)) 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:55:51 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-YsGtuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:55:51 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)) 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:55:51 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-kUnyGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:55:51 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)) 11:55:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:55:51 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-n8gNPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:55:52 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)) 11:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:55:52 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-apFmvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:55:52 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)) 11:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:55:52 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-Nrsynp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:55:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:55:52 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-e9Owei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:55:52 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)) 11:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:55:52 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-C_anLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:55:52 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)) 11:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:55:52 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-SHMZoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:55:52 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)) 11:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:55:52 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-OhHYXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:55:52 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)) 11:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:52 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-qYiAWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:55:52 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)) 11:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:55:52 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-7dWzD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:55:52 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)) 11:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:55:52 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-0eFtMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:55:53 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)) 11:55:53 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)) 11:55:53 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)) 11:55:53 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)) 11:55:53 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)) 11:55:53 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)) 11:55:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:55:53 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 11:55:53 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 11:55:53 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 11:55:53 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 11:55:53 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 11:55:53 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 11:55:55 INFO - Downloading blessings-1.6.tar.gz 11:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:55:55 INFO - Installing collected packages: blessings 11:55:55 INFO - Running setup.py install for blessings 11:55:55 INFO - Successfully installed blessings 11:55:55 INFO - Cleaning up... 11:55:55 INFO - Return code: 0 11:55:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:55:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:56 INFO - Reading from file tmpfile_stdout 11:55:56 INFO - Current package versions: 11:55:56 INFO - blessings == 1.6 11:55:56 INFO - blobuploader == 1.2.4 11:55:56 INFO - docopt == 0.6.1 11:55:56 INFO - functools32 == 3.2.3-2 11:55:56 INFO - jsonschema == 2.5.1 11:55:56 INFO - manifestparser == 1.1 11:55:56 INFO - mozInstall == 1.12 11:55:56 INFO - mozcrash == 0.17 11:55:56 INFO - mozdebug == 0.1 11:55:56 INFO - mozdevice == 0.48 11:55:56 INFO - mozfile == 1.2 11:55:56 INFO - mozhttpd == 0.7 11:55:56 INFO - mozinfo == 0.9 11:55:56 INFO - mozleak == 0.1 11:55:56 INFO - mozlog == 3.3 11:55:56 INFO - moznetwork == 0.27 11:55:56 INFO - mozprocess == 0.23 11:55:56 INFO - mozprofile == 0.28 11:55:56 INFO - mozrunner == 6.12 11:55:56 INFO - mozscreenshot == 0.1 11:55:56 INFO - mozsystemmonitor == 0.3 11:55:56 INFO - moztest == 0.7 11:55:56 INFO - mozversion == 1.4 11:55:56 INFO - psutil == 3.1.1 11:55:56 INFO - requests == 1.2.3 11:55:56 INFO - wsgiref == 0.1.2 11:55:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:55: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')]} 11:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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')]} 11:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:56 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 0x10da1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba73c7bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d830d30>, '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 0x10d656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d828b20>, '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.f53NzvB05X/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.HRVDdEl3k1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 11:55:56 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 11:55:56 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 11:55:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f53NzvB05X/Render', 11:55:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:56 INFO - 'HOME': '/Users/cltbld', 11:55:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:56 INFO - 'LOGNAME': 'cltbld', 11:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:56 INFO - 'MOZ_NO_REMOTE': '1', 11:55:56 INFO - 'NO_EM_RESTART': '1', 11:55:56 INFO - 'PAGER': '/bin/cat', 11:55:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:56 INFO - 'PWD': '/builds/slave/test', 11:55:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:56 INFO - 'SHELL': '/bin/bash', 11:55:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HRVDdEl3k1/Listeners', 11:55:56 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 11:55:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:56 INFO - 'USER': 'cltbld', 11:55:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:56 INFO - 'XPC_FLAGS': '0x0', 11:55:56 INFO - 'XPC_SERVICE_NAME': '0', 11:55:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:56 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)) 11:55:56 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)) 11:55:56 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)) 11:55:56 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)) 11:55:56 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)) 11:55:56 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)) 11:55:56 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)) 11:55:56 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)) 11:55:56 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)) 11:55:56 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)) 11:55:56 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)) 11:55:56 INFO - Cleaning up... 11:55:56 INFO - Return code: 0 11:55:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:55: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')]} 11:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55: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')]} 11:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:55:56 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 0x10da1c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d992570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba73c7bb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d830d30>, '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 0x10d656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d828b20>, '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.f53NzvB05X/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.HRVDdEl3k1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 11:55:56 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 11:55:56 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 11:55:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f53NzvB05X/Render', 11:55:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:55:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:55:56 INFO - 'HOME': '/Users/cltbld', 11:55:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:55:56 INFO - 'LOGNAME': 'cltbld', 11:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:55:56 INFO - 'MOZ_NO_REMOTE': '1', 11:55:56 INFO - 'NO_EM_RESTART': '1', 11:55:56 INFO - 'PAGER': '/bin/cat', 11:55:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:55:56 INFO - 'PWD': '/builds/slave/test', 11:55:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:55:56 INFO - 'SHELL': '/bin/bash', 11:55:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HRVDdEl3k1/Listeners', 11:55:56 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 11:55:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:55:56 INFO - 'USER': 'cltbld', 11:55:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:55:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:55:56 INFO - 'XPC_FLAGS': '0x0', 11:55:56 INFO - 'XPC_SERVICE_NAME': '0', 11:55:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:55:56 INFO - Cleaning up... 11:55:56 INFO - Return code: 0 11:55:56 INFO - Running post-action listener: _resource_record_post_action 11:55:56 INFO - Running post-action listener: _start_resource_monitoring 11:55:56 INFO - Starting resource monitoring. 11:55:56 INFO - [mozharness: 2016-09-13 18:55:56.761705Z] Finished create-virtualenv step (success) 11:55:56 INFO - [mozharness: 2016-09-13 18:55:56.762742Z] Running install step. 11:55:56 INFO - Running pre-action listener: _resource_record_pre_action 11:55:56 INFO - Running main action method: install 11:55:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:55:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:55:57 INFO - Reading from file tmpfile_stdout 11:55:57 INFO - Detecting whether we're running mozinstall >=1.0... 11:55:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:55:57 INFO - Reading from file tmpfile_stdout 11:55:57 INFO - Output received: 11:55:57 INFO - Usage: mozinstall [options] installer 11:55:57 INFO - Options: 11:55:57 INFO - -h, --help show this help message and exit 11:55:57 INFO - -d DEST, --destination=DEST 11:55:57 INFO - Directory to install application into. [default: 11:55:57 INFO - "/builds/slave/test"] 11:55:57 INFO - --app=APP Application being installed. [default: firefox] 11:55:57 INFO - mkdir: /builds/slave/test/build/application 11:55:57 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'] 11:55:57 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 11:56:31 INFO - Reading from file tmpfile_stdout 11:56:31 INFO - Output received: 11:56:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:56:31 INFO - Running post-action listener: _resource_record_post_action 11:56:31 INFO - [mozharness: 2016-09-13 18:56:31.117181Z] Finished install step (success) 11:56:31 INFO - [mozharness: 2016-09-13 18:56:31.117330Z] Running run-tests step. 11:56:31 INFO - Running pre-action listener: _resource_record_pre_action 11:56:31 INFO - Running main action method: run_tests 11:56:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:56:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:56:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:56:31 INFO - 2016-09-13 11:56:31.131 screenresolution[1642:7549] starting screenresolution argv=screenresolution get 11:56:31 INFO - 2016-09-13 11:56:31.134 screenresolution[1642:7549] Display 0: 1600x1200x32@60 11:56:31 INFO - 2016-09-13 11:56:31.140 screenresolution[1643:7551] starting screenresolution argv=screenresolution list 11:56:31 INFO - Available Modes on Display 0 11:56:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:56:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:56:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:56:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:56:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:56:31 INFO - Intel Iris: 11:56:31 INFO - Chipset Model: Intel Iris 11:56:31 INFO - Type: GPU 11:56:31 INFO - Bus: Built-In 11:56:31 INFO - VRAM (Dynamic, Max): 1536 MB 11:56:31 INFO - Vendor: Intel (0x8086) 11:56:31 INFO - Device ID: 0x0a2e 11:56:31 INFO - Revision ID: 0x0009 11:56:31 INFO - Displays: 11:56:31 INFO - Display: 11:56:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:56:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:56:31 INFO - Display Serial Number: 1600x1200 60 11:56:31 INFO - Main Display: Yes 11:56:31 INFO - Mirror: Off 11:56:31 INFO - Online: Yes 11:56:31 INFO - Rotation: Supported 11:56:31 INFO - Return code: 0 11:56:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:56:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:56:31 INFO - Python 2.7.3 11:56:31 INFO - Return code: 0 11:56:31 INFO - grabbing minidump binary from tooltool 11:56:31 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')]} 11:56:31 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 0x10d830d30>, '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 0x10d656db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d828b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:56:31 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 11:56:31 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 11:56:31 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 11:56:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:56:31 INFO - Return code: 0 11:56:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:56:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:56:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:56:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:56:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:56:31 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/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0247', '--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 11:56:31 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/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0247 --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 11:56:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.f53NzvB05X/Render', 11:56:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:56:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:56:31 INFO - 'HOME': '/Users/cltbld', 11:56:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:56:31 INFO - 'LOGNAME': 'cltbld', 11:56:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:56:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:56:31 INFO - 'MOZ_NO_REMOTE': '1', 11:56:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:56:31 INFO - 'NO_EM_RESTART': '1', 11:56:31 INFO - 'PAGER': '/bin/cat', 11:56:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:56:31 INFO - 'PWD': '/builds/slave/test', 11:56:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:56:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:56:31 INFO - 'SHELL': '/bin/bash', 11:56:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HRVDdEl3k1/Listeners', 11:56:31 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 11:56:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:56:31 INFO - 'USER': 'cltbld', 11:56:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:56:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:56:31 INFO - 'XPC_FLAGS': '0x0', 11:56:31 INFO - 'XPC_SERVICE_NAME': '0', 11:56:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:56:31 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/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0247', '--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 11:56:31 INFO - mozversion application_buildid: 20160913100607 11:56:31 INFO - mozversion application_changeset: 0154cd83212689f344562d3ae83f7c2623e72019 11:56:31 INFO - mozversion application_display_name: Nightly 11:56:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:56:31 INFO - mozversion application_name: Firefox 11:56:31 INFO - mozversion application_remotingname: firefox 11:56:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:56:31 INFO - mozversion application_vendor: Mozilla 11:56:31 INFO - mozversion application_version: 51.0a1 11:56:31 INFO - mozversion platform_buildid: 20160913100607 11:56:31 INFO - mozversion platform_changeset: 0154cd83212689f344562d3ae83f7c2623e72019 11:56:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:56:31 INFO - mozversion platform_version: 51.0a1 11:56:31 INFO - using testdate: 1473792991 11:56:31 INFO - actual date: 1473792991 11:56:31 INFO - starting webserver on 'localhost:49266' 11:56:31 INFO - SUITE-START | Running 2 tests 11:56:31 INFO - TEST-START | dromaeo_css 11:56:31 INFO - operating with platform_type : mac_ 11:56:31 INFO - Initialising browser for dromaeo_css test... 11:56:31 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmpNtyXTT/profile http://localhost:49266/getInfo.html) 11:56:34 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 11:56:34 INFO - PROCESS | 1653 | colorDepth:24 11:56:34 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 11:56:34 INFO - PROCESS | 1653 | __metrics 11:56:34 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3000: TypeError: this.tabs is undefined 11:56:35 INFO - TEST-INFO | 1653: exit 0 11:56:35 INFO - Browser initialized. 11:56:35 INFO - Running cycle 1/1 for dromaeo_css test... 11:56:35 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmpNtyXTT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:56:47 INFO - PROCESS | 1656 | RSS: Main: 240082944 11:56:47 INFO - PROCESS | 1656 | 11:57:37 INFO - PROCESS | 1656 | 1473793057209 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] 11:59:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 11:59:50 INFO - PROCESS | 1656 | RSS: Main: 256954368 11:59:50 INFO - PROCESS | 1656 | 12:02:52 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 12:02:53 INFO - PROCESS | 1656 | RSS: Main: 269955072 12:02:53 INFO - PROCESS | 1656 | 12:05:55 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 12:05:55 INFO - PROCESS | 1656 | RSS: Main: 269430784 12:05:55 INFO - PROCESS | 1656 | 12:08:57 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 12:08:58 INFO - PROCESS | 1656 | RSS: Main: 268873728 12:08:58 INFO - PROCESS | 1656 | 12:12:00 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 12:12:01 INFO - PROCESS | 1656 | RSS: Main: 274194432 12:12:01 INFO - PROCESS | 1656 | 12:15:04 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 12:15:04 INFO - PROCESS | 1656 | RSS: Main: 278085632 12:15:04 INFO - PROCESS | 1656 | 12:15:04 INFO - PROCESS | 1656 | __start_tp_report 12:15:04 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 12:15:04 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 12:15:04 INFO - PROCESS | 1656 | |i|pagename|runs| 12:15:04 INFO - PROCESS | 1656 | |0;dojo.html;2832.9433411331765;3385.59372875255;3425.7773244739105;3430.313937212558;3465.98267008665;5284.709340986245;5650.915236271459;5705.172749951254;5740.397258287882;5741.282339707536;5689.975804355215;5788.971055144719;5799.217105690731;5833.212516310296;5898.026825573776;5205.27126202332;5219.373675158986;5319.840404787863;5398.703071331075;5398.838034858941;5365.463453654643;5422.40353561108;5431.375391829931;5439.945600544003;5470.9452905471035;5193.662411943212;5199.168133098686;5235.188545775411;5308.681479111266;5329.094054010808;5231.843044708627;5314.787408503656;5330.706811125387;5344.1716533936915;5345.599080069011;5247.081760691864;5262.447443018466;5276.234945932818;5302.602304827154;5382.0043291991105;5678.574106941955;5706.201131841545;5884.6469211847;5901.262342207224;5902.409759024106;6190.133381326618;6197.845053873644;6253.656048917308;6280.340564240781;6291.528135389818;5215.608829337815;5856.857912707023;6300.369963003709;6312.084747711602;6315.684215789192;5696.401877802812;5751.252337196138;5941.821745347646;5963.642181469126;5969.313528944183;6164.753409863555;6317.557770955989;6341.112244285804;6352.110704501373;6422.45409140219;6190.783322583688;6245.000799871998;6247.219097612799;6256.843578910563;6264.5301602379095;6167.383261673796;6308.968455157695;6321.178246827975;6321.620702757849;6324.33594472583;6121.908171377433;6204.193454850931;6240.31356550779;6270.341614130451;6270.435660790459;6184.5980011299125;6230.06549017651;6246.344133865879;6252;6265.310815810257;3810.866619668354;4554.180247555406;4608.907821843612;5023.995200959823;5046.4953504649975;3635.4365073413665;4205.285101532747;4378.737275763465;4381.737095774264;4486.5962063414445;4851.417829860439;5623.931453023994;5802.303723553201;5877.471027607536;5916.792912248051;6214.782482613177;6254.6872656366995;6256.155419018465;6278;6305.369463053658;5668.178114173422;5759.827205183851;5854.414558544111;5886.293644762656;5944.940550594525;5526.972365138148;5529.225908372831;5531.778728850882;5533.1976863354585;5573.359063707726;6502.804915852532;6509.576877502947;6526.967365163144;6546.410823025855;6608.768693095719;6180.969095154495;6181.258249010148;6232.626042437469;6288.874222515616;6294.905576416266;6347.682615869096;6465.676716164267;6466.805995820133;6476.6114033158165;6495.415412612888;6239.594426362272;6256.593321434092;6260.154879091265;6268.27914789805;6279.843003924939;5826.271716035496;6182.505399568114;6254.249490061222;6258.843528911813;6282.026285925689;6126.945200426759;6190.845228869314;6209;6299.055141728777;6306.747730090929;6242;6259;6272.247330320391;6276.1213430118905;6283.120363149072;5906.793262235973;5935.821925342247;6041.879162416639;6105;6157.199564056823;6187.628742275478;6267.717952692231;6270.310265870842;6274.341194174546;6278.843028924313;5838.766449341979;6024.698765061642;6066.545009124422;6082.026875699867;6114.6942652868065 12:15:04 INFO - PROCESS | 1656 | |1;ext.html;427.5083653798132;535.4377903201637;538.3593523706791;541.3341589844493;556.1241045353567;39069;40767.59232407675;40786.388204176925;40821.3876791848;40897.79551102248;42153.94615134623;42641.786791066;42716.78641606795;42748.57251427485;42752.931176720595;9883.703488895326;9939.403635781877;9955.10404063634;9971.950140249288;10113.190944724405;9830.311878168532;9850.162736167435;9853.162481189072;9944.950275248613;9981.850272245922;8030.558319292437;8869;8984.416012959136;9388.624455021825;9566.043395660414;8872;8908.97546782122;9279.907200927972;9898.455584942825;9951.552180151839;9819.06718861707;9866.309358344919;9869;9877.506124693737;9890.604375824958;40050.59949400498;40595.391069133984;40870.79564602158;40920.77237682845;41141;3025.3646734185845;3248.252901832568;3694.3534881395917;3702.407614781649;3972.503437070366;30716.692833071607;30862.22844428885;31547;31554.526682099786;31571.84214078938;2973.4647763402577;3140.905772826819;3341.548890899746;3353.5808023997;3372.932541349184;356955;361109;362234;362741;362915.3376196155;58455.415445845;58804.70597646984;58885.705571472725;58925.70537147287;59168.40831591715;60096.699516502136;60178.69910650506;60304.39695603075;60496.79006419935;60540;15928.840711592737;16088.276027578788;16171.272292746855;16187.271572779253;16221.918890405472;12432;12465;12623.36883155857;12662.683432914067;12673.556425525247;15762.290696918666;16096.919515402347;16228.432004879773;16296.022238665719;16303.510894673178;6573.441257493071;6580.86838263232;6658.467322614276;6667.333266673294;6694.263631000586;812.8496228197803;854.9871751923727;858.9012263589642;901.5582364641278;986.3440811860177;27541.622918853976;29413.55879661764;29646.962356317425;29682.703172967995;30338.241543961136;1004.2618675273668;1005.4520286443906;1010.2120346130031;1066.7599790047332;1145;14696.897732670093;15287.006344587566;15380.615484612974;15467.381304747909;15628.3748650055;675988;677307;681457;682523;682578;56138.15792763112;56449;57360;57409.425905740405;57916.55208619818;1035;1322.6296636941672;1336.0981337597277;1344.3883033220056;1348.8583698711493;28917.277068073465;29128.12615621535;29294.26764330909;29808.85095574508;29809.78328792496;48565;49350.50649493459;49375.50624493709;49426.25860612166;49460;493606;493663;495742;495790;496604;22167;26033.479330412905;26265.737342627093;26455.7354426461;26665.86667066652;46058;46464.53535464602;46831.06337873155;47598;48075.75962120307;30427.782888684203;32106.51840222352;37332.62667373291;38968.41547376735;39147.2170556593;38707.41938870863;38847.6115238844;39002;39794.60205398025;40446.98882527843;37931.05172370603;38682.6131738679;38753;38943.610563894;39892;26117;30452.086437406913;30726.77092916348;32186.678133219306;33905.30473476267;20942.895285523475;21067.89847513983;24141;25905.74094259033;25976.960921562924 12:15:04 INFO - PROCESS | 1656 | |2;jquery.html;338.98135602541856;370.19482625290004;373.96784873748464;386.0483907168828;398.12809946217783;19462.399456100615;19862.90068549657;19918.50203744907;20898.850563219054;21014.739115653072;11557;11762.17664763467;11937.7612447751;11940.7611847763;14150.64623384416;5294;5615.2700148980775;5616.550675945935;5625.6905870177325;5628.465295796913;3966.702497312713;4165.104502531955;5548.4174161713045;6678.332166783307;6958.930410695904;6731.1922569291755;7008.754693585725;7020.7893763187185;7021.789346319593;7030.121234845645;6903.827404314907;6923.446124310043;6969.860602787916;6981.476389270774;6994.195667498252;5859.589828711992;6043.576949613529;6083.66539840313;6086.1479392884585;6118.663473508956;24101.39746506334;24273.514529709482;24790;25073.623895641398;25109.49781004388;2119.2476670781957;2304.5621331946877;2730.440259746747;3019.426309001283;3089.258577941278;8144.511329320259;9760.658376956844;9939.088468645317;10037.397756134655;11209.663710088711;1817.500187448449;1868.7383766272596;1880.332481968895;1892.2714754819356;1897.7627796525435;90925;121246.39376803147;127512;130880.34559827235;133821;11263.662090137144;11399.715007124889;11494.770104598028;11654.601447826146;11806.635108993896;14557.854421455862;14639.414423423157;14640.194789286692;14648.216838800594;14663.340149693076;8394.412391132562;8536.061033286334;8565.057843637194;8573.356998225157;8671.826563468696;8473.618687159093;8494;8647.956760216159;8651.264642505332;8659.956700216584;4461.910761784746;4478.596926276651;4506.504284528699;4567.977160114178;4584.083183363341;1703.4889533140008;1705.9573510662085;1758.1385121290732;1913.8468922486168;1916.3292847503262;882.3338379523419;935.5556110847293;943.2218419803689;951.2627713521938;957.2294303085944;19797.7738125586;20887.16451341929;20943;21136.577268454545;21209.15163393478;747.9551226926293;913.4062859141611;933.7907409904191;940.0975063938558;980.8136454073704;8757.868631970525;9066.773330666787;10012;11103.333799972028;11179.4969226385;547695;549369;550492.4950750521;582580;591216;124486.13270800945;128437;130057.34971325273;145744;146743;769.7459838253363;932.4032619123766;966.2366730282997;970.1656575345197;984.1831280037552;14830.925845370704;19144.425667230007;19478.513037174183;19493;19586.216551338355;44472.44346447859;49389.75305123451;52298.908043677824;56147;57202;80762.59618701869;81059.59470202611;81366.49068074659;81385;84348;7921.534516114537;7990.04119505663;8013.078495973038;8020.15788342239;8363.121872203332;12380.257184568954;12790.936045319713;12796.872031279569;13083.280419576633;13205.801912971121;8799.34004949644;9697.903020969983;10141.391516509033;10416.37501749867;11176.10591152722;10989.395583242998;11068.225224234226;11179.385133817717;11185.881411858749;11271.267367621078;11191.552337906718;11455.828162577402;11542.422878855856;11581.015613672933;11632;7947.562884041433;8118.3099436548555;8198.713045043394;8373.288270496832;8415.831683366421;9945.502724863873;9960.601575936882;10812.459377031275;11050.33697978124;11051.778964420828 12:15:04 INFO - PROCESS | 1656 | |3;mootools.html;1198.478661782125;1554.7950338487674;1559.6802655455633;1665.5669525923256;1968.5275533871875;6104.694765261741;7844.52932824031;7940.761777146688;8668;8668.873046503953;8584.699535516258;8926.59830307636;8965.641374345034;9017;9027.09729027097;2363.4327761337327;2413.4690368119072;2415.118481754165;2416.4079800448826;2426.1265944260053;2038.6126635939124;2381.2380038387637;2400.519896020794;2426.296374051523;2429.914952976646;2287.7254729432407;2405.494846082325;2408.6868707068056;2426.575349313872;2432.914847980321;2370.0638247891984;2388.450656349041;2390.9718820907;2401.0875867170453;2404.13451157584;1978.1395093134533;2360.8229382796358;2377.5363804058215;2396.9041238350446;2400.4958958618713;8998.59506322217;9001.864972025425;9071.727848164566;9090.000099988996;9146.314026447977;5346.358436987586;5407.351117865881;5413.810516631899;5528.087865502187;5539.224508568804;3255.088575198948;3608.386574282352;3667.8166091695307;3701.3522633539023;3701.481792549045;1035.4201647077584;1093.3931667924298;1095.8794532601407;1101.509828126484;1111.0611533254387;8592.839966604492;11694.239874408137;11795.997340226091;11824.70438239051;11857.881421185764;4735.100330937111;4744.0405258950805;4792.976035119802;4906.2640603908985;4906.2640603909695;10079.69760907174;10194.949025254975;10196.847047294297;10202.234832387452;10208.540615672313;5431.185322201702;5477.534409575231;5501.367342755554;5501.504864562128;5530.446955304437;4483.654903528928;4652.558006989399;4859.927101093486;5007.549320561094;5017.347744793226;3988.481497405319;3990.960090399117;4073.5111786585207;4133.441985331941;4162.83348666056;1304.1848844472204;1308.9214647121203;1310.6854354954742;1320.452012414837;1325.807757875122;766.4443278622954;876.6773926817418;898.3756289378819;899.8335307968047;932.8927173375013;5596.104623260258;5611.158326251095;5722.656640601577;5835.708214589254;6132.601380910227;846.585173265108;876.9386142969931;911.4303560274828;936.5223735894607;990.6978371596588;3106.7048630380077;3452.9309413811584;3847.8845634631007;3899.29812633723;3990.8204130814183;10318.896811031944;10480.580776768844;10559.260851740304;10683.679489615324;10895.618653347095;10622.044016038593;10632.681019569425;10635.149188064936;10635.627753028606;10715.732106697395;8090.555019473985;8304.958475207586;8340.874886876702;8418.621162047844;8442.704505342284;5815.244018277597;5877.177195192591;5949.315828679757;5979.073243647242;6023.578349515492;10037.34757240777;10119.848202276824;10202.59189632436;10202.795944081225;10253.74365640865;9918.900810992087;10529.684109476728;10571.894281057092;10592.311499752492;10668.8933110671;7024.789256322319;7244;7404;7655.961720191363;7720.382369410546;7423.8144046399275;7469.962650186714;7717.459777815499;8342.791430214293;8622.698205562776;5935.792247271324;6589.143411356493;7265;7541;7620.923790762022;7012.158540974911;7473.476856620202;7504.662290196845;7543.245675432632;7590.0891892973195;7067.71729130829;7109.324614161646;7153;7186.353228209487;7208.918662200712;5032.144535429059;5079.5428411443145;5103.18349064148;5104.668196567211;5133.050385678662;4995.650304478651;5008.624353173599;5147.356580427447;5193.37679478465;5258.474152584711 12:15:04 INFO - PROCESS | 1656 | |4;prototype.html;285.6457992089808;301.7359810166103;314.9039542939404;315.5109580150766;318.13308733700654;5491.945080549193;5642.4357564243655;5682.4601662842015;5762.42375762424;5787.681677507735;5042.747862606864;5433.4566543345645;5509.944900550993;5593.776248950047;5633.295838020247;3665.321915445638;3862.6866865265806;4264.952822645117;4282.657387409;4320.330348795942;3357.0600231935096;3493.5458390409212;3526.5239192708914;4159.2721273777115;4325.416068830699;3279.6392396836327;3945.644891959723;4152.460180176573;4200.51694055183;4242.215190189825;3879.3792993121247;3909.1790723948006;4267.338562522814;4269.935950960738;4290.292101803198;3252.682663521278;3659.048647351681;3702.3705969985167;3710.3135919854644;3723.180900201978;4519.751413672247;4847.497275844499;5206.214675148777;5226.014114636452;5362.766711282606;4180.707350485467;4567.109413664337;4612.630989520831;4633.891579331396;4898.481470744081;4347.8695639130565;4918.2376731606655;5573.937643072049;5916;5955.34491205967;3322.401967645823;3368.9724633986625;3386.932261354784;3922.333203355408;4050.392441133824;5326.6005049621435;6230.937690623081;6251.156093927307;6271.404216599416;6319.715612797389;3389.7457690672804;3571;4049.9392509112386;4051.0277533392364;4060.1879624075304;3926.310477323043;4072.714909956334;4122.299209134454;4126.546079931205;4127.6491498222385;4779.0680817241;4801.879953001133;4843.159599352223;4863.878403039952;4873.00103478786;5221.582273418117;5702.287214098238;5804.984127777622;5985.850353741192;6090.386047697364;1162.68607475981;1296.3665781115674;1308.4112149532748;1382.1479217848132;1383.89620778442;710.8413286343331;786.8583654942051;857.7984173719171;896.8968568614563;923.2244914272044;4726.480087190406;4872.43966943806;5515.889682206333;5543.695096769717;5568.49883510486;6066.575339726177;6068.848278793065;6141.7543298268465;6172.629642221481;6177.907331390033;5312.574994000471;5396;5428.972855135699;5548.029094908456;5582.91625625616;2648.510025645262;2679.169457468191;2697.5009623219767;2699.9355731245178;2715.67411910572;4748.0295677294225;5262.552683021986;5296.629235953446;5352.1802587120565;5364.570834333244;4238.9479574706165;4695.403562788668;4835.028739506706;5234.2933703949475;5285.471452854684;4445.644348452181;4563.498015218323;4742.755234065492;4919.4834542373255;4936.98791747698;4140.817774048293;4373.119558589837;4709.764511774466;4863.562279394871;5135.460776618401;4736.19484687597;4944.678595891256;5023.467842307985;5056.772445240046;5084.949150508448;4377.861755943414;5108.770105345194;5167.684983039054;5377.8808291190235;5429.5656347492895;3347.698707116371;3440.896773096811;3543.8582456701442;3556.342076715816;3584.7311451641754;4702.565717456208;5104.310918026019;5139.768710408115;5162.360535822311;5212.687238765686;5112.6165537585575;5628.465295796893;5788.623739456922;5935.40645935403;6041.426064524039;5541.778328866801;5917.881642367214;6027.819165425044;6028.8794224116145;6040.184575082483;5434.809781657623;5755.7697692093525;5773.509251713652;5798.884022319446;5802.564807639359;5050.823221187387;5662.2639056922335;5963.582549221686;6046.425589568984;6067;5363.41002489718;5375.81184658535;5820.06878899391;5859.5351162209445;5924.377940316204 12:15:04 INFO - PROCESS | 1656 | |5;yui.html;668.8963210702343;693.4660311560098;726.5967388099609;756.9280918312762;811.9391045671572;15172.08967461953;15453.22733863305;15800.920995395036;15831.05013699176;15879.285432155551;14282.785758213635;14328;14354.784678229835;14379.35292911819;14464.204468754215;837.5519097282939;849.7450764770575;851.7146755836802;851.8849955256023;853.970964987192;690.1545606631886;704.6476761619191;834.5952213176605;855.2003876375578;870.4037734152095;909.8316811389881;911.3802614222326;911.4531281231275;911.680911680913;914.3279689428265;900.0099890120815;902.4359775140537;902.8781114549517;904.864270359448;905.3752910491739;648.5103746671233;652.9444997175245;661.8345413646589;664.0868805392586;664.1266734244454;14521.056131351534;14537.709245815131;14541.563753087425;14602.634934126625;14619.634509137357;14394.352254148589;14395.640108997253;14631.195284259362;14704.632384190374;14753.11481311114;11892.345920974343;11971.820422693667;12026.218295810831;12230.694232644166;12436.37818109091;3803.2393521295853;3865.61343865614;3868.071662800936;3978.2242462719782;3986.2824691555506;120359.39820300843;122350;122911.38544307221;123234;123236;11065.114790816715;11250.943745281222;11277.94361028206;11297;11437.656870293904;22668.546629067656;22755.658665120038;22854.085836566683;22867.19964801224;22949.196778112684;7940.761777146695;8032.1164671886045;8095.919040809516;8259;8271.793205169919;3988.760674359548;4323.659665503704;4388.2320593896575;4555.2483840166005;4696.319033740088;3563.483294922222;3693.8707145249787;3726.310632532936;3728.496652951817;3751.005983414397;599.1402337645493;654.2802916791492;658.7713913551192;665.0356982375574;683.2893790457967;501.93976722793496;587.4477990688824;623.8222106699569;628.1394489549347;636.4844475974476;6971.651417429108;8894.096529716768;9360.251179905592;9660.227181825578;9748;556.3212880286045;657.2769953051701;668.8528523724773;670.4167374384317;699.8215455058927;4394.846180383671;4581.954180458153;4655.208614535537;4680.204365257846;4712.363830882856;92975;94544.10911781863;98843;151151.48848511375;161372;84759;127779;128542;128544;132184;96589.51705241429;99240;112905;118034.19658034299;119159.40420297843;9310.60976461547;10033.19734421259;10036.247281453774;10047.648332308334;10092.444915529717;43107;43983;52420.737896310275;61195;61542.384576155455;89640;94341;96721;97875;99579;12839.422225999666;12919.612411627666;13043.282619455642;13366.198028118344;13738.10702304387;14601.488947886774;14615.123092614052;14811.703765924405;15235.542933712006;15417.383304668136;13364.732705346034;13475.124116932368;13683.305507513114;13973.720525589635;14293.857061429253;13332.666683332607;13577.79633305521;13891.166530008231;14079;14175.29123543798;12999.675008124872;13286.20282783036;13296.202227866359;13312;13672.86327136716;11102.722431939266;11149.219554631098;11206.887931120911;11807.881921181022;11873.406329683654;9045.59294831721;10858.837117443087;11598.536058557564;11604.071674266208;11682.591109311134 12:15:04 INFO - PROCESS | 1656 | __end_tp_report 12:15:04 INFO - PROCESS | 1656 | __start_cc_report 12:15:04 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,366 12:15:04 INFO - PROCESS | 1656 | __end_cc_report 12:15:04 INFO - PROCESS | 1656 | __startTimestamp1473794104949__endTimestamp 12:15:04 INFO - PROCESS | 1656 | 12:15:04 INFO - PROCESS | 1656 | ------- Summary: start ------- 12:15:04 INFO - PROCESS | 1656 | Number of tests: 6 12:15:04 INFO - PROCESS | 1656 | 12:15:04 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5790.07 Median:6041.88 stddev:698.99 (11.6%) stddev-sans-first:661.52 12:15:04 INFO - PROCESS | 1656 | Values: 2832.9 3385.6 3425.8 3430.3 3466.0 5284.7 5650.9 5705.2 5740.4 5741.3 5690.0 5789.0 5799.2 5833.2 5898.0 5205.3 5219.4 5319.8 5398.7 5398.8 5365.5 5422.4 5431.4 5439.9 5470.9 5193.7 5199.2 5235.2 5308.7 5329.1 5231.8 5314.8 5330.7 5344.2 5345.6 5247.1 5262.4 5276.2 5302.6 5382.0 5678.6 5706.2 5884.6 5901.3 5902.4 6190.1 6197.8 6253.7 6280.3 6291.5 5215.6 5856.9 6300.4 6312.1 6315.7 5696.4 5751.3 5941.8 5963.6 5969.3 6164.8 6317.6 6341.1 6352.1 6422.5 6190.8 6245.0 6247.2 6256.8 6264.5 6167.4 6309.0 6321.2 6321.6 6324.3 6121.9 6204.2 6240.3 6270.3 6270.4 6184.6 6230.1 6246.3 6252.0 6265.3 3810.9 4554.2 4608.9 5024.0 5046.5 3635.4 4205.3 4378.7 4381.7 4486.6 4851.4 5623.9 5802.3 5877.5 5916.8 6214.8 6254.7 6256.2 6278.0 6305.4 5668.2 5759.8 5854.4 5886.3 5944.9 5527.0 5529.2 5531.8 5533.2 5573.4 6502.8 6509.6 6527.0 6546.4 6608.8 6181.0 6181.3 6232.6 6288.9 6294.9 6347.7 6465.7 6466.8 6476.6 6495.4 6239.6 6256.6 6260.2 6268.3 6279.8 5826.3 6182.5 6254.2 6258.8 6282.0 6126.9 6190.8 6209.0 6299.1 6306.7 6242.0 6259.0 6272.2 6276.1 6283.1 5906.8 5935.8 6041.9 6105.0 6157.2 6187.6 6267.7 6270.3 6274.3 6278.8 5838.8 6024.7 6066.5 6082.0 6114.7 12:15:04 INFO - PROCESS | 1656 | 12:15:04 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:65038.54 Median:39971.30 stddev:141462.05 (353.9%) stddev-sans-first:141775.71 12:15:04 INFO - PROCESS | 1656 | Values: 427.5 535.4 538.4 541.3 556.1 39069.0 40767.6 40786.4 40821.4 40897.8 42153.9 42641.8 42716.8 42748.6 42752.9 9883.7 9939.4 9955.1 9972.0 10113.2 9830.3 9850.2 9853.2 9945.0 9981.9 8030.6 8869.0 8984.4 9388.6 9566.0 8872.0 8909.0 9279.9 9898.5 9951.6 9819.1 9866.3 9869.0 9877.5 9890.6 40050.6 40595.4 40870.8 40920.8 41141.0 3025.4 3248.3 3694.4 3702.4 3972.5 30716.7 30862.2 31547.0 31554.5 31571.8 2973.5 3140.9 3341.5 3353.6 3372.9 356955.0 361109.0 362234.0 362741.0 362915.3 58455.4 58804.7 58885.7 58925.7 59168.4 60096.7 60178.7 60304.4 60496.8 60540.0 15928.8 16088.3 16171.3 16187.3 16221.9 12432.0 12465.0 12623.4 12662.7 12673.6 15762.3 16096.9 16228.4 16296.0 16303.5 6573.4 6580.9 6658.5 6667.3 6694.3 812.8 855.0 858.9 901.6 986.3 27541.6 29413.6 29647.0 29682.7 30338.2 1004.3 1005.5 1010.2 1066.8 1145.0 14696.9 15287.0 15380.6 15467.4 15628.4 675988.0 677307.0 681457.0 682523.0 682578.0 56138.2 56449.0 57360.0 57409.4 57916.6 1035.0 1322.6 1336.1 1344.4 1348.9 28917.3 29128.1 29294.3 29808.9 29809.8 48565.0 49350.5 49375.5 49426.3 49460.0 493606.0 493663.0 495742.0 495790.0 496604.0 22167.0 26033.5 26265.7 26455.7 26665.9 46058.0 46464.5 46831.1 47598.0 48075.8 30427.8 32106.5 37332.6 38968.4 39147.2 38707.4 38847.6 39002.0 39794.6 40447.0 37931.1 38682.6 38753.0 38943.6 39892.0 26117.0 30452.1 30726.8 32186.7 33905.3 20942.9 21067.9 24141.0 25905.7 25977.0 12:15:04 INFO - PROCESS | 1656 | 12:15:04 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:34189.88 Median:2281.62 stddev:94972.00 (4162.5%) stddev-sans-first:95204.41 12:15:04 INFO - PROCESS | 1656 | Values: 339.0 370.2 374.0 386.0 398.1 19462.4 19862.9 19918.5 20898.9 21014.7 11557.0 11762.2 11937.8 11940.8 14150.6 5294.0 5615.3 5616.6 5625.7 5628.5 3966.7 4165.1 5548.4 6678.3 6958.9 6731.2 7008.8 7020.8 7021.8 7030.1 6903.8 6923.4 6969.9 6981.5 6994.2 5859.6 6043.6 6083.7 6086.1 6118.7 24101.4 24273.5 24790.0 25073.6 25109.5 2119.2 2304.6 2730.4 3019.4 3089.3 8144.5 9760.7 9939.1 10037.4 11209.7 1817.5 1868.7 1880.3 1892.3 1897.8 90925.0 121246.4 127512.0 130880.3 133821.0 11263.7 11399.7 11494.8 11654.6 11806.6 14557.9 14639.4 14640.2 14648.2 14663.3 8394.4 8536.1 8565.1 8573.4 8671.8 8473.6 8494.0 8648.0 8651.3 8660.0 4461.9 4478.6 4506.5 4568.0 4584.1 1703.5 1706.0 1758.1 1913.8 1916.3 882.3 935.6 943.2 951.3 957.2 19797.8 20887.2 20943.0 21136.6 21209.2 748.0 913.4 933.8 940.1 980.8 8757.9 9066.8 10012.0 11103.3 11179.5 547695.0 549369.0 550492.5 582580.0 591216.0 124486.1 128437.0 130057.3 145744.0 146743.0 769.7 932.4 966.2 970.2 984.2 14830.9 19144.4 19478.5 19493.0 19586.2 44472.4 49389.8 52298.9 56147.0 57202.0 80762.6 81059.6 81366.5 81385.0 84348.0 7921.5 7990.0 8013.1 8020.2 8363.1 12380.3 12790.9 12796.9 13083.3 13205.8 8799.3 9697.9 10141.4 10416.4 11176.1 10989.4 11068.2 11179.4 11185.9 11271.3 11191.6 11455.8 11542.4 11581.0 11632.0 7947.6 8118.3 8198.7 8373.3 8415.8 9945.5 9960.6 10812.5 11050.3 11051.8 12:15:04 INFO - PROCESS | 1656 | 12:15:04 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5711.11 Median:4950.96 stddev:3193.27 (64.5%) stddev-sans-first:3184.21 12:15:04 INFO - PROCESS | 1656 | Values: 1198.5 1554.8 1559.7 1665.6 1968.5 6104.7 7844.5 7940.8 8668.0 8668.9 8584.7 8926.6 8965.6 9017.0 9027.1 2363.4 2413.5 2415.1 2416.4 2426.1 2038.6 2381.2 2400.5 2426.3 2429.9 2287.7 2405.5 2408.7 2426.6 2432.9 2370.1 2388.5 2391.0 2401.1 2404.1 1978.1 2360.8 2377.5 2396.9 2400.5 8998.6 9001.9 9071.7 9090.0 9146.3 5346.4 5407.4 5413.8 5528.1 5539.2 3255.1 3608.4 3667.8 3701.4 3701.5 1035.4 1093.4 1095.9 1101.5 1111.1 8592.8 11694.2 11796.0 11824.7 11857.9 4735.1 4744.0 4793.0 4906.3 4906.3 10079.7 10194.9 10196.8 10202.2 10208.5 5431.2 5477.5 5501.4 5501.5 5530.4 4483.7 4652.6 4859.9 5007.5 5017.3 3988.5 3991.0 4073.5 4133.4 4162.8 1304.2 1308.9 1310.7 1320.5 1325.8 766.4 876.7 898.4 899.8 932.9 5596.1 5611.2 5722.7 5835.7 6132.6 846.6 876.9 911.4 936.5 990.7 3106.7 3452.9 3847.9 3899.3 3990.8 10318.9 10480.6 10559.3 10683.7 10895.6 10622.0 10632.7 10635.1 10635.6 10715.7 8090.6 8305.0 8340.9 8418.6 8442.7 5815.2 5877.2 5949.3 5979.1 6023.6 10037.3 10119.8 10202.6 10202.8 10253.7 9918.9 10529.7 10571.9 10592.3 10668.9 7024.8 7244.0 7404.0 7656.0 7720.4 7423.8 7470.0 7717.5 8342.8 8622.7 5935.8 6589.1 7265.0 7541.0 7620.9 7012.2 7473.5 7504.7 7543.2 7590.1 7067.7 7109.3 7153.0 7186.4 7208.9 5032.1 5079.5 5103.2 5104.7 5133.1 4995.7 5008.6 5147.4 5193.4 5258.5 12:15:04 INFO - PROCESS | 1656 | 12:15:04 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4515.67 Median:4928.24 stddev:1421.86 (28.9%) stddev-sans-first:1389.95 12:15:04 INFO - PROCESS | 1656 | Values: 285.6 301.7 314.9 315.5 318.1 5491.9 5642.4 5682.5 5762.4 5787.7 5042.7 5433.5 5509.9 5593.8 5633.3 3665.3 3862.7 4265.0 4282.7 4320.3 3357.1 3493.5 3526.5 4159.3 4325.4 3279.6 3945.6 4152.5 4200.5 4242.2 3879.4 3909.2 4267.3 4269.9 4290.3 3252.7 3659.0 3702.4 3710.3 3723.2 4519.8 4847.5 5206.2 5226.0 5362.8 4180.7 4567.1 4612.6 4633.9 4898.5 4347.9 4918.2 5573.9 5916.0 5955.3 3322.4 3369.0 3386.9 3922.3 4050.4 5326.6 6230.9 6251.2 6271.4 6319.7 3389.7 3571.0 4049.9 4051.0 4060.2 3926.3 4072.7 4122.3 4126.5 4127.6 4779.1 4801.9 4843.2 4863.9 4873.0 5221.6 5702.3 5805.0 5985.9 6090.4 1162.7 1296.4 1308.4 1382.1 1383.9 710.8 786.9 857.8 896.9 923.2 4726.5 4872.4 5515.9 5543.7 5568.5 6066.6 6068.8 6141.8 6172.6 6177.9 5312.6 5396.0 5429.0 5548.0 5582.9 2648.5 2679.2 2697.5 2699.9 2715.7 4748.0 5262.6 5296.6 5352.2 5364.6 4238.9 4695.4 4835.0 5234.3 5285.5 4445.6 4563.5 4742.8 4919.5 4937.0 4140.8 4373.1 4709.8 4863.6 5135.5 4736.2 4944.7 5023.5 5056.8 5084.9 4377.9 5108.8 5167.7 5377.9 5429.6 3347.7 3440.9 3543.9 3556.3 3584.7 4702.6 5104.3 5139.8 5162.4 5212.7 5112.6 5628.5 5788.6 5935.4 6041.4 5541.8 5917.9 6027.8 6028.9 6040.2 5434.8 5755.8 5773.5 5798.9 5802.6 5050.8 5662.3 5963.6 6046.4 6067.0 5363.4 5375.8 5820.1 5859.5 5924.4 12:15:04 INFO - PROCESS | 1656 | 12:15:04 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:24078.25 Median:3739.75 stddev:37872.43 (1012.7%) stddev-sans-first:37937.89 12:15:04 INFO - PROCESS | 1656 | Values: 668.9 693.5 726.6 756.9 811.9 15172.1 15453.2 15800.9 15831.1 15879.3 14282.8 14328.0 14354.8 14379.4 14464.2 837.6 849.7 851.7 851.9 854.0 690.2 704.6 834.6 855.2 870.4 909.8 911.4 911.5 911.7 914.3 900.0 902.4 902.9 904.9 905.4 648.5 652.9 661.8 664.1 664.1 14521.1 14537.7 14541.6 14602.6 14619.6 14394.4 14395.6 14631.2 14704.6 14753.1 11892.3 11971.8 12026.2 12230.7 12436.4 3803.2 3865.6 3868.1 3978.2 3986.3 120359.4 122350.0 122911.4 123234.0 123236.0 11065.1 11250.9 11277.9 11297.0 11437.7 22668.5 22755.7 22854.1 22867.2 22949.2 7940.8 8032.1 8095.9 8259.0 8271.8 3988.8 4323.7 4388.2 4555.2 4696.3 3563.5 3693.9 3726.3 3728.5 3751.0 599.1 654.3 658.8 665.0 683.3 501.9 587.4 623.8 628.1 636.5 6971.7 8894.1 9360.3 9660.2 9748.0 556.3 657.3 668.9 670.4 699.8 4394.8 4582.0 4655.2 4680.2 4712.4 92975.0 94544.1 98843.0 151151.5 161372.0 84759.0 127779.0 128542.0 128544.0 132184.0 96589.5 99240.0 112905.0 118034.2 119159.4 9310.6 10033.2 10036.2 10047.6 10092.4 43107.0 43983.0 52420.7 61195.0 61542.4 89640.0 94341.0 96721.0 97875.0 99579.0 12839.4 12919.6 13043.3 13366.2 13738.1 14601.5 14615.1 14811.7 15235.5 15417.4 13364.7 13475.1 13683.3 13973.7 14293.9 13332.7 13577.8 13891.2 14079.0 14175.3 12999.7 13286.2 13296.2 13312.0 13672.9 11102.7 11149.2 11206.9 11807.9 11873.4 9045.6 10858.8 11598.5 11604.1 11682.6 12:15:04 INFO - PROCESS | 1656 | -------- Summary: end -------- 12:15:04 INFO - PROCESS | 1656 | 12:15:05 INFO - TEST-INFO | 1656: exit 0 12:15:05 INFO - TEST-OK | dromaeo_css | took 1113851ms 12:15:05 INFO - TEST-START | kraken 12:15:05 INFO - operating with platform_type : mac_ 12:15:05 INFO - Initialising browser for kraken test... 12:15:05 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmpQjpNpm/profile http://localhost:49266/getInfo.html) 12:15:08 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 12:15:08 INFO - PROCESS | 1669 | colorDepth:24 12:15:08 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 12:15:08 INFO - PROCESS | 1669 | __metrics 12:15:08 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3000: TypeError: this.tabs is undefined 12:15:09 INFO - TEST-INFO | 1669: exit 0 12:15:09 INFO - Browser initialized. 12:15:09 INFO - Running cycle 1/1 for kraken test... 12:15:09 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmpQjpNpm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:21 INFO - PROCESS | 1671 | RSS: Main: 240013312 12:15:21 INFO - PROCESS | 1671 | 12:15:24 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 12:15:25 INFO - PROCESS | 1671 | RSS: Main: 252600320 12:15:25 INFO - PROCESS | 1671 | 12:15:27 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 12:15:28 INFO - PROCESS | 1671 | RSS: Main: 261173248 12:15:28 INFO - PROCESS | 1671 | 12:15:31 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 12:15:32 INFO - PROCESS | 1671 | RSS: Main: 261513216 12:15:32 INFO - PROCESS | 1671 | 12:15:34 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 12:15:35 INFO - PROCESS | 1671 | RSS: Main: 263712768 12:15:35 INFO - PROCESS | 1671 | 12:15:37 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:15:37 INFO - PROCESS | 1671 | RSS: Main: 264126464 12:15:37 INFO - PROCESS | 1671 | 12:15:40 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 12:15:41 INFO - PROCESS | 1671 | RSS: Main: 264900608 12:15:41 INFO - PROCESS | 1671 | 12:15:44 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 12:15:44 INFO - PROCESS | 1671 | RSS: Main: 265166848 12:15:44 INFO - PROCESS | 1671 | 12:15:47 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 12:15:48 INFO - PROCESS | 1671 | RSS: Main: 265617408 12:15:48 INFO - PROCESS | 1671 | 12:15:49 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:15:50 INFO - PROCESS | 1671 | RSS: Main: 265068544 12:15:50 INFO - PROCESS | 1671 | 12:15:52 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:15:53 INFO - PROCESS | 1671 | RSS: Main: 265138176 12:15:53 INFO - PROCESS | 1671 | 12:15:55 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:15:56 INFO - PROCESS | 1671 | RSS: Main: 265191424 12:15:56 INFO - PROCESS | 1671 | 12:15:59 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:15:59 INFO - PROCESS | 1671 | RSS: Main: 265519104 12:15:59 INFO - PROCESS | 1671 | 12:16:02 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:16:03 INFO - PROCESS | 1671 | RSS: Main: 265486336 12:16:03 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 12:16:05 INFO - PROCESS | 1671 | RSS: Main: 267681792 12:16:05 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | __start_tp_report 12:16:05 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 12:16:05 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 12:16:05 INFO - PROCESS | 1671 | |i|pagename|runs| 12:16:05 INFO - PROCESS | 1671 | |0;ai-astar;107;116;116;130;170;125;117;119;117;118 12:16:05 INFO - PROCESS | 1671 | |1;audio-beat-detection;146;112;113;150;125;149;127;112;138;128 12:16:05 INFO - PROCESS | 1671 | |2;audio-dft;212;224;281;251;221;264;197;199;196;193 12:16:05 INFO - PROCESS | 1671 | |3;audio-fft;80;61;57;86;59;59;61;54;78;58 12:16:05 INFO - PROCESS | 1671 | |4;audio-oscillator;81;71;89;73;71;73;91;70;74;89 12:16:05 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;88;86;88;87;89;86;87;86;90;85 12:16:05 INFO - PROCESS | 1671 | |6;imaging-darkroom;95;94;94;94;96;109;152;127;94;95 12:16:05 INFO - PROCESS | 1671 | |7;imaging-desaturate;90;99;90;89;98;148;91;115;146;94 12:16:05 INFO - PROCESS | 1671 | |8;json-parse-financial;57;55;70;92;93;88;85;61;59;58 12:16:05 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;67;77;82;78;77;95;101;92;71;73 12:16:05 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;86;87;77;100;111;109;109;91;88;85 12:16:05 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;134;176;153;165;156;162;152;145;176;138 12:16:05 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;167;174;169;171;178;239;241;184;169;171 12:16:05 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;69;68;70;71;67;69;67;66;71;67 12:16:05 INFO - PROCESS | 1671 | __end_tp_report 12:16:05 INFO - PROCESS | 1671 | __start_cc_report 12:16:05 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,973 12:16:05 INFO - PROCESS | 1671 | __end_cc_report 12:16:05 INFO - PROCESS | 1671 | __startTimestamp1473794165429__endTimestamp 12:16:05 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | ------- Summary: start ------- 12:16:05 INFO - PROCESS | 1671 | Number of tests: 14 12:16:05 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:123.50 Median:118.50 stddev:17.41 (14.7%) stddev-sans-first:17.41 12:16:05 INFO - PROCESS | 1671 | Values: 107.0 116.0 116.0 130.0 170.0 125.0 117.0 119.0 117.0 118.0 12:16:05 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:130.00 Median:133.00 stddev:15.11 (11.4%) stddev-sans-first:14.88 12:16:05 INFO - PROCESS | 1671 | Values: 146.0 112.0 113.0 150.0 125.0 149.0 127.0 112.0 138.0 128.0 12:16:05 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:223.80 Median:222.50 stddev:31.32 (14.1%) stddev-sans-first:32.93 12:16:05 INFO - PROCESS | 1671 | Values: 212.0 224.0 281.0 251.0 221.0 264.0 197.0 199.0 196.0 193.0 12:16:05 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:65.30 Median:61.00 stddev:11.41 (18.7%) stddev-sans-first:10.79 12:16:05 INFO - PROCESS | 1671 | Values: 80.0 61.0 57.0 86.0 59.0 59.0 61.0 54.0 78.0 58.0 12:16:05 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:77.50 stddev:8.48 (10.9%) stddev-sans-first:8.94 12:16:05 INFO - PROCESS | 1671 | Values: 81.0 71.0 89.0 73.0 71.0 73.0 91.0 70.0 74.0 89.0 12:16:05 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:87.50 stddev:1.55 (1.8%) stddev-sans-first:1.62 12:16:05 INFO - PROCESS | 1671 | Values: 88.0 86.0 88.0 87.0 89.0 86.0 87.0 86.0 90.0 85.0 12:16:05 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:105.00 Median:94.00 stddev:19.65 (20.9%) stddev-sans-first:20.50 12:16:05 INFO - PROCESS | 1671 | Values: 95.0 94.0 94.0 94.0 96.0 109.0 152.0 127.0 94.0 95.0 12:16:05 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:106.00 Median:90.50 stddev:22.92 (25.3%) stddev-sans-first:23.57 12:16:05 INFO - PROCESS | 1671 | Values: 90.0 99.0 90.0 89.0 98.0 148.0 91.0 115.0 146.0 94.0 12:16:05 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:71.80 Median:77.50 stddev:15.88 (20.5%) stddev-sans-first:15.91 12:16:05 INFO - PROCESS | 1671 | Values: 57.0 55.0 70.0 92.0 93.0 88.0 85.0 61.0 59.0 58.0 12:16:05 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:81.30 Median:77.50 stddev:11.15 (14.4%) stddev-sans-first:10.55 12:16:05 INFO - PROCESS | 1671 | Values: 67.0 77.0 82.0 78.0 77.0 95.0 101.0 92.0 71.0 73.0 12:16:05 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:94.30 Median:85.50 stddev:12.03 (14.1%) stddev-sans-first:12.38 12:16:05 INFO - PROCESS | 1671 | Values: 86.0 87.0 77.0 100.0 111.0 109.0 109.0 91.0 88.0 85.0 12:16:05 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:155.70 Median:159.00 stddev:14.41 (9.1%) stddev-sans-first:12.98 12:16:05 INFO - PROCESS | 1671 | Values: 134.0 176.0 153.0 165.0 156.0 162.0 152.0 145.0 176.0 138.0 12:16:05 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.30 Median:176.00 stddev:28.74 (16.3%) stddev-sans-first:29.62 12:16:05 INFO - PROCESS | 1671 | Values: 167.0 174.0 169.0 171.0 178.0 239.0 241.0 184.0 169.0 171.0 12:16:05 INFO - PROCESS | 1671 | 12:16:05 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.78 (2.6%) stddev-sans-first:1.88 12:16:05 INFO - PROCESS | 1671 | Values: 69.0 68.0 70.0 71.0 67.0 69.0 67.0 66.0 71.0 67.0 12:16:05 INFO - PROCESS | 1671 | -------- Summary: end -------- 12:16:05 INFO - PROCESS | 1671 | 12:16:06 INFO - TEST-INFO | 1671: exit 0 12:16:06 INFO - TEST-OK | kraken | took 60768ms 12:16:06 INFO - SUITE-END | took 1174s 12:16:06 INFO - Completed test suite (00:19:34) 12:16:06 INFO - javascript benchmark 12:16:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7312.030946685043, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2832.9433411331765, 3385.59372875255, 3425.7773244739105, 3430.313937212558, 3465.98267008665, 5284.709340986245, 5650.915236271459, 5705.172749951254, 5740.397258287882, 5741.282339707536, 5689.975804355215, 5788.971055144719, 5799.217105690731, 5833.212516310296, 5898.026825573776, 5205.27126202332, 5219.373675158986, 5319.840404787863, 5398.703071331075, 5398.838034858941, 5365.463453654643, 5422.40353561108, 5431.375391829931, 5439.945600544003, 5470.9452905471035, 5193.662411943212, 5199.168133098686, 5235.188545775411, 5308.681479111266, 5329.094054010808, 5231.843044708627, 5314.787408503656, 5330.706811125387, 5344.1716533936915, 5345.599080069011, 5247.081760691864, 5262.447443018466, 5276.234945932818, 5302.602304827154, 5382.0043291991105, 5678.574106941955, 5706.201131841545, 5884.6469211847, 5901.262342207224, 5902.409759024106, 6190.133381326618, 6197.845053873644, 6253.656048917308, 6280.340564240781, 6291.528135389818, 5215.608829337815, 5856.857912707023, 6300.369963003709, 6312.084747711602, 6315.684215789192, 5696.401877802812, 5751.252337196138, 5941.821745347646, 5963.642181469126, 5969.313528944183, 6164.753409863555, 6317.557770955989, 6341.112244285804, 6352.110704501373, 6422.45409140219, 6190.783322583688, 6245.000799871998, 6247.219097612799, 6256.843578910563, 6264.5301602379095, 6167.383261673796, 6308.968455157695, 6321.178246827975, 6321.620702757849, 6324.33594472583, 6121.908171377433, 6204.193454850931, 6240.31356550779, 6270.341614130451, 6270.435660790459, 6184.5980011299125, 6230.06549017651, 6246.344133865879, 6252.0, 6265.310815810257, 3810.866619668354, 4554.180247555406, 4608.907821843612, 5023.995200959823, 5046.4953504649975, 3635.4365073413665, 4205.285101532747, 4378.737275763465, 4381.737095774264, 4486.5962063414445, 4851.417829860439, 5623.931453023994, 5802.303723553201, 5877.471027607536, 5916.792912248051, 6214.782482613177, 6254.6872656366995, 6256.155419018465, 6278.0, 6305.369463053658, 5668.178114173422, 5759.827205183851, 5854.414558544111, 5886.293644762656, 5944.940550594525, 5526.972365138148, 5529.225908372831, 5531.778728850882, 5533.1976863354585, 5573.359063707726, 6502.804915852532, 6509.576877502947, 6526.967365163144, 6546.410823025855, 6608.768693095719, 6180.969095154495, 6181.258249010148, 6232.626042437469, 6288.874222515616, 6294.905576416266, 6347.682615869096, 6465.676716164267, 6466.805995820133, 6476.6114033158165, 6495.415412612888, 6239.594426362272, 6256.593321434092, 6260.154879091265, 6268.27914789805, 6279.843003924939, 5826.271716035496, 6182.505399568114, 6254.249490061222, 6258.843528911813, 6282.026285925689, 6126.945200426759, 6190.845228869314, 6209.0, 6299.055141728777, 6306.747730090929, 6242.0, 6259.0, 6272.247330320391, 6276.1213430118905, 6283.120363149072, 5906.793262235973, 5935.821925342247, 6041.879162416639, 6105.0, 6157.199564056823, 6187.628742275478, 6267.717952692231, 6270.310265870842, 6274.341194174546, 6278.843028924313, 5838.766449341979, 6024.698765061642, 6066.545009124422, 6082.026875699867, 6114.6942652868065], "value": 5742.0094222758225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.5083653798132, 535.4377903201637, 538.3593523706791, 541.3341589844493, 556.1241045353567, 39069.0, 40767.59232407675, 40786.388204176925, 40821.3876791848, 40897.79551102248, 42153.94615134623, 42641.786791066, 42716.78641606795, 42748.57251427485, 42752.931176720595, 9883.703488895326, 9939.403635781877, 9955.10404063634, 9971.950140249288, 10113.190944724405, 9830.311878168532, 9850.162736167435, 9853.162481189072, 9944.950275248613, 9981.850272245922, 8030.558319292437, 8869.0, 8984.416012959136, 9388.624455021825, 9566.043395660414, 8872.0, 8908.97546782122, 9279.907200927972, 9898.455584942825, 9951.552180151839, 9819.06718861707, 9866.309358344919, 9869.0, 9877.506124693737, 9890.604375824958, 40050.59949400498, 40595.391069133984, 40870.79564602158, 40920.77237682845, 41141.0, 3025.3646734185845, 3248.252901832568, 3694.3534881395917, 3702.407614781649, 3972.503437070366, 30716.692833071607, 30862.22844428885, 31547.0, 31554.526682099786, 31571.84214078938, 2973.4647763402577, 3140.905772826819, 3341.548890899746, 3353.5808023997, 3372.932541349184, 356955.0, 361109.0, 362234.0, 362741.0, 362915.3376196155, 58455.415445845, 58804.70597646984, 58885.705571472725, 58925.70537147287, 59168.40831591715, 60096.699516502136, 60178.69910650506, 60304.39695603075, 60496.79006419935, 60540.0, 15928.840711592737, 16088.276027578788, 16171.272292746855, 16187.271572779253, 16221.918890405472, 12432.0, 12465.0, 12623.36883155857, 12662.683432914067, 12673.556425525247, 15762.290696918666, 16096.919515402347, 16228.432004879773, 16296.022238665719, 16303.510894673178, 6573.441257493071, 6580.86838263232, 6658.467322614276, 6667.333266673294, 6694.263631000586, 812.8496228197803, 854.9871751923727, 858.9012263589642, 901.5582364641278, 986.3440811860177, 27541.622918853976, 29413.55879661764, 29646.962356317425, 29682.703172967995, 30338.241543961136, 1004.2618675273668, 1005.4520286443906, 1010.2120346130031, 1066.7599790047332, 1145.0, 14696.897732670093, 15287.006344587566, 15380.615484612974, 15467.381304747909, 15628.3748650055, 675988.0, 677307.0, 681457.0, 682523.0, 682578.0, 56138.15792763112, 56449.0, 57360.0, 57409.425905740405, 57916.55208619818, 1035.0, 1322.6296636941672, 1336.0981337597277, 1344.3883033220056, 1348.8583698711493, 28917.277068073465, 29128.12615621535, 29294.26764330909, 29808.85095574508, 29809.78328792496, 48565.0, 49350.50649493459, 49375.50624493709, 49426.25860612166, 49460.0, 493606.0, 493663.0, 495742.0, 495790.0, 496604.0, 22167.0, 26033.479330412905, 26265.737342627093, 26455.7354426461, 26665.86667066652, 46058.0, 46464.53535464602, 46831.06337873155, 47598.0, 48075.75962120307, 30427.782888684203, 32106.51840222352, 37332.62667373291, 38968.41547376735, 39147.2170556593, 38707.41938870863, 38847.6115238844, 39002.0, 39794.60205398025, 40446.98882527843, 37931.05172370603, 38682.6131738679, 38753.0, 38943.610563894, 39892.0, 26117.0, 30452.086437406913, 30726.77092916348, 32186.678133219306, 33905.30473476267, 20942.895285523475, 21067.89847513983, 24141.0, 25905.74094259033, 25976.960921562924], "value": 19344.993318651334, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.98135602541856, 370.19482625290004, 373.96784873748464, 386.0483907168828, 398.12809946217783, 19462.399456100615, 19862.90068549657, 19918.50203744907, 20898.850563219054, 21014.739115653072, 11557.0, 11762.17664763467, 11937.7612447751, 11940.7611847763, 14150.64623384416, 5294.0, 5615.2700148980775, 5616.550675945935, 5625.6905870177325, 5628.465295796913, 3966.702497312713, 4165.104502531955, 5548.4174161713045, 6678.332166783307, 6958.930410695904, 6731.1922569291755, 7008.754693585725, 7020.7893763187185, 7021.789346319593, 7030.121234845645, 6903.827404314907, 6923.446124310043, 6969.860602787916, 6981.476389270774, 6994.195667498252, 5859.589828711992, 6043.576949613529, 6083.66539840313, 6086.1479392884585, 6118.663473508956, 24101.39746506334, 24273.514529709482, 24790.0, 25073.623895641398, 25109.49781004388, 2119.2476670781957, 2304.5621331946877, 2730.440259746747, 3019.426309001283, 3089.258577941278, 8144.511329320259, 9760.658376956844, 9939.088468645317, 10037.397756134655, 11209.663710088711, 1817.500187448449, 1868.7383766272596, 1880.332481968895, 1892.2714754819356, 1897.7627796525435, 90925.0, 121246.39376803147, 127512.0, 130880.34559827235, 133821.0, 11263.662090137144, 11399.715007124889, 11494.770104598028, 11654.601447826146, 11806.635108993896, 14557.854421455862, 14639.414423423157, 14640.194789286692, 14648.216838800594, 14663.340149693076, 8394.412391132562, 8536.061033286334, 8565.057843637194, 8573.356998225157, 8671.826563468696, 8473.618687159093, 8494.0, 8647.956760216159, 8651.264642505332, 8659.956700216584, 4461.910761784746, 4478.596926276651, 4506.504284528699, 4567.977160114178, 4584.083183363341, 1703.4889533140008, 1705.9573510662085, 1758.1385121290732, 1913.8468922486168, 1916.3292847503262, 882.3338379523419, 935.5556110847293, 943.2218419803689, 951.2627713521938, 957.2294303085944, 19797.7738125586, 20887.16451341929, 20943.0, 21136.577268454545, 21209.15163393478, 747.9551226926293, 913.4062859141611, 933.7907409904191, 940.0975063938558, 980.8136454073704, 8757.868631970525, 9066.773330666787, 10012.0, 11103.333799972028, 11179.4969226385, 547695.0, 549369.0, 550492.4950750521, 582580.0, 591216.0, 124486.13270800945, 128437.0, 130057.34971325273, 145744.0, 146743.0, 769.7459838253363, 932.4032619123766, 966.2366730282997, 970.1656575345197, 984.1831280037552, 14830.925845370704, 19144.425667230007, 19478.513037174183, 19493.0, 19586.216551338355, 44472.44346447859, 49389.75305123451, 52298.908043677824, 56147.0, 57202.0, 80762.59618701869, 81059.59470202611, 81366.49068074659, 81385.0, 84348.0, 7921.534516114537, 7990.04119505663, 8013.078495973038, 8020.15788342239, 8363.121872203332, 12380.257184568954, 12790.936045319713, 12796.872031279569, 13083.280419576633, 13205.801912971121, 8799.34004949644, 9697.903020969983, 10141.391516509033, 10416.37501749867, 11176.10591152722, 10989.395583242998, 11068.225224234226, 11179.385133817717, 11185.881411858749, 11271.267367621078, 11191.552337906718, 11455.828162577402, 11542.422878855856, 11581.015613672933, 11632.0, 7947.562884041433, 8118.3099436548555, 8198.713045043394, 8373.288270496832, 8415.831683366421, 9945.502724863873, 9960.601575936882, 10812.459377031275, 11050.33697978124, 11051.778964420828], "value": 9461.059276113976, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1198.478661782125, 1554.7950338487674, 1559.6802655455633, 1665.5669525923256, 1968.5275533871875, 6104.694765261741, 7844.52932824031, 7940.761777146688, 8668.0, 8668.873046503953, 8584.699535516258, 8926.59830307636, 8965.641374345034, 9017.0, 9027.09729027097, 2363.4327761337327, 2413.4690368119072, 2415.118481754165, 2416.4079800448826, 2426.1265944260053, 2038.6126635939124, 2381.2380038387637, 2400.519896020794, 2426.296374051523, 2429.914952976646, 2287.7254729432407, 2405.494846082325, 2408.6868707068056, 2426.575349313872, 2432.914847980321, 2370.0638247891984, 2388.450656349041, 2390.9718820907, 2401.0875867170453, 2404.13451157584, 1978.1395093134533, 2360.8229382796358, 2377.5363804058215, 2396.9041238350446, 2400.4958958618713, 8998.59506322217, 9001.864972025425, 9071.727848164566, 9090.000099988996, 9146.314026447977, 5346.358436987586, 5407.351117865881, 5413.810516631899, 5528.087865502187, 5539.224508568804, 3255.088575198948, 3608.386574282352, 3667.8166091695307, 3701.3522633539023, 3701.481792549045, 1035.4201647077584, 1093.3931667924298, 1095.8794532601407, 1101.509828126484, 1111.0611533254387, 8592.839966604492, 11694.239874408137, 11795.997340226091, 11824.70438239051, 11857.881421185764, 4735.100330937111, 4744.0405258950805, 4792.976035119802, 4906.2640603908985, 4906.2640603909695, 10079.69760907174, 10194.949025254975, 10196.847047294297, 10202.234832387452, 10208.540615672313, 5431.185322201702, 5477.534409575231, 5501.367342755554, 5501.504864562128, 5530.446955304437, 4483.654903528928, 4652.558006989399, 4859.927101093486, 5007.549320561094, 5017.347744793226, 3988.481497405319, 3990.960090399117, 4073.5111786585207, 4133.441985331941, 4162.83348666056, 1304.1848844472204, 1308.9214647121203, 1310.6854354954742, 1320.452012414837, 1325.807757875122, 766.4443278622954, 876.6773926817418, 898.3756289378819, 899.8335307968047, 932.8927173375013, 5596.104623260258, 5611.158326251095, 5722.656640601577, 5835.708214589254, 6132.601380910227, 846.585173265108, 876.9386142969931, 911.4303560274828, 936.5223735894607, 990.6978371596588, 3106.7048630380077, 3452.9309413811584, 3847.8845634631007, 3899.29812633723, 3990.8204130814183, 10318.896811031944, 10480.580776768844, 10559.260851740304, 10683.679489615324, 10895.618653347095, 10622.044016038593, 10632.681019569425, 10635.149188064936, 10635.627753028606, 10715.732106697395, 8090.555019473985, 8304.958475207586, 8340.874886876702, 8418.621162047844, 8442.704505342284, 5815.244018277597, 5877.177195192591, 5949.315828679757, 5979.073243647242, 6023.578349515492, 10037.34757240777, 10119.848202276824, 10202.59189632436, 10202.795944081225, 10253.74365640865, 9918.900810992087, 10529.684109476728, 10571.894281057092, 10592.311499752492, 10668.8933110671, 7024.789256322319, 7244.0, 7404.0, 7655.961720191363, 7720.382369410546, 7423.8144046399275, 7469.962650186714, 7717.459777815499, 8342.791430214293, 8622.698205562776, 5935.792247271324, 6589.143411356493, 7265.0, 7541.0, 7620.923790762022, 7012.158540974911, 7473.476856620202, 7504.662290196845, 7543.245675432632, 7590.0891892973195, 7067.71729130829, 7109.324614161646, 7153.0, 7186.353228209487, 7208.918662200712, 5032.144535429059, 5079.5428411443145, 5103.18349064148, 5104.668196567211, 5133.050385678662, 4995.650304478651, 5008.624353173599, 5147.356580427447, 5193.37679478465, 5258.474152584711], "value": 4594.387302965646, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.6457992089808, 301.7359810166103, 314.9039542939404, 315.5109580150766, 318.13308733700654, 5491.945080549193, 5642.4357564243655, 5682.4601662842015, 5762.42375762424, 5787.681677507735, 5042.747862606864, 5433.4566543345645, 5509.944900550993, 5593.776248950047, 5633.295838020247, 3665.321915445638, 3862.6866865265806, 4264.952822645117, 4282.657387409, 4320.330348795942, 3357.0600231935096, 3493.5458390409212, 3526.5239192708914, 4159.2721273777115, 4325.416068830699, 3279.6392396836327, 3945.644891959723, 4152.460180176573, 4200.51694055183, 4242.215190189825, 3879.3792993121247, 3909.1790723948006, 4267.338562522814, 4269.935950960738, 4290.292101803198, 3252.682663521278, 3659.048647351681, 3702.3705969985167, 3710.3135919854644, 3723.180900201978, 4519.751413672247, 4847.497275844499, 5206.214675148777, 5226.014114636452, 5362.766711282606, 4180.707350485467, 4567.109413664337, 4612.630989520831, 4633.891579331396, 4898.481470744081, 4347.8695639130565, 4918.2376731606655, 5573.937643072049, 5916.0, 5955.34491205967, 3322.401967645823, 3368.9724633986625, 3386.932261354784, 3922.333203355408, 4050.392441133824, 5326.6005049621435, 6230.937690623081, 6251.156093927307, 6271.404216599416, 6319.715612797389, 3389.7457690672804, 3571.0, 4049.9392509112386, 4051.0277533392364, 4060.1879624075304, 3926.310477323043, 4072.714909956334, 4122.299209134454, 4126.546079931205, 4127.6491498222385, 4779.0680817241, 4801.879953001133, 4843.159599352223, 4863.878403039952, 4873.00103478786, 5221.582273418117, 5702.287214098238, 5804.984127777622, 5985.850353741192, 6090.386047697364, 1162.68607475981, 1296.3665781115674, 1308.4112149532748, 1382.1479217848132, 1383.89620778442, 710.8413286343331, 786.8583654942051, 857.7984173719171, 896.8968568614563, 923.2244914272044, 4726.480087190406, 4872.43966943806, 5515.889682206333, 5543.695096769717, 5568.49883510486, 6066.575339726177, 6068.848278793065, 6141.7543298268465, 6172.629642221481, 6177.907331390033, 5312.574994000471, 5396.0, 5428.972855135699, 5548.029094908456, 5582.91625625616, 2648.510025645262, 2679.169457468191, 2697.5009623219767, 2699.9355731245178, 2715.67411910572, 4748.0295677294225, 5262.552683021986, 5296.629235953446, 5352.1802587120565, 5364.570834333244, 4238.9479574706165, 4695.403562788668, 4835.028739506706, 5234.2933703949475, 5285.471452854684, 4445.644348452181, 4563.498015218323, 4742.755234065492, 4919.4834542373255, 4936.98791747698, 4140.817774048293, 4373.119558589837, 4709.764511774466, 4863.562279394871, 5135.460776618401, 4736.19484687597, 4944.678595891256, 5023.467842307985, 5056.772445240046, 5084.949150508448, 4377.861755943414, 5108.770105345194, 5167.684983039054, 5377.8808291190235, 5429.5656347492895, 3347.698707116371, 3440.896773096811, 3543.8582456701442, 3556.342076715816, 3584.7311451641754, 4702.565717456208, 5104.310918026019, 5139.768710408115, 5162.360535822311, 5212.687238765686, 5112.6165537585575, 5628.465295796893, 5788.623739456922, 5935.40645935403, 6041.426064524039, 5541.778328866801, 5917.881642367214, 6027.819165425044, 6028.8794224116145, 6040.184575082483, 5434.809781657623, 5755.7697692093525, 5773.509251713652, 5798.884022319446, 5802.564807639359, 5050.823221187387, 5662.2639056922335, 5963.582549221686, 6046.425589568984, 6067.0, 5363.41002489718, 5375.81184658535, 5820.06878899391, 5859.5351162209445, 5924.377940316204], "value": 4060.7607655839183, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.8963210702343, 693.4660311560098, 726.5967388099609, 756.9280918312762, 811.9391045671572, 15172.08967461953, 15453.22733863305, 15800.920995395036, 15831.05013699176, 15879.285432155551, 14282.785758213635, 14328.0, 14354.784678229835, 14379.35292911819, 14464.204468754215, 837.5519097282939, 849.7450764770575, 851.7146755836802, 851.8849955256023, 853.970964987192, 690.1545606631886, 704.6476761619191, 834.5952213176605, 855.2003876375578, 870.4037734152095, 909.8316811389881, 911.3802614222326, 911.4531281231275, 911.680911680913, 914.3279689428265, 900.0099890120815, 902.4359775140537, 902.8781114549517, 904.864270359448, 905.3752910491739, 648.5103746671233, 652.9444997175245, 661.8345413646589, 664.0868805392586, 664.1266734244454, 14521.056131351534, 14537.709245815131, 14541.563753087425, 14602.634934126625, 14619.634509137357, 14394.352254148589, 14395.640108997253, 14631.195284259362, 14704.632384190374, 14753.11481311114, 11892.345920974343, 11971.820422693667, 12026.218295810831, 12230.694232644166, 12436.37818109091, 3803.2393521295853, 3865.61343865614, 3868.071662800936, 3978.2242462719782, 3986.2824691555506, 120359.39820300843, 122350.0, 122911.38544307221, 123234.0, 123236.0, 11065.114790816715, 11250.943745281222, 11277.94361028206, 11297.0, 11437.656870293904, 22668.546629067656, 22755.658665120038, 22854.085836566683, 22867.19964801224, 22949.196778112684, 7940.761777146695, 8032.1164671886045, 8095.919040809516, 8259.0, 8271.793205169919, 3988.760674359548, 4323.659665503704, 4388.2320593896575, 4555.2483840166005, 4696.319033740088, 3563.483294922222, 3693.8707145249787, 3726.310632532936, 3728.496652951817, 3751.005983414397, 599.1402337645493, 654.2802916791492, 658.7713913551192, 665.0356982375574, 683.2893790457967, 501.93976722793496, 587.4477990688824, 623.8222106699569, 628.1394489549347, 636.4844475974476, 6971.651417429108, 8894.096529716768, 9360.251179905592, 9660.227181825578, 9748.0, 556.3212880286045, 657.2769953051701, 668.8528523724773, 670.4167374384317, 699.8215455058927, 4394.846180383671, 4581.954180458153, 4655.208614535537, 4680.204365257846, 4712.363830882856, 92975.0, 94544.10911781863, 98843.0, 151151.48848511375, 161372.0, 84759.0, 127779.0, 128542.0, 128544.0, 132184.0, 96589.51705241429, 99240.0, 112905.0, 118034.19658034299, 119159.40420297843, 9310.60976461547, 10033.19734421259, 10036.247281453774, 10047.648332308334, 10092.444915529717, 43107.0, 43983.0, 52420.737896310275, 61195.0, 61542.384576155455, 89640.0, 94341.0, 96721.0, 97875.0, 99579.0, 12839.422225999666, 12919.612411627666, 13043.282619455642, 13366.198028118344, 13738.10702304387, 14601.488947886774, 14615.123092614052, 14811.703765924405, 15235.542933712006, 15417.383304668136, 13364.732705346034, 13475.124116932368, 13683.305507513114, 13973.720525589635, 14293.857061429253, 13332.666683332607, 13577.79633305521, 13891.166530008231, 14079.0, 14175.29123543798, 12999.675008124872, 13286.20282783036, 13296.202227866359, 13312.0, 13672.86327136716, 11102.722431939266, 11149.219554631098, 11206.887931120911, 11807.881921181022, 11873.406329683654, 9045.59294831721, 10858.837117443087, 11598.536058557564, 11604.071674266208, 11682.591109311134], "value": 7794.281100085435, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 116.0, 130.0, 170.0, 125.0, 117.0, 119.0, 117.0, 118.0], "value": 123.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 112.0, 113.0, 150.0, 125.0, 149.0, 127.0, 112.0, 138.0, 128.0], "value": 130.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 224.0, 281.0, 251.0, 221.0, 264.0, 197.0, 199.0, 196.0, 193.0], "value": 223.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 61.0, 57.0, 86.0, 59.0, 59.0, 61.0, 54.0, 78.0, 58.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 71.0, 89.0, 73.0, 71.0, 73.0, 91.0, 70.0, 74.0, 89.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 87.0, 89.0, 86.0, 87.0, 86.0, 90.0, 85.0], "value": 87.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 96.0, 109.0, 152.0, 127.0, 94.0, 95.0], "value": 105.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 99.0, 90.0, 89.0, 98.0, 148.0, 91.0, 115.0, 146.0, 94.0], "value": 106.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 70.0, 92.0, 93.0, 88.0, 85.0, 61.0, 59.0, 58.0], "value": 71.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 77.0, 82.0, 78.0, 77.0, 95.0, 101.0, 92.0, 71.0, 73.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 77.0, 100.0, 111.0, 109.0, 109.0, 91.0, 88.0, 85.0], "value": 94.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 176.0, 153.0, 165.0, 156.0, 162.0, 152.0, 145.0, 176.0, 138.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 174.0, 169.0, 171.0, 178.0, 239.0, 241.0, 184.0, 169.0, 171.0], "value": 186.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 70.0, 71.0, 67.0, 69.0, 67.0, 66.0, 71.0, 67.0], "value": 68.5, "unit": "score"}]}]} 12:16:06 INFO - Return code: 0 12:16:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:16:06 ERROR - # TBPL SUCCESS # 12:16:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:16:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:16:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:16:06 INFO - 2016-09-13 12:16:06.762 screenresolution[1676:10704] starting screenresolution argv=screenresolution get 12:16:06 INFO - 2016-09-13 12:16:06.765 screenresolution[1676:10704] Display 0: 1600x1200x32@60 12:16:06 INFO - 2016-09-13 12:16:06.772 screenresolution[1677:10707] starting screenresolution argv=screenresolution list 12:16:06 INFO - Available Modes on Display 0 12:16:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:16:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:16:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:16:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:16:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:16:07 INFO - Intel Iris: 12:16:07 INFO - Chipset Model: Intel Iris 12:16:07 INFO - Type: GPU 12:16:07 INFO - Bus: Built-In 12:16:07 INFO - VRAM (Dynamic, Max): 1536 MB 12:16:07 INFO - Vendor: Intel (0x8086) 12:16:07 INFO - Device ID: 0x0a2e 12:16:07 INFO - Revision ID: 0x0009 12:16:07 INFO - Displays: 12:16:07 INFO - Display: 12:16:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:16:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:16:07 INFO - Display Serial Number: 1600x1200 60 12:16:07 INFO - Main Display: Yes 12:16:07 INFO - Mirror: Off 12:16:07 INFO - Online: Yes 12:16:07 INFO - Rotation: Supported 12:16:07 INFO - Return code: 0 12:16:07 INFO - Running post-action listener: _resource_record_post_action 12:16:07 INFO - [mozharness: 2016-09-13 19:16:07.006863Z] Finished run-tests step (success) 12:16:07 INFO - Running post-run listener: _resource_record_post_run 12:16:07 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 37221376; Write bytes: 707139584; Read time: 234; Write time: 1976 12:16:07 INFO - TinderboxPrint: CPU usage
54.5% 12:16:07 INFO - TinderboxPrint: I/O read bytes / time
37,221,376 / 234 12:16:07 INFO - TinderboxPrint: I/O write bytes / time
707,139,584 / 1,976 12:16:07 INFO - TinderboxPrint: CPU idle
2,202.1 (45.5%) 12:16:07 INFO - TinderboxPrint: CPU system
977.0 (20.2%) 12:16:07 INFO - TinderboxPrint: CPU user
1,658.6 (34.3%) 12:16:07 INFO - TinderboxPrint: Swap in / out
442,372,096 / 0 12:16:07 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399788544; Write bytes: 393889280; Read time: 29511; Write time: 785 12:16:07 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35124224; Write bytes: 298426880; Read time: 216; Write time: 1153 12:16:07 INFO - Running post-run listener: _upload_blobber_files 12:16:07 INFO - Blob upload gear active. 12:16:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:16:07 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 12:16:07 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'] 12:16:07 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 12:16:07 INFO - (blobuploader) - INFO - Open directory for files ... 12:16:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:16:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:16:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:16:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:16:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:16:08 INFO - (blobuploader) - INFO - Done attempting. 12:16:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:16:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:16:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:16:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:16:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:16:09 INFO - (blobuploader) - INFO - Done attempting. 12:16:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:16:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:16:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:16:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:16:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:16:12 INFO - (blobuploader) - INFO - Done attempting. 12:16:12 INFO - (blobuploader) - INFO - Iteration through files over. 12:16:12 INFO - Return code: 0 12:16:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:16:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:16:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/88213f677f668a6ce53855a58aba41436ff8ca9666f91cbe6acd8d323413ec2aea59dcb29a0f4c709a24aa2985a717a3b293acf47d480aa340dd5d03d31724bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e6b10b536b1b8aee7aa4862dffd05e077bae212b8b5c3333271160371e4f2193feb49d12109c3877f5eaf0073d0e01b0eec77e718a85192ea664be9fc0b4808c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d42bfc1852bce72ebac2c0622f71622eedf3cf74c02c128a352a02726935a83f24e3c2ca995aa3fd1a136fcc6ffd909e6aff81231ad71b908a2bc8e4f6ecd771"} 12:16:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:16:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:16:12 INFO - Contents: 12:16:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/88213f677f668a6ce53855a58aba41436ff8ca9666f91cbe6acd8d323413ec2aea59dcb29a0f4c709a24aa2985a717a3b293acf47d480aa340dd5d03d31724bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e6b10b536b1b8aee7aa4862dffd05e077bae212b8b5c3333271160371e4f2193feb49d12109c3877f5eaf0073d0e01b0eec77e718a85192ea664be9fc0b4808c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d42bfc1852bce72ebac2c0622f71622eedf3cf74c02c128a352a02726935a83f24e3c2ca995aa3fd1a136fcc6ffd909e6aff81231ad71b908a2bc8e4f6ecd771"} 12:16:12 INFO - Running post-run listener: copy_logs_to_upload_dir 12:16:12 INFO - Copying logs to upload dir... 12:16:12 INFO - mkdir: /builds/slave/test/build/upload/logs 12:16:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.201871 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-13 12:16:12.275632) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 12:16:12.279560) ========= 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.f53NzvB05X/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.HRVDdEl3k1/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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/88213f677f668a6ce53855a58aba41436ff8ca9666f91cbe6acd8d323413ec2aea59dcb29a0f4c709a24aa2985a717a3b293acf47d480aa340dd5d03d31724bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e6b10b536b1b8aee7aa4862dffd05e077bae212b8b5c3333271160371e4f2193feb49d12109c3877f5eaf0073d0e01b0eec77e718a85192ea664be9fc0b4808c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d42bfc1852bce72ebac2c0622f71622eedf3cf74c02c128a352a02726935a83f24e3c2ca995aa3fd1a136fcc6ffd909e6aff81231ad71b908a2bc8e4f6ecd771"} build_url:https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011078 build_url: 'https://queue.taskcluster.net/v1/task/MDSdruOlTS-fiV2ZT3eqpw/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/88213f677f668a6ce53855a58aba41436ff8ca9666f91cbe6acd8d323413ec2aea59dcb29a0f4c709a24aa2985a717a3b293acf47d480aa340dd5d03d31724bf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e6b10b536b1b8aee7aa4862dffd05e077bae212b8b5c3333271160371e4f2193feb49d12109c3877f5eaf0073d0e01b0eec77e718a85192ea664be9fc0b4808c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d42bfc1852bce72ebac2c0622f71622eedf3cf74c02c128a352a02726935a83f24e3c2ca995aa3fd1a136fcc6ffd909e6aff81231ad71b908a2bc8e4f6ecd771"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-13 12:16:12.317028) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 12:16:12.317775) ========= 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.f53NzvB05X/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.HRVDdEl3k1/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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.005130 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-13 12:16:12.370534) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 12:16:12.371226) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-13 12:16:12.371935) ========= ========= Total master_lag: 0.18 =========