builder: larch_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0043 starttime: 1474511644.85 results: success (0) buildid: 20160921173106 builduid: 58c5dd34763d4260a770f013f4d9dc60 revision: 36b4cfcfaff31cc3e2a1bda6d0f9d92df831b154 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 19:34:04.849115) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 19:34:04.850128) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 19:34:04.850539) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 19:34:04.915049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 19:34:04.915336) ========= 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.5hxi2y0kSd/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.UXonUZfis7/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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-21 19:34:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 68.9M=0s 2016-09-21 19:34:05 (68.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141527 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 19:34:05.080779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 19:34:05.081209) ========= 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.5hxi2y0kSd/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.UXonUZfis7/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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.021336 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 19:34:05.130200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 19:34:05.130563) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 36b4cfcfaff31cc3e2a1bda6d0f9d92df831b154 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 36b4cfcfaff31cc3e2a1bda6d0f9d92df831b154 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5hxi2y0kSd/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.UXonUZfis7/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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-21 19:34:05,161 truncating revision to first 12 chars 2016-09-21 19:34:05,161 Setting DEBUG logging. 2016-09-21 19:34:05,161 attempt 1/10 2016-09-21 19:34:05,161 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/36b4cfcfaff3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 19:34:05,819 unpacking tar archive at: larch-36b4cfcfaff3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.931765 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 19:34:06.182377) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 19:34:06.183190) ========= script_repo_revision: 36b4cfcfaff31cc3e2a1bda6d0f9d92df831b154 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 19:34:06.184143) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 19:34:06.184823) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 19:34:06.206597) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-21 19:34:06.207272) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 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', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5hxi2y0kSd/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.UXonUZfis7/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 19:34:06 INFO - MultiFileLogger online at 20160921 19:34:06 in /builds/slave/test 19:34:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 19:34:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:34:06 INFO - {'append_to_log': False, 19:34:06 INFO - 'base_work_dir': '/builds/slave/test', 19:34:06 INFO - 'blob_upload_branch': 'Larch', 19:34:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:34:06 INFO - 'branch': 'Larch', 19:34:06 INFO - 'buildbot_json_path': 'buildprops.json', 19:34:06 INFO - 'config_files': ('talos/mac_config.py',), 19:34:06 INFO - 'default_actions': ('clobber', 19:34:06 INFO - 'read-buildbot-config', 19:34:06 INFO - 'download-and-extract', 19:34:06 INFO - 'populate-webroot', 19:34:06 INFO - 'create-virtualenv', 19:34:06 INFO - 'install', 19:34:06 INFO - 'run-tests'), 19:34:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:34:06 INFO - 'download_minidump_stackwalk': True, 19:34:06 INFO - 'download_symbols': 'ondemand', 19:34:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:34:06 INFO - 'tooltool.py': '/tools/tooltool.py', 19:34:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:34:06 INFO - '/tools/misc-python/virtualenv.py')}, 19:34:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:34:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:34:06 INFO - 'installer_path': 'installer.exe', 19:34:06 INFO - 'log_level': 'info', 19:34:06 INFO - 'log_name': 'talos', 19:34:06 INFO - 'log_to_console': True, 19:34:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:34:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:34:06 INFO - 'opt_config_files': (), 19:34:06 INFO - 'pip_index': False, 19:34:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:34:06 INFO - 'cmd': ('bash', 19:34:06 INFO - '-c', 19:34:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:34:06 INFO - 'enabled': True, 19:34:06 INFO - 'halt_on_failure': False, 19:34:06 INFO - 'name': 'check_screen_resolution'},), 19:34:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:34:06 INFO - 'cmd': ('bash', 19:34:06 INFO - '-c', 19:34:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:34:06 INFO - 'enabled': True, 19:34:06 INFO - 'halt_on_failure': False, 19:34:06 INFO - 'name': 'check_screen_resolution'},), 19:34:06 INFO - 'run_cmd_checks_enabled': True, 19:34:06 INFO - 'sps_profile': False, 19:34:06 INFO - 'sps_profile_interval': 0, 19:34:06 INFO - 'suite': 'dromaeojs-e10s', 19:34:06 INFO - 'system_bits': '32', 19:34:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:34:06 INFO - 'title': 't-yosemite-r7-0043', 19:34:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:34:06 INFO - 'use_talos_json': True, 19:34:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:34:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:34:06 INFO - 'work_dir': 'build'} 19:34:06 INFO - [mozharness: 2016-09-22 02:34:06.354440Z] Running clobber step. 19:34:06 INFO - Running pre-action listener: _resource_record_pre_action 19:34:06 INFO - Running main action method: clobber 19:34:06 INFO - rmtree: /builds/slave/test/build 19:34:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:34:07 INFO - Running post-action listener: _resource_record_post_action 19:34:07 INFO - [mozharness: 2016-09-22 02:34:07.253702Z] Finished clobber step (success) 19:34:07 INFO - [mozharness: 2016-09-22 02:34:07.253816Z] Running read-buildbot-config step. 19:34:07 INFO - Running pre-action listener: _resource_record_pre_action 19:34:07 INFO - Running main action method: read_buildbot_config 19:34:07 INFO - Using buildbot properties: 19:34:07 INFO - { 19:34:07 INFO - "project": "", 19:34:07 INFO - "product": "firefox", 19:34:07 INFO - "script_repo_revision": "production", 19:34:07 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs-e10s", 19:34:07 INFO - "repository": "", 19:34:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs-e10s", 19:34:07 INFO - "buildid": "20160921173106", 19:34:07 INFO - "pgo_build": "False", 19:34:07 INFO - "basedir": "/builds/slave/test", 19:34:07 INFO - "buildnumber": 4, 19:34:07 INFO - "slavename": "t-yosemite-r7-0043", 19:34:07 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 19:34:07 INFO - "platform": "yosemite_r7", 19:34:07 INFO - "scheduler": "tests-larch-macosx64-talos", 19:34:07 INFO - "branch": "larch", 19:34:07 INFO - "repo_path": "projects/larch", 19:34:07 INFO - "revision": "36b4cfcfaff31cc3e2a1bda6d0f9d92df831b154", 19:34:07 INFO - "stage_platform": "macosx64", 19:34:07 INFO - "builduid": "58c5dd34763d4260a770f013f4d9dc60", 19:34:07 INFO - "slavebuilddir": "test" 19:34:07 INFO - } 19:34:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 19:34:07 INFO - Running post-action listener: _resource_record_post_action 19:34:07 INFO - [mozharness: 2016-09-22 02:34:07.256655Z] Finished read-buildbot-config step (success) 19:34:07 INFO - [mozharness: 2016-09-22 02:34:07.256754Z] Running download-and-extract step. 19:34:07 INFO - Running pre-action listener: _resource_record_pre_action 19:34:07 INFO - Running main action method: download_and_extract 19:34:07 INFO - mkdir: /builds/slave/test/build/tests 19:34:07 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')]} 19:34:07 INFO - trying https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 19:34:07 INFO - Downloading https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 19:34:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 19:34:08 INFO - Downloaded 1199 bytes. 19:34:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 19:34:08 INFO - Using the following test package requirements: 19:34:08 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 19:34:08 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:34:08 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 19:34:08 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:34:08 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 19:34:08 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:34:08 INFO - u'jsshell-mac.zip'], 19:34:08 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:34:08 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 19:34:08 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 19:34:08 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:34:08 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 19:34:08 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:34:08 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 19:34:08 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:34:08 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 19:34:08 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 19:34:08 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 19:34:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:34:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 19:34:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:34:08 INFO - Fetch https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 19:34:09 INFO - Expected file size: 16432460 19:34:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:34:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 19:34:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:34:17 INFO - Fetch https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 19:34:17 INFO - Expected file size: 16432460 19:34:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 19:34:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:34:24 INFO - Fetch https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 19:34:24 INFO - Expected file size: 14414059 19:34:26 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')]} 19:34:26 INFO - trying https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 19:34:26 INFO - Downloading https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 19:34:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 19:34:28 INFO - Downloaded 111339256 bytes. 19:34:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 19:34:28 INFO - mkdir: /builds/slave/test/properties 19:34:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:34:28 INFO - Writing to file /builds/slave/test/properties/build_url 19:34:28 INFO - Contents: 19:34:28 INFO - build_url:https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 19:34:29 INFO - Running post-action listener: _resource_record_post_action 19:34:29 INFO - Running post-action listener: set_extra_try_arguments 19:34:29 INFO - [mozharness: 2016-09-22 02:34:29.641214Z] Finished download-and-extract step (success) 19:34:29 INFO - [mozharness: 2016-09-22 02:34:29.641354Z] Running populate-webroot step. 19:34:29 INFO - Running pre-action listener: _resource_record_pre_action 19:34:29 INFO - Running main action method: populate_webroot 19:34:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:34:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:34:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:34:29 INFO - '--tppagecycles', 19:34:29 INFO - '7'], 19:34:29 INFO - 'tests': ['tsvgm']}}, 19:34:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:34:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:34:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:34:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:34:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:34:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:34:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:34:29 INFO - 'talos_options': ['--disable-e10s'], 19:34:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:34:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:34:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:34:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:34:29 INFO - 'talos_options': ['--disable-e10s'], 19:34:29 INFO - 'tests': ['damp', 'tps']}, 19:34:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:34:29 INFO - 'tests': ['damp', 'tps']}, 19:34:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:34:29 INFO - 'tests': ['dromaeo_dom']}, 19:34:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:34:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:34:29 INFO - 'tests': ['basic_compositor_video']}, 19:34:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:34:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:34:29 INFO - 'tests': ['a11yr', 19:34:29 INFO - 'ts_paint', 19:34:29 INFO - 'tpaint', 19:34:29 INFO - 'sessionrestore', 19:34:29 INFO - 'sessionrestore_no_auto_restore', 19:34:29 INFO - 'tabpaint']}, 19:34:29 INFO - 'other-e10s': {'tests': ['a11yr', 19:34:29 INFO - 'ts_paint', 19:34:29 INFO - 'tpaint', 19:34:29 INFO - 'sessionrestore', 19:34:29 INFO - 'sessionrestore_no_auto_restore', 19:34:29 INFO - 'tabpaint']}, 19:34:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:34:29 INFO - 'ts_paint', 19:34:29 INFO - 'tpaint', 19:34:29 INFO - 'sessionrestore', 19:34:29 INFO - 'sessionrestore_no_auto_restore', 19:34:29 INFO - 'tabpaint']}, 19:34:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:34:29 INFO - 'ts_paint', 19:34:29 INFO - 'tpaint', 19:34:29 INFO - 'sessionrestore', 19:34:29 INFO - 'sessionrestore_no_auto_restore', 19:34:29 INFO - 'tabpaint']}, 19:34:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:34:29 INFO - 'tests': ['a11yr', 19:34:29 INFO - 'ts_paint', 19:34:29 INFO - 'tpaint', 19:34:29 INFO - 'sessionrestore', 19:34:29 INFO - 'sessionrestore_no_auto_restore', 19:34:29 INFO - 'tabpaint']}, 19:34:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:34:29 INFO - 'tests': ['a11yr', 19:34:29 INFO - 'ts_paint', 19:34:29 INFO - 'tpaint', 19:34:29 INFO - 'sessionrestore', 19:34:29 INFO - 'sessionrestore_no_auto_restore', 19:34:29 INFO - 'tabpaint']}, 19:34:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:34:29 INFO - 'tests': ['tsvgx', 19:34:29 INFO - 'tsvgr_opacity', 19:34:29 INFO - 'tart', 19:34:29 INFO - 'tscrollx', 19:34:29 INFO - 'cart']}, 19:34:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:34:29 INFO - 'tsvgr_opacity', 19:34:29 INFO - 'tart', 19:34:29 INFO - 'tscrollx', 19:34:29 INFO - 'cart']}, 19:34:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:34:29 INFO - 'talos_options': ['--disable-e10s'], 19:34:29 INFO - 'tests': ['tp5o']}, 19:34:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:34:29 INFO - 'tests': ['tp5o']}, 19:34:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:34:29 INFO - 'talos_options': ['--disable-e10s', 19:34:29 INFO - '--xperf_path', 19:34:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:34:29 INFO - 'tests': ['tp5n']}, 19:34:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:34:29 INFO - 'talos_options': ['--xperf_path', 19:34:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:34:29 INFO - 'tests': ['tp5n']}}, 19:34:29 INFO - 'talos.zip': {'path': '', 19:34:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:34:29 INFO - Running post-action listener: _resource_record_post_action 19:34:29 INFO - [mozharness: 2016-09-22 02:34:29.659506Z] Finished populate-webroot step (success) 19:34:29 INFO - [mozharness: 2016-09-22 02:34:29.659642Z] Running create-virtualenv step. 19:34:29 INFO - Running pre-action listener: _resource_record_pre_action 19:34:29 INFO - Running main action method: create_virtualenv 19:34:29 INFO - Creating virtualenv /builds/slave/test/build/venv 19:34:29 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 19:34:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:34:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:34:29 INFO - Using real prefix '/tools/python27' 19:34:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:34:30 INFO - Installing distribute.............................................................................................................................................................................................done. 19:34:33 INFO - Installing pip.................done. 19:34:33 INFO - Return code: 0 19:34:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c1ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c130570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e43455d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfced30>, '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 0x10bdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc6b20>, '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.5hxi2y0kSd/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.UXonUZfis7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 19:34:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:34:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5hxi2y0kSd/Render', 19:34:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:33 INFO - 'HOME': '/Users/cltbld', 19:34:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:33 INFO - 'LOGNAME': 'cltbld', 19:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:33 INFO - 'MOZ_NO_REMOTE': '1', 19:34:33 INFO - 'NO_EM_RESTART': '1', 19:34:33 INFO - 'PAGER': '/bin/cat', 19:34:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:33 INFO - 'PWD': '/builds/slave/test', 19:34:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:33 INFO - 'SHELL': '/bin/bash', 19:34:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXonUZfis7/Listeners', 19:34:33 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 19:34:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:33 INFO - 'USER': 'cltbld', 19:34:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:33 INFO - 'XPC_FLAGS': '0x0', 19:34:33 INFO - 'XPC_SERVICE_NAME': '0', 19:34:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:33 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 19:34:33 INFO - Cleaning up... 19:34:33 INFO - Return code: 0 19:34:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c1ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c130570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e43455d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfced30>, '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 0x10bdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc6b20>, '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.5hxi2y0kSd/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.UXonUZfis7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 19:34:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:34:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5hxi2y0kSd/Render', 19:34:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:33 INFO - 'HOME': '/Users/cltbld', 19:34:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:33 INFO - 'LOGNAME': 'cltbld', 19:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:33 INFO - 'MOZ_NO_REMOTE': '1', 19:34:33 INFO - 'NO_EM_RESTART': '1', 19:34:33 INFO - 'PAGER': '/bin/cat', 19:34:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:33 INFO - 'PWD': '/builds/slave/test', 19:34:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:33 INFO - 'SHELL': '/bin/bash', 19:34:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXonUZfis7/Listeners', 19:34:33 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 19:34:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:33 INFO - 'USER': 'cltbld', 19:34:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:33 INFO - 'XPC_FLAGS': '0x0', 19:34:33 INFO - 'XPC_SERVICE_NAME': '0', 19:34:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:33 INFO - Downloading/unpacking psutil>=3.1.1 19:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:34:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:34:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:34:36 INFO - Installing collected packages: psutil 19:34:36 INFO - Running setup.py install for psutil 19:34:36 INFO - building 'psutil._psutil_osx' extension 19:34:36 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 19:34:36 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 19:34:36 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 19:34:36 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 19:34:36 INFO - building 'psutil._psutil_posix' extension 19:34:36 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 19:34:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:34:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:34:37 INFO - ^ 19:34:37 INFO - 1 warning generated. 19:34:37 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 19:34:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:34:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:34:37 INFO - Successfully installed psutil 19:34:37 INFO - Cleaning up... 19:34:37 INFO - Return code: 0 19:34:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:34: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')]} 19:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34: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')]} 19:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c1ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c130570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e43455d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfced30>, '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 0x10bdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc6b20>, '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.5hxi2y0kSd/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.UXonUZfis7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 19:34: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:34: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 mozsystemmonitor==0.3 19:34:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5hxi2y0kSd/Render', 19:34:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:37 INFO - 'HOME': '/Users/cltbld', 19:34:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:37 INFO - 'LOGNAME': 'cltbld', 19:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:37 INFO - 'MOZ_NO_REMOTE': '1', 19:34:37 INFO - 'NO_EM_RESTART': '1', 19:34:37 INFO - 'PAGER': '/bin/cat', 19:34:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:37 INFO - 'PWD': '/builds/slave/test', 19:34:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:37 INFO - 'SHELL': '/bin/bash', 19:34:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXonUZfis7/Listeners', 19:34:37 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 19:34:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:37 INFO - 'USER': 'cltbld', 19:34:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:37 INFO - 'XPC_FLAGS': '0x0', 19:34:37 INFO - 'XPC_SERVICE_NAME': '0', 19:34:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:34: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 19:34: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 19:34: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 19:34: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 19:34: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 19:34: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 19:34:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:34:40 INFO - Installing collected packages: mozsystemmonitor 19:34:40 INFO - Running setup.py install for mozsystemmonitor 19:34:40 INFO - Successfully installed mozsystemmonitor 19:34:40 INFO - Cleaning up... 19:34:40 INFO - Return code: 0 19:34:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:34:40 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')]} 19:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:40 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')]} 19:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:40 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 0x10c1ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c130570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e43455d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfced30>, '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 0x10bdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc6b20>, '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.5hxi2y0kSd/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.UXonUZfis7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 19:34:40 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 19:34:40 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 19:34:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5hxi2y0kSd/Render', 19:34:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:40 INFO - 'HOME': '/Users/cltbld', 19:34:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:40 INFO - 'LOGNAME': 'cltbld', 19:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:40 INFO - 'MOZ_NO_REMOTE': '1', 19:34:40 INFO - 'NO_EM_RESTART': '1', 19:34:40 INFO - 'PAGER': '/bin/cat', 19:34:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:40 INFO - 'PWD': '/builds/slave/test', 19:34:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:40 INFO - 'SHELL': '/bin/bash', 19:34:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXonUZfis7/Listeners', 19:34:40 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 19:34:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:40 INFO - 'USER': 'cltbld', 19:34:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:40 INFO - 'XPC_FLAGS': '0x0', 19:34:40 INFO - 'XPC_SERVICE_NAME': '0', 19:34:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:40 INFO - Downloading/unpacking jsonschema==2.5.1 19:34: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 19:34: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 19:34: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 19:34: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 19:34: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 19:34: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 19:34:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:34:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:34:42 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 19:34:42 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 19:34:42 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 19:34:42 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 19:34:42 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 19:34:42 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 19:34:43 INFO - Downloading functools32-3.2.3-2.tar.gz 19:34:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:34:43 INFO - warning: no files found matching '*.txt' 19:34:43 INFO - no previously-included directories found matching 'build' 19:34:43 INFO - no previously-included directories found matching 'dist' 19:34:43 INFO - no previously-included directories found matching '.git*' 19:34:43 INFO - Installing collected packages: jsonschema, functools32 19:34:43 INFO - Running setup.py install for functools32 19:34:43 INFO - warning: no files found matching '*.txt' 19:34:43 INFO - no previously-included directories found matching 'build' 19:34:43 INFO - no previously-included directories found matching 'dist' 19:34:43 INFO - no previously-included directories found matching '.git*' 19:34:43 INFO - Successfully installed jsonschema functools32 19:34:43 INFO - Cleaning up... 19:34:43 INFO - Return code: 0 19:34:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:34:43 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')]} 19:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:44 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')]} 19:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:44 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 0x10c1ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c130570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e43455d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfced30>, '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 0x10bdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc6b20>, '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.5hxi2y0kSd/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.UXonUZfis7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 19:34:44 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 19:34:44 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 19:34:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5hxi2y0kSd/Render', 19:34:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:44 INFO - 'HOME': '/Users/cltbld', 19:34:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:44 INFO - 'LOGNAME': 'cltbld', 19:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:44 INFO - 'MOZ_NO_REMOTE': '1', 19:34:44 INFO - 'NO_EM_RESTART': '1', 19:34:44 INFO - 'PAGER': '/bin/cat', 19:34:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:44 INFO - 'PWD': '/builds/slave/test', 19:34:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:44 INFO - 'SHELL': '/bin/bash', 19:34:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXonUZfis7/Listeners', 19:34:44 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 19:34:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:44 INFO - 'USER': 'cltbld', 19:34:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:44 INFO - 'XPC_FLAGS': '0x0', 19:34:44 INFO - 'XPC_SERVICE_NAME': '0', 19:34:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:34:44 INFO - Cleaning up... 19:34:44 INFO - Return code: 0 19:34:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:34:44 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')]} 19:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:44 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')]} 19:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:44 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 0x10c1ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c130570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e43455d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfced30>, '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 0x10bdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc6b20>, '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.5hxi2y0kSd/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.UXonUZfis7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 19:34:44 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 19:34:44 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 19:34:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5hxi2y0kSd/Render', 19:34:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:44 INFO - 'HOME': '/Users/cltbld', 19:34:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:44 INFO - 'LOGNAME': 'cltbld', 19:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:44 INFO - 'MOZ_NO_REMOTE': '1', 19:34:44 INFO - 'NO_EM_RESTART': '1', 19:34:44 INFO - 'PAGER': '/bin/cat', 19:34:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:44 INFO - 'PWD': '/builds/slave/test', 19:34:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:44 INFO - 'SHELL': '/bin/bash', 19:34:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXonUZfis7/Listeners', 19:34:44 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 19:34:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:44 INFO - 'USER': 'cltbld', 19:34:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:44 INFO - 'XPC_FLAGS': '0x0', 19:34:44 INFO - 'XPC_SERVICE_NAME': '0', 19:34:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:44 INFO - Downloading/unpacking blobuploader==1.2.4 19:34: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 19:34: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 19:34: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 19:34: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 19:34: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 19:34: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 19:34:47 INFO - Downloading blobuploader-1.2.4.tar.gz 19:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:34:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:34:47 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 19:34:47 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 19:34:47 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 19:34:47 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 19:34:47 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 19:34:47 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 19:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:34:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:48 INFO - Downloading docopt-0.6.1.tar.gz 19:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:34:48 INFO - Installing collected packages: blobuploader, requests, docopt 19:34:48 INFO - Running setup.py install for blobuploader 19:34:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:34:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:34:48 INFO - Running setup.py install for requests 19:34:49 INFO - Running setup.py install for docopt 19:34:49 INFO - Successfully installed blobuploader requests docopt 19:34:49 INFO - Cleaning up... 19:34:49 INFO - Return code: 0 19:34:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:34:49 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')]} 19:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:49 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')]} 19:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:49 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 0x10c1ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c130570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e43455d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfced30>, '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 0x10bdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc6b20>, '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.5hxi2y0kSd/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.UXonUZfis7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 19:34:49 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 19:34:49 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 19:34:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5hxi2y0kSd/Render', 19:34:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:49 INFO - 'HOME': '/Users/cltbld', 19:34:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:49 INFO - 'LOGNAME': 'cltbld', 19:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:49 INFO - 'MOZ_NO_REMOTE': '1', 19:34:49 INFO - 'NO_EM_RESTART': '1', 19:34:49 INFO - 'PAGER': '/bin/cat', 19:34:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:49 INFO - 'PWD': '/builds/slave/test', 19:34:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:49 INFO - 'SHELL': '/bin/bash', 19:34:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXonUZfis7/Listeners', 19:34:49 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 19:34:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:49 INFO - 'USER': 'cltbld', 19:34:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:49 INFO - 'XPC_FLAGS': '0x0', 19:34:49 INFO - 'XPC_SERVICE_NAME': '0', 19:34:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:34:49 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-7XpCbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:34:50 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-QV0PUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:34:50 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-jEgND1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:34:50 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-RTdw4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:34:50 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-7KvXti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:34:50 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-IDN83M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:34:50 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-1PsyX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:34:50 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-EeLtPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:34:50 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-evd_48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:34:50 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-R9PISz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:34:50 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-nSHh2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:34:51 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-iGI3lY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:34:51 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-Y0yQwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:34:51 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-HxhcJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:34:51 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-OBYH_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:34:51 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-Yd9Fue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:34:51 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-Zs3LIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:34:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:34:51 INFO - Running setup.py install for manifestparser 19:34:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:34:51 INFO - Running setup.py install for mozcrash 19:34:52 INFO - Running setup.py install for mozdebug 19:34:52 INFO - Running setup.py install for mozdevice 19:34:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:34:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:34:52 INFO - Running setup.py install for mozfile 19:34:52 INFO - Running setup.py install for mozhttpd 19:34:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:34:52 INFO - Running setup.py install for mozinfo 19:34:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:34:52 INFO - Running setup.py install for mozInstall 19:34:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:34:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:34:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:34:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:34:52 INFO - Running setup.py install for mozleak 19:34:53 INFO - Running setup.py install for mozlog 19:34:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:34:53 INFO - Running setup.py install for moznetwork 19:34:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:34:53 INFO - Running setup.py install for mozprocess 19:34:53 INFO - Running setup.py install for mozprofile 19:34:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:34:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:34:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:34:53 INFO - Running setup.py install for mozrunner 19:34:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:34:53 INFO - Running setup.py install for mozscreenshot 19:34:53 INFO - Running setup.py install for moztest 19:34:54 INFO - Running setup.py install for mozversion 19:34:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:34:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:34:54 INFO - Cleaning up... 19:34:54 INFO - Return code: 0 19:34:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:54 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 0x10c1ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c130570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e43455d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfced30>, '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 0x10bdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc6b20>, '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.5hxi2y0kSd/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.UXonUZfis7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 19:34:54 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 19:34:54 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 19:34:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5hxi2y0kSd/Render', 19:34:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:54 INFO - 'HOME': '/Users/cltbld', 19:34:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:54 INFO - 'LOGNAME': 'cltbld', 19:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:54 INFO - 'MOZ_NO_REMOTE': '1', 19:34:54 INFO - 'NO_EM_RESTART': '1', 19:34:54 INFO - 'PAGER': '/bin/cat', 19:34:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:54 INFO - 'PWD': '/builds/slave/test', 19:34:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:54 INFO - 'SHELL': '/bin/bash', 19:34:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXonUZfis7/Listeners', 19:34:54 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 19:34:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:54 INFO - 'USER': 'cltbld', 19:34:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:54 INFO - 'XPC_FLAGS': '0x0', 19:34:54 INFO - 'XPC_SERVICE_NAME': '0', 19:34:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:34:54 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-N9Uqg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:34:54 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)) 19:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:34:54 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-b4CHgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:34:54 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)) 19:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:34:54 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-FBZLym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:34:54 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)) 19:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:34:54 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-f9SZcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:34:54 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)) 19:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:34:54 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-wSGHMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:34:55 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)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:34:55 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-9npZrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:34:55 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)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:34:55 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-ahhuDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:34:55 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)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:34:55 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-Ey4mQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:34:55 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)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:34:55 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-wv2E74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:34:55 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)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:34:55 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-NP9z07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:34:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:34:55 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-Wm0TwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:34:55 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)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:34:55 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-5U4yM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:34:55 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)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:34:55 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-sgvKDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:34:55 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)) 19:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:34:55 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-vxcr1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:34:56 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)) 19:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:34:56 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-fw1nft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:34:56 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)) 19:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:34:56 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-ULwm4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:34:56 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)) 19:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:34:56 INFO - Running setup.py (path:/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/pip-_Q_Dm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:34:56 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)) 19:34:56 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)) 19:34:56 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)) 19:34:56 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)) 19:34:56 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)) 19:34:56 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)) 19:34:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:34:56 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 19:34:56 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 19:34:56 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 19:34:56 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 19:34:56 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 19:34:56 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 19:34:58 INFO - Downloading blessings-1.6.tar.gz 19:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:34:58 INFO - Installing collected packages: blessings 19:34:58 INFO - Running setup.py install for blessings 19:34:59 INFO - Successfully installed blessings 19:34:59 INFO - Cleaning up... 19:34:59 INFO - Return code: 0 19:34:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:34:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:34:59 INFO - Reading from file tmpfile_stdout 19:34:59 INFO - Current package versions: 19:34:59 INFO - blessings == 1.6 19:34:59 INFO - blobuploader == 1.2.4 19:34:59 INFO - docopt == 0.6.1 19:34:59 INFO - functools32 == 3.2.3-2 19:34:59 INFO - jsonschema == 2.5.1 19:34:59 INFO - manifestparser == 1.1 19:34:59 INFO - mozInstall == 1.12 19:34:59 INFO - mozcrash == 0.17 19:34:59 INFO - mozdebug == 0.1 19:34:59 INFO - mozdevice == 0.48 19:34:59 INFO - mozfile == 1.2 19:34:59 INFO - mozhttpd == 0.7 19:34:59 INFO - mozinfo == 0.9 19:34:59 INFO - mozleak == 0.1 19:34:59 INFO - mozlog == 3.4 19:34:59 INFO - moznetwork == 0.27 19:34:59 INFO - mozprocess == 0.23 19:34:59 INFO - mozprofile == 0.28 19:34:59 INFO - mozrunner == 6.12 19:34:59 INFO - mozscreenshot == 0.1 19:34:59 INFO - mozsystemmonitor == 0.3 19:34:59 INFO - moztest == 0.7 19:34:59 INFO - mozversion == 1.4 19:34:59 INFO - psutil == 3.1.1 19:34:59 INFO - requests == 1.2.3 19:34:59 INFO - wsgiref == 0.1.2 19:34:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:59 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 0x10c1ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c130570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e43455d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfced30>, '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 0x10bdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc6b20>, '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.5hxi2y0kSd/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.UXonUZfis7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 19:34:59 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 19:34:59 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 19:34:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5hxi2y0kSd/Render', 19:34:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:59 INFO - 'HOME': '/Users/cltbld', 19:34:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:59 INFO - 'LOGNAME': 'cltbld', 19:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:59 INFO - 'MOZ_NO_REMOTE': '1', 19:34:59 INFO - 'NO_EM_RESTART': '1', 19:34:59 INFO - 'PAGER': '/bin/cat', 19:34:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:59 INFO - 'PWD': '/builds/slave/test', 19:34:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:59 INFO - 'SHELL': '/bin/bash', 19:34:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXonUZfis7/Listeners', 19:34:59 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 19:34:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:59 INFO - 'USER': 'cltbld', 19:34:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:59 INFO - 'XPC_FLAGS': '0x0', 19:34:59 INFO - 'XPC_SERVICE_NAME': '0', 19:34:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:59 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)) 19:34:59 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)) 19:34:59 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)) 19:34:59 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)) 19:34:59 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)) 19:34:59 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)) 19:34:59 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)) 19:34:59 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)) 19:34:59 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)) 19:34:59 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)) 19:34:59 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)) 19:34:59 INFO - Cleaning up... 19:34:59 INFO - Return code: 0 19:34:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:34:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c1ba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c130570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e43455d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfced30>, '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 0x10bdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc6b20>, '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.5hxi2y0kSd/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.UXonUZfis7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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 19:34:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:34:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5hxi2y0kSd/Render', 19:34:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:34:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:34:59 INFO - 'HOME': '/Users/cltbld', 19:34:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:34:59 INFO - 'LOGNAME': 'cltbld', 19:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:34:59 INFO - 'MOZ_NO_REMOTE': '1', 19:34:59 INFO - 'NO_EM_RESTART': '1', 19:34:59 INFO - 'PAGER': '/bin/cat', 19:34:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:34:59 INFO - 'PWD': '/builds/slave/test', 19:34:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:34:59 INFO - 'SHELL': '/bin/bash', 19:34:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXonUZfis7/Listeners', 19:34:59 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 19:34:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:34:59 INFO - 'USER': 'cltbld', 19:34:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:34:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:34:59 INFO - 'XPC_FLAGS': '0x0', 19:34:59 INFO - 'XPC_SERVICE_NAME': '0', 19:34:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:34:59 INFO - Cleaning up... 19:35:00 INFO - Return code: 0 19:35:00 INFO - Running post-action listener: _resource_record_post_action 19:35:00 INFO - Running post-action listener: _start_resource_monitoring 19:35:00 INFO - Starting resource monitoring. 19:35:00 INFO - [mozharness: 2016-09-22 02:35:00.035607Z] Finished create-virtualenv step (success) 19:35:00 INFO - [mozharness: 2016-09-22 02:35:00.036570Z] Running install step. 19:35:00 INFO - Running pre-action listener: _resource_record_pre_action 19:35:00 INFO - Running main action method: install 19:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:35:00 INFO - Reading from file tmpfile_stdout 19:35:00 INFO - Detecting whether we're running mozinstall >=1.0... 19:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:35:00 INFO - Reading from file tmpfile_stdout 19:35:00 INFO - Output received: 19:35:00 INFO - Usage: mozinstall [options] installer 19:35:00 INFO - Options: 19:35:00 INFO - -h, --help show this help message and exit 19:35:00 INFO - -d DEST, --destination=DEST 19:35:00 INFO - Directory to install application into. [default: 19:35:00 INFO - "/builds/slave/test"] 19:35:00 INFO - --app=APP Application being installed. [default: firefox] 19:35:00 INFO - mkdir: /builds/slave/test/build/application 19:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:35:34 INFO - Reading from file tmpfile_stdout 19:35:34 INFO - Output received: 19:35:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:35:34 INFO - Running post-action listener: _resource_record_post_action 19:35:34 INFO - [mozharness: 2016-09-22 02:35:34.962746Z] Finished install step (success) 19:35:34 INFO - [mozharness: 2016-09-22 02:35:34.962864Z] Running run-tests step. 19:35:34 INFO - Running pre-action listener: _resource_record_pre_action 19:35:34 INFO - Running main action method: run_tests 19:35:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:35:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:35:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:35:34 INFO - 2016-09-21 19:35:34.977 screenresolution[1933:14871] starting screenresolution argv=screenresolution get 19:35:34 INFO - 2016-09-21 19:35:34.980 screenresolution[1933:14871] Display 0: 1600x1200x32@60 19:35:34 INFO - 2016-09-21 19:35:34.986 screenresolution[1934:14873] starting screenresolution argv=screenresolution list 19:35:34 INFO - Available Modes on Display 0 19:35:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:35:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:35:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:35:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:35:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:35:35 INFO - Intel Iris: 19:35:35 INFO - Chipset Model: Intel Iris 19:35:35 INFO - Type: GPU 19:35:35 INFO - Bus: Built-In 19:35:35 INFO - VRAM (Dynamic, Max): 1536 MB 19:35:35 INFO - Vendor: Intel (0x8086) 19:35:35 INFO - Device ID: 0x0a2e 19:35:35 INFO - Revision ID: 0x0009 19:35:35 INFO - Displays: 19:35:35 INFO - Display: 19:35:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:35:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:35:35 INFO - Display Serial Number: 1600x1200 60 19:35:35 INFO - Main Display: Yes 19:35:35 INFO - Mirror: Off 19:35:35 INFO - Online: Yes 19:35:35 INFO - Rotation: Supported 19:35:35 INFO - Return code: 0 19:35:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:35:35 INFO - Python 2.7.3 19:35:35 INFO - Return code: 0 19:35:35 INFO - grabbing minidump binary from tooltool 19:35:35 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')]} 19:35:35 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 0x10bfced30>, '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 0x10bdf4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:35:35 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 19:35:35 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 19:35:35 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 19:35:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:35:35 INFO - Return code: 0 19:35:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:35:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:35:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:35:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:35:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:35:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0043', '--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 19:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0043 --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 19:35:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5hxi2y0kSd/Render', 19:35:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:35:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:35:35 INFO - 'HOME': '/Users/cltbld', 19:35:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:35:35 INFO - 'LOGNAME': 'cltbld', 19:35:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:35:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:35:35 INFO - 'MOZ_NO_REMOTE': '1', 19:35:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:35:35 INFO - 'NO_EM_RESTART': '1', 19:35:35 INFO - 'PAGER': '/bin/cat', 19:35:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:35:35 INFO - 'PWD': '/builds/slave/test', 19:35:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:35:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:35:35 INFO - 'SHELL': '/bin/bash', 19:35:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UXonUZfis7/Listeners', 19:35:35 INFO - 'TMPDIR': '/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/', 19:35:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:35:35 INFO - 'USER': 'cltbld', 19:35:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:35:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:35:35 INFO - 'XPC_FLAGS': '0x0', 19:35:35 INFO - 'XPC_SERVICE_NAME': '0', 19:35:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:35:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0043', '--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 19:35:35 INFO - mozversion application_buildid: 20160921173106 19:35:35 INFO - mozversion application_changeset: 36b4cfcfaff31cc3e2a1bda6d0f9d92df831b154 19:35:35 INFO - mozversion application_display_name: Nightly 19:35:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:35:35 INFO - mozversion application_name: Firefox 19:35:35 INFO - mozversion application_remotingname: firefox 19:35:35 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 19:35:35 INFO - mozversion application_vendor: Mozilla 19:35:35 INFO - mozversion application_version: 52.0a1 19:35:35 INFO - mozversion platform_buildid: 20160921173106 19:35:35 INFO - mozversion platform_changeset: 36b4cfcfaff31cc3e2a1bda6d0f9d92df831b154 19:35:35 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 19:35:35 INFO - mozversion platform_version: 52.0a1 19:35:35 INFO - using testdate: 1474511735 19:35:35 INFO - actual date: 1474511735 19:35:35 INFO - starting webserver on 'localhost:49435' 19:35:35 INFO - SUITE-START | Running 2 tests 19:35:35 INFO - TEST-START | dromaeo_css 19:35:35 INFO - operating with platform_type : mac_ 19:35:35 INFO - Initialising browser for dromaeo_css test... 19:35:35 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmpSeo7N9/profile http://localhost:49435/getInfo.html) 19:35:38 INFO - PROCESS | 1944 | __metrics Screen width/height:1600/1200 19:35:38 INFO - PROCESS | 1944 | colorDepth:24 19:35:38 INFO - PROCESS | 1944 | Browser inner width/height: 1024/689 19:35:38 INFO - PROCESS | 1944 | __metrics 19:35:38 ERROR - PROCESS | 1944 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 19:35:39 INFO - TEST-INFO | 1944: exit 0 19:35:39 INFO - Browser initialized. 19:35:39 INFO - Running cycle 1/1 for dromaeo_css test... 19:35:39 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmpSeo7N9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:35:51 INFO - PROCESS | 1947 | RSS: Main: 243998720 19:35:51 INFO - PROCESS | 1947 | 19:36:40 INFO - PROCESS | 1947 | 1474511800840 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] 19:38:52 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49435/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49435/tests/dromaeo/cssquery-ext.html) 19:38:53 INFO - PROCESS | 1947 | RSS: Main: 256888832 19:38:53 INFO - PROCESS | 1947 | 19:41:56 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49435/tests/dromaeo/cssquery-ext.html (next: http://localhost:49435/tests/dromaeo/cssquery-jquery.html) 19:41:56 INFO - PROCESS | 1947 | RSS: Main: 267386880 19:41:56 INFO - PROCESS | 1947 | 19:44:58 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49435/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49435/tests/dromaeo/cssquery-mootools.html) 19:44:59 INFO - PROCESS | 1947 | RSS: Main: 272060416 19:44:59 INFO - PROCESS | 1947 | 19:48:01 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49435/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49435/tests/dromaeo/cssquery-prototype.html) 19:48:01 INFO - PROCESS | 1947 | RSS: Main: 271663104 19:48:01 INFO - PROCESS | 1947 | 19:51:04 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49435/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49435/tests/dromaeo/cssquery-yui.html) 19:51:05 INFO - PROCESS | 1947 | RSS: Main: 277098496 19:51:05 INFO - PROCESS | 1947 | 19:54:08 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:49435/tests/dromaeo/cssquery-yui.html (next: http://localhost:49435/tests/dromaeo/cssquery-dojo.html) 19:54:08 INFO - PROCESS | 1947 | RSS: Main: 279879680 19:54:08 INFO - PROCESS | 1947 | 19:54:08 INFO - PROCESS | 1947 | __start_tp_report 19:54:08 INFO - PROCESS | 1947 | _x_x_mozilla_page_load 19:54:08 INFO - PROCESS | 1947 | _x_x_mozilla_page_load_details 19:54:08 INFO - PROCESS | 1947 | |i|pagename|runs| 19:54:08 INFO - PROCESS | 1947 | |0;dojo.html;3250.642429332773;3299.488579270214;3318.767686261962;3327.3511665225274;3345.732341412687;4607.907841843165;5627.887442251153;5637.21079048933;5650.830475085754;5670.659760414378;5537.529310008644;5652.180433837091;5672.659640421578;5675.517581005609;5695.971520142404;5158.452464260726;5168.043911876305;5218.843434696965;5253.311307705324;5299.231611416342;4489.5285994970545;5199.168133098705;5248.370195576517;5284.154535274357;5300.125479295931;5109.897802043938;5132.56373208274;5162.251473536354;5216.374035115772;5220.791168353261;5168.01807656544;5170.896582068338;5171.637985341028;5214;5217.660852044605;5147.382314122292;5150.768215430315;5154.484551544853;5209;5211.322528071364;4131.5248746394245;5464.153056276284;5490.972545137289;5557.221988921554;5582.609217354787;6102.822530596007;6115.51416190291;6170.84572885677;6173.228346456693;6182.938170618281;6174.228221472316;6183.041628547582;6221.9688901555655;6224.097505861625;6246.0630905364105;4309.008927946527;5426.538744206708;5685.317761868561;5708.115242137434;5749.31008279005;6147.370946699129;6185.381461853779;6211.3167551569295;6259.937400625936;6275.466585340206;5988.850278742979;6058.363871793486;6071.51427885768;6072.392760723892;6101.84745381369;5954;6123.663198524124;6135.693215339215;6139.201903752483;6146.815595532141;6012.428819262163;6080.939190608037;6093.238345206849;6104.8779024420155;6105.945000794801;6125.75438176821;6145.139680444741;6152.692365381713;6154.78458253959;6160.507159427235;4875.463698993108;4881.780319885614;4890.364252647133;4901.754912254444;4932.235503496964;4329.480462344476;4345.543717909574;4375.846845360397;4388.2320593896575;4441.244988351988;5778.3643799182055;5811.912821307684;5880.617759845596;5890.970545147246;5910.556708246899;6149.723262453201;6169.753209871555;6170.691465426711;6182.567220294536;6183.938160618426;5007.324011258506;5693.60144789869;5750.3099628044065;5874.794382196603;5896.086106653475;5324.494173053554;5352.464753524617;5364.704941228192;5391.56867450603;5430.864228394322;6221.657808820558;6229.034499652561;6249.437550620466;6270.498360131179;6275.309715931244;6056.091586262096;6157.9384206157365;6226.62640241587;6234.064890266496;6236;6155.569110162246;6171.444569988723;6223.906641400292;6233.594816336924;6236.75052997875;6108.267007958895;6130.816075517741;6137.987232106652;6149.538784591084;6161.383861613803;5845.035569131046;6100.450959413674;6119.07606531266;6231.345708700703;6249.812505624838;5678.432156784289;5698.373178950229;5710.771569137188;5715.31416230055;5719.399463056319;5628.043232650377;5668.801591944262;5669.262995810684;5684.9431505684415;5693.4875861172695;4501.167284052461;5513.696746678971;5536.363318218296;5554.583406244467;5634.267545219095;5961.076033214858;6004.8498787528915;6039.275286965592;6134.834381467507;6144.2319710036245;5327.733613319241;5907.675077870758;5923.437273459014;5932.466078052996;5938.584299099194 19:54:08 INFO - PROCESS | 1947 | |1;ext.html;465.3996344715317;473.2191883392404;494.69576210630464;533.6424595521;540.5810496864931;39094.804525977364;41722.582774172246;41979.580204197984;43755;43819.78090109553;43035.784821075926;43532.12935741291;43633;43662.90842728933;43673.12653746923;9796.118349348575;9990.150837178848;9998.25013124015;10017.148542373907;10022.398656080659;9869.259805514579;9921.75195620108;9936;9951.303408761389;9960.053794889474;9920.702378928607;9951.90048099517;9973.252006099536;9973.551190196458;9987.450690212036;9902.306838521306;9945.353552019167;9947.75130621733;9952.452615106165;9956.601735930553;9739.707808765748;9766.07222313886;9770.804583908353;9788.021197880225;9813.558389872473;41188.58811411878;41244.968875778344;41398.58601413977;41562.58437415618;41748.58251417477;3317.104381816896;3381.661833816623;3571.821408929543;3892.3772196448717;3926.509186351706;28485.287867803265;28719.71280287212;30850;31262.21844453884;32204.677953220402;3190.7925984810913;3228.660990595977;3295.653956334574;3330.2673411849355;3401.3027329397414;507705;510782;513338;514698;514801;61413;61417.38582614206;61760;61807.381926181064;61835.381646183865;64361.67819160968;64464.67767661132;64669.67665161644;64714.35285647177;64898.351016490175;16593.50219493417;16650.084245366623;16705;16787;16841.157942102847;10998.780024399468;12857.228566286052;12989.805152922525;13009.21944683322;13059.738805224033;14720.484783032542;14845.183514906785;16725.163741813103;17965.461036168937;18006;5286.60350473716;6024.969875150597;6454.225492940784;6480.611163330121;6480.935190648033;815.8939337886037;818.8444195602816;826.1490664615455;992.7815880506278;1083.3770581915273;29936.05415647976;30463.847680761897;30801.38397232043;31133.377332453223;31141.688583114334;921.755734730297;1025.820481415764;1043.3479075577764;1152.7060599547062;1173.6537721372215;15369.462068827537;15913.761293580606;15953.282102305191;16032.272237089173;16312.51062468128;678362;684263;684940.9035457788;685801;686046;57818.13272800911;58680.119798203064;58733.70633146807;58958.41041589529;59111.11333330003;1350.4868150102898;1360.7346567419456;1372.1286982766017;1381.730562540295;1386.202933313349;28976;29838.10485685433;30124.849375753856;30360.935243530064;30801.075967721004;43397.56602433935;43584;52324.47675523196;52384.47615523796;52441.213381800066;620262;626044;627770;627945.8602706958;631601;26607;26687.866560667073;26976.055838045573;27040.72959270382;27354;46891.29663055125;47437;48220.758896206695;48413.757931210115;48848;34437.48343774895;39386.606133938294;39616.80191599023;40346;40412.79793601013;37537.624623754506;39025.414618780174;39282.554250836205;40272.597274026884;40462.1907561853;34977.475337869444;37344.43983340306;37833.810830945666;38590;38625.80687096546;30900.690993089782;34000.93991540773;34695.65304347025;34870;35072.47391289082;23929.16247931314;25383.87308063448;25462.490750184523;25653.3586660335;26052.869735651202 19:54:08 INFO - PROCESS | 1947 | |2;jquery.html;374.8088474877813;380.00438850212447;382.1916646293088;383.2526573182294;400.25552472401347;18182.545436364097;18944.52638684032;20847.478813029662;20966.790332096676;21071.367858964237;16646.0844653544;20195.39413817584;20734.585308293863;21095.2616658417;21105.050272737724;5008.924866127011;5750.597458177929;5984.251968503937;5992.610480318765;6044.153818465418;5924.200232968558;5976;5981.342052374235;6055.727492262837;6072.757089716428;5721.828345149652;5991.011483105304;6022.217111775485;6072.544559158081;6112.572119951606;5868.530517558585;6060.545459090564;6083.117947897552;6083.908741368883;6104.481119104881;5853.47318741311;5898;5903.616264942765;5928.851778705567;5931.673757943311;12969.54606588765;13238.602841914759;13269.203847769164;13422.261775602337;13451.394687239097;1986.6424043672134;2194.5830292244423;2581.186926118267;2937.3684657798462;2962.955555666667;10416.947915260374;11006.614768483065;13118.016148788784;15165;15955.20223988796;1815.4553633909775;1873.5971766070224;1906.733057371969;1910.7993660665568;1964.5481539246055;121995;125484;126667;127018.72981270161;128677;9569.904300956901;11074.944625276983;11334.489947952361;11490.712732181762;11533.538658453735;14416.783748243784;14427.35076921541;14438.133711977314;14443.78334324986;14444.988850780555;8325.66697332112;8485.95757021211;8569.657213711507;8671.56642167889;8692.261157801659;7000.614966176808;7180.3537681608905;7951;8562.229399353964;8577.01364343096;4460;4463.553644635575;4477.440319960005;4479.552044795494;4490.191765482245;1520.4982355822551;1909.150428059528;1917.712343148511;1925.1433112264908;1953;860.337540094124;890.9599068041954;927.7912469694264;947.6304241345881;989.475577943691;20382.388528344174;21632;22164.292028106094;22792.43018924507;22970.65544016841;825.5718649877082;868.7133246028795;924.4499522784067;924.4776701163821;985.8718366612438;10839.620613278497;11018.834717479083;11242.775144497227;11263.43682815856;11263.549458021751;606218;616928;619860;634006;635495;106023;128742;140461.2976935109;143452.28273858564;147198;1016.6594190946116;1020.5611587017505;1050.4327663062013;1098.4672433869566;1100.2133474565724;19176;19911.26780090715;19986.500337491678;20144.89927550353;20170.193192272145;40730.59269407268;55826.44173558213;57615.711921440125;57650;58314;58029;73903.26096738964;75035.62482187554;80369.59815200887;80504.3899122026;4535.639308207458;5414.83755487336;6240.939040363059;6255.71849266775;6744.898826517704;7241.891371629325;9361.391509551857;10397.220208484243;10907.83638245411;11751.471183796579;9015.459072455411;10195.337303075275;10375.273730839072;11493.94253028763;11746.29522228669;11188.776224475629;11512.19414640967;11540.94229528847;11566.016888564229;11888.227265227733;11548.158851960936;11665.650030499099;11846.348450835287;11966.940165299466;11974.042076634023;6963.825904352431;8139;8179.10029896699;8189.50862948225;8406.537640429835;10838.512266948164;11254.718632034264;11633.069354451793;11678.766424671629;11737.530498780296 19:54:08 INFO - PROCESS | 1947 | |3;mootools.html;1311.6327428320071;1495.4840579999895;1671.2479384277071;1836.4582448177787;1862.2550979608147;8047.758567242978;8327.91737074181;8426.873596896052;8972.596233169506;9036.141566551176;8521.488710677364;8804.867926981084;8834.60244289007;8955.507447090407;8982.37123401362;2346.1671106757112;2391.7249516305674;2397.30478161333;2400.3399065257017;2401.2556107606697;2036.3483685220735;2076.805836643928;2393.4734358441115;2397.30478161333;2408.5664580375524;2356.2813341930705;2375.2185860604545;2378.5599664062115;2394.1022116706235;2405.494846082325;2357.4577847095265;2360.386299562109;2378.143868207444;2382.737898831127;2388.5461762265113;2150.817180539656;2279.3959600705825;2368.9052437902637;2371;2375.9762402375927;8894.332925030583;8898.688545900926;8935.910640893639;8943.55282235892;8991.28069754418;4427.003924117048;5235.293235413209;5246.580273578143;5398.946010539923;5406.351237851443;3519.894403167909;3627.437747149196;3691.630836916314;3692.6861216796606;3699.8705045323286;888.595688961521;1060.9098226650744;1061.7080302916681;1069.6897899609105;1083.3987137138886;9538.380005299634;11656.41717914101;11661.941690291578;11683.065354771683;11697.47361368732;3884.76691398517;4714.88212794676;4822.059698358787;4837.588804951619;4843.709377437365;8666.78333041679;9346.691463195159;9959.900400995897;9965.900340996497;9994.600215991279;4535.863924082283;5334.786608535615;5340.49265319794;5353.304070470814;5357.785688572413;4381.452318460192;4536.956500005017;4713.316569097462;4862.270659401047;4874.025194961022;3648.1973965727498;3773.9433908491396;3876.534815822063;3986.421968814506;4031.879043628696;1149.3908228638668;1300.830891984036;1317.8155058291848;1325.15190278222;1328.5350127455313;842.8326767427158;852.3436953545735;905.4567259644292;913.1142791492242;927.8515437529962;5666.716664166775;5684.8863022739315;5928.822135335947;6014.578979471483;6070;910.5356268303213;942.4157022646003;945.3004776465503;958.0850287974968;1001.2740762946805;3938.6849052075763;3954.8022598869943;3998.220347032359;4075.5109386873764;4088.652464540488;10658.680239592824;10893.183011274186;10909;10913.781724365626;10959.342439453658;9346.299027572959;10846.728831779268;10849.240553161202;10857.565697372016;10884.40135792539;8088.191180881865;8201.753947381589;8203;8204.958975205085;8211.876821847676;4511.1654343946475;5101.51535604117;5660.716964151694;5733.741981610754;5770.422957704196;8802.471851688919;9807.313488055768;9869.654562090293;10001.649942252277;10002.29983901149;9840.852387214341;10014.599416023277;10075.244356673426;10227.130693891102;10311.07200351972;6568.146141001639;6758.357955994173;6828.078209441662;7040.647967601497;7115.039469671735;8277.213664701843;8419.536925469158;8447.070822209429;8503.91496085056;8505.617247223767;6492;7439.92560074414;7538.509996850187;7569.318761311509;7709.151993280847;6211.720472578835;6437;6557.9344206557325;6756.4257038150345;7354.154272258758;6570.047343135314;6873.828154296182;6883.862322753416;6954.9652251740445;6969.128858892638;4528.230200865926;5000.099982003274;5020.849374518771;5039.445660977363;5044.1424957756535;4942.777575009205;5015.84952451427;5023.397192336943;5092.567131793839;5127.692338459704 19:54:08 INFO - PROCESS | 1947 | |4;prototype.html;295.9570862224976;305.5783019433182;310.3885345868638;314.0766147526273;318.1981406854726;5176.249443830642;5288.682679039251;5357.598180136486;5488.807891723791;5518.751656175472;5000.299958005873;5007.399112106552;5278.12910869707;5316.229146773716;5358.973205133969;2886.4515742008953;3965.4250133730593;3993.9201215975663;4111;4116.382542618601;3839.0786211309223;4080.9387859182134;4097.422492340441;4113.675773188154;4155.168966206756;4007.6793856491413;4054.837806487737;4058.289799285128;4070.328395814687;4084.346504559271;3862.343401621731;4077.7145599808027;4077.97961010196;4087.305158123126;4099.733517321394;3138.450771115046;3257.6742325767473;3427.160345715291;3550.946735798965;3560.6439356064448;4958.718989264942;5058.696478211319;5163.8192663256605;5191.948080519184;5233.555147812441;4650.372199753024;4660.440747110335;4677.859664210079;4681.859544213679;4764.475907650156;5097.974510127463;5546.334439867242;5667.1782591524;5669.744861481243;5680.046375884558;3407.9659203407896;3430.485427185917;3531.3643544162296;3739.5138631977943;3759.3609086455094;4750.61995040396;5908.911366329508;5940.2871655401195;5987.221661184019;6030.50230866101;3882.3400021995762;3885.592012838668;3885.922281554353;3894.883153505399;3894.9610503894596;3793.715471339661;3830.272248272819;3877.825497852547;3940.822662980173;3950.881473555798;3960.9701477616027;4335.544767799399;4425.636516247675;4552.908941821212;4583.793729282191;4758.595519380891;5671.914921276184;5676.0551416765775;5707.885842283131;5712.7714891403875;1100.9669709908715;1258.2702032820941;1310.2269660900115;1327.6922231601864;1332.1274565159836;786.2216405758372;861.866410706329;864.6930339729431;871.877937088808;886.2068448738343;5213.452587478336;5306.442823503554;5318.484231993863;5345;5412.891742165135;5746.511546518509;5762.625429347079;5771.59598828078;5794.82615521535;5795.3193573863955;4911.852644420602;5034.723090230073;5282.392524859613;5339.546138578265;5360.472265404341;2220.7668194839307;2238.641817309223;2595.4030572968322;2626.6979297380663;2638.630591717161;4426.955730442719;4654.767261636905;4705.55297246761;4904.117258893433;5149.871253218699;5047.974760126176;5089.592832573385;5097.9745101275;5598.964191624563;6083.574149809471;5363.973180133997;6102.131997960952;6124.877502449926;6180.690965451709;6192.553941193113;5643.097104463266;5855.414458554111;5927.733252003756;5940.1683764272175;5957.523398128053;5490.368607610176;5670.234518339971;5812.796552120655;5814.476697097281;5860.443257890493;5188.547206782107;5338.958903013875;6197.349278325892;6199.876002480015;6210.391635513186;3612.7832330060282;3770.6606405423645;3807.5621303550447;3897.8830635080994;3911.3155197840833;5547.611667183259;5715.428457154251;5791.218185544897;5811.215485909348;5833.883322333445;5408.486193811582;5515;5634.408387119457;5705.348576910864;5732.426757324234;5093.388793344822;5260.816761044124;5664.37691853904;5666.914996275142;5734.569907256889;4712.986707857827;5095.847124586268;5193.558547523352;5618.606697531133;5665.745041473226;4968.981358821361;5636.5208957237455;5672.149177623224;5716.256886604715;5721.256236689203;5119.948800511947;5326.36083669962;5598.748056337556;5616.494515493625;5640.446518693197 19:54:08 INFO - PROCESS | 1947 | |5;yui.html;719.6042176802757;768.7539987204093;793.9523628582282;796.1481215099843;815.0993152566416;15447.613809654751;16079.83920160798;16090.919545402287;16100.83899161008;16136.273867675938;14373.20947347898;14421.062630928982;14470.131792092481;14473.927630361859;14530.418783248657;665.2482694555146;687.7867860963117;750.7484992527483;817.6851912013888;818.9058258300312;838.8238469921293;854.747849384433;854.8076682746363;855.9443636163661;859.9656013759442;816.5998660656265;905.1265528764741;907.5190149220923;907.587047893207;909.495230147268;667.8712975072112;761.402299195132;826.4215049465338;900.4192295969096;904.1275169461468;660.4320284555279;669.0566301514889;669.0967194287673;669.2704951602776;670.3430637974764;14599.854001460062;14617.415303387852;14678.853211467855;14704.55886323412;14759;14528.200948947804;14651.267436628126;14660.780088298685;14730.55808325752;14806.851931480764;10574.682759517149;11644.243124196984;11872.52509899603;11946.044316454663;12001.93999030008;3802.790846503441;3832.2143960488033;3857.498525191735;3871.5160604924386;4010.83956641734;117962;120258;121549;122300.38849805783;123310;9546.284028697875;11074.667759967213;11184.60853870127;11268.54925802975;11516.078713702884;22740.65889011666;22750;22788.544229115323;22796.2021329256;22871.771282287296;8069.556174410463;8141.0230772307705;8154.796130096795;8156.265936065783;8221.54781487024;4092.8158232878995;4283.250431174532;4293.69944103916;4333.306670932636;4399.6040356368085;3491.6159222485508;3613.530241068644;3614.6023937366867;3627.0750958505414;3866.3233934061427;710.9111361079865;717.673706279158;722.4401089155946;726.2374506767873;727.1092911183757;554.3901708121115;600.4145957691217;611.6574718157846;614.3457218062749;645.6642545876213;7872.567008814455;9458.763530911645;9577.425354478753;9686.418814871131;9706.90293097074;624.7157543317779;640.5804198250154;659.535027805396;670.2325836916704;678.4301187002941;4261.509926358509;4281.101765854781;4702.764861756898;4840.1287768201355;4853.878653033632;88762.22475550453;97473.51263243638;132432.70269189123;151301;151686;109935;111764.76470470545;115086.4245678783;116576.41711791557;116728;79331;80965.19034809695;94569;101052;106815.7161926373;7839.9216007839195;9607;9936.006399360007;10045.69862904114;10051.84403793573;46864;52225.73887130692;60810;60903.60120773423;62532.68733656302;78971.60514197392;90973.54513227656;94820.52589737007;95409;95696;12703;13176.934115329363;13206;13439.731205375641;13694.808830587457;13232.735345293233;13715.1085179467;13880.305984700522;13986.790198146833;14028.579142625738;13168.868311316764;13531.458741650224;13710.52013179534;13929.791053134413;14049;13173.538926137539;13646.385912634154;13828.723425531232;14116.294185290899;14301.35643896048;11797.941010294893;13569.728605428034;13589.254498458376;13830.226507270643;13992.510262140777;11236.381998990135;11363.431828408711;11423.371714555778;11519.596814111466;11788.764224715285;8569.442986205877;10459.58161673555;10727.785444291227;11025.44872756343;11515.424228788695 19:54:08 INFO - PROCESS | 1947 | __end_tp_report 19:54:08 INFO - PROCESS | 1947 | __start_cc_report 19:54:08 INFO - PROCESS | 1947 | _x_x_mozilla_cycle_collect,361 19:54:08 INFO - PROCESS | 1947 | __end_cc_report 19:54:08 INFO - PROCESS | 1947 | __startTimestamp1474512848454__endTimestamp 19:54:08 INFO - PROCESS | 1947 | 19:54:08 INFO - PROCESS | 1947 | ------- Summary: start ------- 19:54:08 INFO - PROCESS | 1947 | Number of tests: 6 19:54:08 INFO - PROCESS | 1947 | 19:54:08 INFO - PROCESS | 1947 | [#0] dojo.html Cycles:165 Average:5624.63 Median:5749.31 stddev:656.41 (11.4%) stddev-sans-first:631.46 19:54:08 INFO - PROCESS | 1947 | Values: 3250.6 3299.5 3318.8 3327.4 3345.7 4607.9 5627.9 5637.2 5650.8 5670.7 5537.5 5652.2 5672.7 5675.5 5696.0 5158.5 5168.0 5218.8 5253.3 5299.2 4489.5 5199.2 5248.4 5284.2 5300.1 5109.9 5132.6 5162.3 5216.4 5220.8 5168.0 5170.9 5171.6 5214.0 5217.7 5147.4 5150.8 5154.5 5209.0 5211.3 4131.5 5464.2 5491.0 5557.2 5582.6 6102.8 6115.5 6170.8 6173.2 6182.9 6174.2 6183.0 6222.0 6224.1 6246.1 4309.0 5426.5 5685.3 5708.1 5749.3 6147.4 6185.4 6211.3 6259.9 6275.5 5988.9 6058.4 6071.5 6072.4 6101.8 5954.0 6123.7 6135.7 6139.2 6146.8 6012.4 6080.9 6093.2 6104.9 6105.9 6125.8 6145.1 6152.7 6154.8 6160.5 4875.5 4881.8 4890.4 4901.8 4932.2 4329.5 4345.5 4375.8 4388.2 4441.2 5778.4 5811.9 5880.6 5891.0 5910.6 6149.7 6169.8 6170.7 6182.6 6183.9 5007.3 5693.6 5750.3 5874.8 5896.1 5324.5 5352.5 5364.7 5391.6 5430.9 6221.7 6229.0 6249.4 6270.5 6275.3 6056.1 6157.9 6226.6 6234.1 6236.0 6155.6 6171.4 6223.9 6233.6 6236.8 6108.3 6130.8 6138.0 6149.5 6161.4 5845.0 6100.5 6119.1 6231.3 6249.8 5678.4 5698.4 5710.8 5715.3 5719.4 5628.0 5668.8 5669.3 5684.9 5693.5 4501.2 5513.7 5536.4 5554.6 5634.3 5961.1 6004.8 6039.3 6134.8 6144.2 5327.7 5907.7 5923.4 5932.5 5938.6 19:54:08 INFO - PROCESS | 1947 | 19:54:08 INFO - PROCESS | 1947 | [#1] ext.html Cycles:180 Average:73681.11 Median:41480.59 stddev:163776.81 (394.8%) stddev-sans-first:164144.00 19:54:08 INFO - PROCESS | 1947 | Values: 465.4 473.2 494.7 533.6 540.6 39094.8 41722.6 41979.6 43755.0 43819.8 43035.8 43532.1 43633.0 43662.9 43673.1 9796.1 9990.2 9998.3 10017.1 10022.4 9869.3 9921.8 9936.0 9951.3 9960.1 9920.7 9951.9 9973.3 9973.6 9987.5 9902.3 9945.4 9947.8 9952.5 9956.6 9739.7 9766.1 9770.8 9788.0 9813.6 41188.6 41245.0 41398.6 41562.6 41748.6 3317.1 3381.7 3571.8 3892.4 3926.5 28485.3 28719.7 30850.0 31262.2 32204.7 3190.8 3228.7 3295.7 3330.3 3401.3 507705.0 510782.0 513338.0 514698.0 514801.0 61413.0 61417.4 61760.0 61807.4 61835.4 64361.7 64464.7 64669.7 64714.4 64898.4 16593.5 16650.1 16705.0 16787.0 16841.2 10998.8 12857.2 12989.8 13009.2 13059.7 14720.5 14845.2 16725.2 17965.5 18006.0 5286.6 6025.0 6454.2 6480.6 6480.9 815.9 818.8 826.1 992.8 1083.4 29936.1 30463.8 30801.4 31133.4 31141.7 921.8 1025.8 1043.3 1152.7 1173.7 15369.5 15913.8 15953.3 16032.3 16312.5 678362.0 684263.0 684940.9 685801.0 686046.0 57818.1 58680.1 58733.7 58958.4 59111.1 1350.5 1360.7 1372.1 1381.7 1386.2 28976.0 29838.1 30124.8 30360.9 30801.1 43397.6 43584.0 52324.5 52384.5 52441.2 620262.0 626044.0 627770.0 627945.9 631601.0 26607.0 26687.9 26976.1 27040.7 27354.0 46891.3 47437.0 48220.8 48413.8 48848.0 34437.5 39386.6 39616.8 40346.0 40412.8 37537.6 39025.4 39282.6 40272.6 40462.2 34977.5 37344.4 37833.8 38590.0 38625.8 30900.7 34000.9 34695.7 34870.0 35072.5 23929.2 25383.9 25462.5 25653.4 26052.9 19:54:08 INFO - PROCESS | 1947 | 19:54:08 INFO - PROCESS | 1947 | [#2] jquery.html Cycles:180 Average:35644.78 Median:22478.36 stddev:104067.68 (463.0%) stddev-sans-first:104325.92 19:54:08 INFO - PROCESS | 1947 | Values: 374.8 380.0 382.2 383.3 400.3 18182.5 18944.5 20847.5 20966.8 21071.4 16646.1 20195.4 20734.6 21095.3 21105.1 5008.9 5750.6 5984.3 5992.6 6044.2 5924.2 5976.0 5981.3 6055.7 6072.8 5721.8 5991.0 6022.2 6072.5 6112.6 5868.5 6060.5 6083.1 6083.9 6104.5 5853.5 5898.0 5903.6 5928.9 5931.7 12969.5 13238.6 13269.2 13422.3 13451.4 1986.6 2194.6 2581.2 2937.4 2963.0 10416.9 11006.6 13118.0 15165.0 15955.2 1815.5 1873.6 1906.7 1910.8 1964.5 121995.0 125484.0 126667.0 127018.7 128677.0 9569.9 11074.9 11334.5 11490.7 11533.5 14416.8 14427.4 14438.1 14443.8 14445.0 8325.7 8486.0 8569.7 8671.6 8692.3 7000.6 7180.4 7951.0 8562.2 8577.0 4460.0 4463.6 4477.4 4479.6 4490.2 1520.5 1909.2 1917.7 1925.1 1953.0 860.3 891.0 927.8 947.6 989.5 20382.4 21632.0 22164.3 22792.4 22970.7 825.6 868.7 924.4 924.5 985.9 10839.6 11018.8 11242.8 11263.4 11263.5 606218.0 616928.0 619860.0 634006.0 635495.0 106023.0 128742.0 140461.3 143452.3 147198.0 1016.7 1020.6 1050.4 1098.5 1100.2 19176.0 19911.3 19986.5 20144.9 20170.2 40730.6 55826.4 57615.7 57650.0 58314.0 58029.0 73903.3 75035.6 80369.6 80504.4 4535.6 5414.8 6240.9 6255.7 6744.9 7241.9 9361.4 10397.2 10907.8 11751.5 9015.5 10195.3 10375.3 11493.9 11746.3 11188.8 11512.2 11540.9 11566.0 11888.2 11548.2 11665.7 11846.3 11966.9 11974.0 6963.8 8139.0 8179.1 8189.5 8406.5 10838.5 11254.7 11633.1 11678.8 11737.5 19:54:08 INFO - PROCESS | 1947 | 19:54:08 INFO - PROCESS | 1947 | [#3] mootools.html Cycles:180 Average:5626.28 Median:5018.35 stddev:3157.36 (62.9%) stddev-sans-first:3149.57 19:54:08 INFO - PROCESS | 1947 | Values: 1311.6 1495.5 1671.2 1836.5 1862.3 8047.8 8327.9 8426.9 8972.6 9036.1 8521.5 8804.9 8834.6 8955.5 8982.4 2346.2 2391.7 2397.3 2400.3 2401.3 2036.3 2076.8 2393.5 2397.3 2408.6 2356.3 2375.2 2378.6 2394.1 2405.5 2357.5 2360.4 2378.1 2382.7 2388.5 2150.8 2279.4 2368.9 2371.0 2376.0 8894.3 8898.7 8935.9 8943.6 8991.3 4427.0 5235.3 5246.6 5398.9 5406.4 3519.9 3627.4 3691.6 3692.7 3699.9 888.6 1060.9 1061.7 1069.7 1083.4 9538.4 11656.4 11661.9 11683.1 11697.5 3884.8 4714.9 4822.1 4837.6 4843.7 8666.8 9346.7 9959.9 9965.9 9994.6 4535.9 5334.8 5340.5 5353.3 5357.8 4381.5 4537.0 4713.3 4862.3 4874.0 3648.2 3773.9 3876.5 3986.4 4031.9 1149.4 1300.8 1317.8 1325.2 1328.5 842.8 852.3 905.5 913.1 927.9 5666.7 5684.9 5928.8 6014.6 6070.0 910.5 942.4 945.3 958.1 1001.3 3938.7 3954.8 3998.2 4075.5 4088.7 10658.7 10893.2 10909.0 10913.8 10959.3 9346.3 10846.7 10849.2 10857.6 10884.4 8088.2 8201.8 8203.0 8205.0 8211.9 4511.2 5101.5 5660.7 5733.7 5770.4 8802.5 9807.3 9869.7 10001.6 10002.3 9840.9 10014.6 10075.2 10227.1 10311.1 6568.1 6758.4 6828.1 7040.6 7115.0 8277.2 8419.5 8447.1 8503.9 8505.6 6492.0 7439.9 7538.5 7569.3 7709.2 6211.7 6437.0 6557.9 6756.4 7354.2 6570.0 6873.8 6883.9 6955.0 6969.1 4528.2 5000.1 5020.8 5039.4 5044.1 4942.8 5015.8 5023.4 5092.6 5127.7 19:54:08 INFO - PROCESS | 1947 | 19:54:08 INFO - PROCESS | 1947 | [#4] prototype.html Cycles:180 Average:4550.50 Median:5134.91 stddev:1439.07 (28.0%) stddev-sans-first:1407.23 19:54:08 INFO - PROCESS | 1947 | Values: 296.0 305.6 310.4 314.1 318.2 5176.2 5288.7 5357.6 5488.8 5518.8 5000.3 5007.4 5278.1 5316.2 5359.0 2886.5 3965.4 3993.9 4111.0 4116.4 3839.1 4080.9 4097.4 4113.7 4155.2 4007.7 4054.8 4058.3 4070.3 4084.3 3862.3 4077.7 4078.0 4087.3 4099.7 3138.5 3257.7 3427.2 3550.9 3560.6 4958.7 5058.7 5163.8 5191.9 5233.6 4650.4 4660.4 4677.9 4681.9 4764.5 5098.0 5546.3 5667.2 5669.7 5680.0 3408.0 3430.5 3531.4 3739.5 3759.4 4750.6 5908.9 5940.3 5987.2 6030.5 3882.3 3885.6 3885.9 3894.9 3895.0 3793.7 3830.3 3877.8 3940.8 3950.9 3961.0 4335.5 4425.6 4552.9 4583.8 4758.6 5671.9 5676.1 5707.9 5712.8 1101.0 1258.3 1310.2 1327.7 1332.1 786.2 861.9 864.7 871.9 886.2 5213.5 5306.4 5318.5 5345.0 5412.9 5746.5 5762.6 5771.6 5794.8 5795.3 4911.9 5034.7 5282.4 5339.5 5360.5 2220.8 2238.6 2595.4 2626.7 2638.6 4427.0 4654.8 4705.6 4904.1 5149.9 5048.0 5089.6 5098.0 5599.0 6083.6 5364.0 6102.1 6124.9 6180.7 6192.6 5643.1 5855.4 5927.7 5940.2 5957.5 5490.4 5670.2 5812.8 5814.5 5860.4 5188.5 5339.0 6197.3 6199.9 6210.4 3612.8 3770.7 3807.6 3897.9 3911.3 5547.6 5715.4 5791.2 5811.2 5833.9 5408.5 5515.0 5634.4 5705.3 5732.4 5093.4 5260.8 5664.4 5666.9 5734.6 4713.0 5095.8 5193.6 5618.6 5665.7 4969.0 5636.5 5672.1 5716.3 5721.3 5119.9 5326.4 5598.7 5616.5 5640.4 19:54:08 INFO - PROCESS | 1947 | 19:54:08 INFO - PROCESS | 1947 | [#5] yui.html Cycles:180 Average:23464.09 Median:3844.86 stddev:36405.13 (946.9%) stddev-sans-first:36467.20 19:54:08 INFO - PROCESS | 1947 | Values: 719.6 768.8 794.0 796.1 815.1 15447.6 16079.8 16090.9 16100.8 16136.3 14373.2 14421.1 14470.1 14473.9 14530.4 665.2 687.8 750.7 817.7 818.9 838.8 854.7 854.8 855.9 860.0 816.6 905.1 907.5 907.6 909.5 667.9 761.4 826.4 900.4 904.1 660.4 669.1 669.1 669.3 670.3 14599.9 14617.4 14678.9 14704.6 14759.0 14528.2 14651.3 14660.8 14730.6 14806.9 10574.7 11644.2 11872.5 11946.0 12001.9 3802.8 3832.2 3857.5 3871.5 4010.8 117962.0 120258.0 121549.0 122300.4 123310.0 9546.3 11074.7 11184.6 11268.5 11516.1 22740.7 22750.0 22788.5 22796.2 22871.8 8069.6 8141.0 8154.8 8156.3 8221.5 4092.8 4283.3 4293.7 4333.3 4399.6 3491.6 3613.5 3614.6 3627.1 3866.3 710.9 717.7 722.4 726.2 727.1 554.4 600.4 611.7 614.3 645.7 7872.6 9458.8 9577.4 9686.4 9706.9 624.7 640.6 659.5 670.2 678.4 4261.5 4281.1 4702.8 4840.1 4853.9 88762.2 97473.5 132432.7 151301.0 151686.0 109935.0 111764.8 115086.4 116576.4 116728.0 79331.0 80965.2 94569.0 101052.0 106815.7 7839.9 9607.0 9936.0 10045.7 10051.8 46864.0 52225.7 60810.0 60903.6 62532.7 78971.6 90973.5 94820.5 95409.0 95696.0 12703.0 13176.9 13206.0 13439.7 13694.8 13232.7 13715.1 13880.3 13986.8 14028.6 13168.9 13531.5 13710.5 13929.8 14049.0 13173.5 13646.4 13828.7 14116.3 14301.4 11797.9 13569.7 13589.3 13830.2 13992.5 11236.4 11363.4 11423.4 11519.6 11788.8 8569.4 10459.6 10727.8 11025.4 11515.4 19:54:08 INFO - PROCESS | 1947 | -------- Summary: end -------- 19:54:08 INFO - PROCESS | 1947 | 19:54:09 INFO - TEST-INFO | 1947: exit 0 19:54:09 INFO - TEST-OK | dromaeo_css | took 1113529ms 19:54:09 INFO - TEST-START | kraken 19:54:09 INFO - operating with platform_type : mac_ 19:54:09 INFO - Initialising browser for kraken test... 19:54:09 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmpREz5GW/profile http://localhost:49435/getInfo.html) 19:54:11 INFO - PROCESS | 1952 | __metrics Screen width/height:1600/1200 19:54:11 INFO - PROCESS | 1952 | colorDepth:24 19:54:11 INFO - PROCESS | 1952 | Browser inner width/height: 1024/689 19:54:11 INFO - PROCESS | 1952 | __metrics 19:54:11 ERROR - PROCESS | 1952 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 19:54:12 INFO - TEST-INFO | 1952: exit 0 19:54:12 INFO - Browser initialized. 19:54:12 INFO - Running cycle 1/1 for kraken test... 19:54:12 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/T/tmpREz5GW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:54:24 INFO - PROCESS | 1954 | RSS: Main: 244166656 19:54:24 INFO - PROCESS | 1954 | 19:54:27 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49435/tests/kraken/driver.html?testName=audio-beat-detection) 19:54:28 INFO - PROCESS | 1954 | RSS: Main: 255987712 19:54:28 INFO - PROCESS | 1954 | 19:54:31 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49435/tests/kraken/driver.html?testName=audio-dft) 19:54:31 INFO - PROCESS | 1954 | RSS: Main: 263438336 19:54:31 INFO - PROCESS | 1954 | 19:54:35 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49435/tests/kraken/driver.html?testName=audio-fft) 19:54:35 INFO - PROCESS | 1954 | RSS: Main: 262766592 19:54:35 INFO - PROCESS | 1954 | 19:54:37 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49435/tests/kraken/driver.html?testName=audio-oscillator) 19:54:38 INFO - PROCESS | 1954 | RSS: Main: 263561216 19:54:38 INFO - PROCESS | 1954 | 19:54:40 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49435/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:54:41 INFO - PROCESS | 1954 | RSS: Main: 264605696 19:54:41 INFO - PROCESS | 1954 | 19:54:43 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49435/tests/kraken/driver.html?testName=imaging-darkroom) 19:54:44 INFO - PROCESS | 1954 | RSS: Main: 265252864 19:54:44 INFO - PROCESS | 1954 | 19:54:47 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49435/tests/kraken/driver.html?testName=imaging-desaturate) 19:54:48 INFO - PROCESS | 1954 | RSS: Main: 265445376 19:54:48 INFO - PROCESS | 1954 | 19:54:51 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49435/tests/kraken/driver.html?testName=json-parse-financial) 19:54:51 INFO - PROCESS | 1954 | RSS: Main: 265859072 19:54:51 INFO - PROCESS | 1954 | 19:54:53 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49435/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:54:54 INFO - PROCESS | 1954 | RSS: Main: 265342976 19:54:54 INFO - PROCESS | 1954 | 19:54:56 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49435/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:54:56 INFO - PROCESS | 1954 | RSS: Main: 265383936 19:54:56 INFO - PROCESS | 1954 | 19:54:58 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49435/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:54:59 INFO - PROCESS | 1954 | RSS: Main: 265338880 19:54:59 INFO - PROCESS | 1954 | 19:55:02 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:55:03 INFO - PROCESS | 1954 | RSS: Main: 265785344 19:55:03 INFO - PROCESS | 1954 | 19:55:05 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:55:06 INFO - PROCESS | 1954 | RSS: Main: 265854976 19:55:06 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:49435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49435/tests/kraken/driver.html?testName=ai-astar) 19:55:08 INFO - PROCESS | 1954 | RSS: Main: 267436032 19:55:08 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | __start_tp_report 19:55:08 INFO - PROCESS | 1954 | _x_x_mozilla_page_load 19:55:08 INFO - PROCESS | 1954 | _x_x_mozilla_page_load_details 19:55:08 INFO - PROCESS | 1954 | |i|pagename|runs| 19:55:08 INFO - PROCESS | 1954 | |0;ai-astar;114;119;118;113;117;118;116;119;121;153 19:55:08 INFO - PROCESS | 1954 | |1;audio-beat-detection;146;113;111;137;134;137;139;118;142;109 19:55:08 INFO - PROCESS | 1954 | |2;audio-dft;201;208;234;197;267;200;195;195;200;273 19:55:08 INFO - PROCESS | 1954 | |3;audio-fft;82;56;54;83;61;59;61;78;99;59 19:55:08 INFO - PROCESS | 1954 | |4;audio-oscillator;91;71;87;74;71;96;113;71;72;84 19:55:08 INFO - PROCESS | 1954 | |5;imaging-gaussian-blur;89;87;88;86;89;85;89;86;89;86 19:55:08 INFO - PROCESS | 1954 | |6;imaging-darkroom;96;94;95;99;95;101;151;119;95;96 19:55:08 INFO - PROCESS | 1954 | |7;imaging-desaturate;147;140;91;90;76;143;150;143;121;93 19:55:08 INFO - PROCESS | 1954 | |8;json-parse-financial;58;56;56;57;56;58;56;57;57;56 19:55:08 INFO - PROCESS | 1954 | |9;json-stringify-tinderbox;73;72;74;82;79;69;71;78;100;93 19:55:08 INFO - PROCESS | 1954 | |10;stanford-crypto-aes;88;91;90;88;88;84;91;92;85;111 19:55:08 INFO - PROCESS | 1954 | |11;stanford-crypto-ccm;139;141;138;137;143;148;158;157;153;146 19:55:08 INFO - PROCESS | 1954 | |12;stanford-crypto-pbkdf2;221;225;172;170;169;172;170;168;169;169 19:55:08 INFO - PROCESS | 1954 | |13;stanford-crypto-sha256-iterative;70;68;70;70;69;69;70;67;69;70 19:55:08 INFO - PROCESS | 1954 | __end_tp_report 19:55:08 INFO - PROCESS | 1954 | __start_cc_report 19:55:08 INFO - PROCESS | 1954 | _x_x_mozilla_cycle_collect,956 19:55:08 INFO - PROCESS | 1954 | __end_cc_report 19:55:08 INFO - PROCESS | 1954 | __startTimestamp1474512908593__endTimestamp 19:55:08 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | ------- Summary: start ------- 19:55:08 INFO - PROCESS | 1954 | Number of tests: 14 19:55:08 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | [#0] ai-astar Cycles:10 Average:120.80 Median:118.50 stddev:11.56 (9.8%) stddev-sans-first:12.00 19:55:08 INFO - PROCESS | 1954 | Values: 114.0 119.0 118.0 113.0 117.0 118.0 116.0 119.0 121.0 153.0 19:55:08 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:137.00 stddev:14.18 (10.4%) stddev-sans-first:13.57 19:55:08 INFO - PROCESS | 1954 | Values: 146.0 113.0 111.0 137.0 134.0 137.0 139.0 118.0 142.0 109.0 19:55:08 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | [#2] audio-dft Cycles:10 Average:217.00 Median:204.50 stddev:30.20 (14.8%) stddev-sans-first:31.47 19:55:08 INFO - PROCESS | 1954 | Values: 201.0 208.0 234.0 197.0 267.0 200.0 195.0 195.0 200.0 273.0 19:55:08 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | [#3] audio-fft Cycles:10 Average:69.20 Median:69.50 stddev:15.16 (21.8%) stddev-sans-first:15.35 19:55:08 INFO - PROCESS | 1954 | Values: 82.0 56.0 54.0 83.0 61.0 59.0 61.0 78.0 99.0 59.0 19:55:08 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | [#4] audio-oscillator Cycles:10 Average:83.00 Median:79.00 stddev:14.08 (17.8%) stddev-sans-first:14.63 19:55:08 INFO - PROCESS | 1954 | Values: 91.0 71.0 87.0 74.0 71.0 96.0 113.0 71.0 72.0 84.0 19:55:08 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.50 stddev:1.58 (1.8%) stddev-sans-first:1.56 19:55:08 INFO - PROCESS | 1954 | Values: 89.0 87.0 88.0 86.0 89.0 85.0 89.0 86.0 89.0 86.0 19:55:08 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | [#6] imaging-darkroom Cycles:10 Average:104.10 Median:95.00 stddev:18.07 (19.0%) stddev-sans-first:18.93 19:55:08 INFO - PROCESS | 1954 | Values: 96.0 94.0 95.0 99.0 95.0 101.0 151.0 119.0 95.0 96.0 19:55:08 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | [#7] imaging-desaturate Cycles:10 Average:119.40 Median:113.00 stddev:28.85 (25.5%) stddev-sans-first:28.82 19:55:08 INFO - PROCESS | 1954 | Values: 147.0 140.0 91.0 90.0 76.0 143.0 150.0 143.0 121.0 93.0 19:55:08 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.73 19:55:08 INFO - PROCESS | 1954 | Values: 58.0 56.0 56.0 57.0 56.0 58.0 56.0 57.0 57.0 56.0 19:55:08 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | [#9] json-stringify-tinderbox Cycles:10 Average:79.10 Median:76.00 stddev:10.12 (13.3%) stddev-sans-first:10.49 19:55:08 INFO - PROCESS | 1954 | Values: 73.0 72.0 74.0 82.0 79.0 69.0 71.0 78.0 100.0 93.0 19:55:08 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:89.00 stddev:7.55 (8.5%) stddev-sans-first:7.94 19:55:08 INFO - PROCESS | 1954 | Values: 88.0 91.0 90.0 88.0 88.0 84.0 91.0 92.0 85.0 111.0 19:55:08 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:147.00 stddev:7.79 (5.3%) stddev-sans-first:7.84 19:55:08 INFO - PROCESS | 1954 | Values: 139.0 141.0 138.0 137.0 143.0 148.0 158.0 157.0 153.0 146.0 19:55:08 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.50 Median:171.00 stddev:22.46 (13.1%) stddev-sans-first:18.43 19:55:08 INFO - PROCESS | 1954 | Values: 221.0 225.0 172.0 170.0 169.0 172.0 170.0 168.0 169.0 169.0 19:55:08 INFO - PROCESS | 1954 | 19:55:08 INFO - PROCESS | 1954 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:70.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 19:55:08 INFO - PROCESS | 1954 | Values: 70.0 68.0 70.0 70.0 69.0 69.0 70.0 67.0 69.0 70.0 19:55:08 INFO - PROCESS | 1954 | -------- Summary: end -------- 19:55:08 INFO - PROCESS | 1954 | 19:55:09 INFO - TEST-INFO | 1954: exit 0 19:55:09 INFO - TEST-OK | kraken | took 60348ms 19:55:09 INFO - SUITE-END | took 1173s 19:55:09 INFO - Completed test suite (00:19:34) 19:55:09 INFO - javascript benchmark 19:55:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7298.879217175967, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3250.642429332773, 3299.488579270214, 3318.767686261962, 3327.3511665225274, 3345.732341412687, 4607.907841843165, 5627.887442251153, 5637.21079048933, 5650.830475085754, 5670.659760414378, 5537.529310008644, 5652.180433837091, 5672.659640421578, 5675.517581005609, 5695.971520142404, 5158.452464260726, 5168.043911876305, 5218.843434696965, 5253.311307705324, 5299.231611416342, 4489.5285994970545, 5199.168133098705, 5248.370195576517, 5284.154535274357, 5300.125479295931, 5109.897802043938, 5132.56373208274, 5162.251473536354, 5216.374035115772, 5220.791168353261, 5168.01807656544, 5170.896582068338, 5171.637985341028, 5214.0, 5217.660852044605, 5147.382314122292, 5150.768215430315, 5154.484551544853, 5209.0, 5211.322528071364, 4131.5248746394245, 5464.153056276284, 5490.972545137289, 5557.221988921554, 5582.609217354787, 6102.822530596007, 6115.51416190291, 6170.84572885677, 6173.228346456693, 6182.938170618281, 6174.228221472316, 6183.041628547582, 6221.9688901555655, 6224.097505861625, 6246.0630905364105, 4309.008927946527, 5426.538744206708, 5685.317761868561, 5708.115242137434, 5749.31008279005, 6147.370946699129, 6185.381461853779, 6211.3167551569295, 6259.937400625936, 6275.466585340206, 5988.850278742979, 6058.363871793486, 6071.51427885768, 6072.392760723892, 6101.84745381369, 5954.0, 6123.663198524124, 6135.693215339215, 6139.201903752483, 6146.815595532141, 6012.428819262163, 6080.939190608037, 6093.238345206849, 6104.8779024420155, 6105.945000794801, 6125.75438176821, 6145.139680444741, 6152.692365381713, 6154.78458253959, 6160.507159427235, 4875.463698993108, 4881.780319885614, 4890.364252647133, 4901.754912254444, 4932.235503496964, 4329.480462344476, 4345.543717909574, 4375.846845360397, 4388.2320593896575, 4441.244988351988, 5778.3643799182055, 5811.912821307684, 5880.617759845596, 5890.970545147246, 5910.556708246899, 6149.723262453201, 6169.753209871555, 6170.691465426711, 6182.567220294536, 6183.938160618426, 5007.324011258506, 5693.60144789869, 5750.3099628044065, 5874.794382196603, 5896.086106653475, 5324.494173053554, 5352.464753524617, 5364.704941228192, 5391.56867450603, 5430.864228394322, 6221.657808820558, 6229.034499652561, 6249.437550620466, 6270.498360131179, 6275.309715931244, 6056.091586262096, 6157.9384206157365, 6226.62640241587, 6234.064890266496, 6236.0, 6155.569110162246, 6171.444569988723, 6223.906641400292, 6233.594816336924, 6236.75052997875, 6108.267007958895, 6130.816075517741, 6137.987232106652, 6149.538784591084, 6161.383861613803, 5845.035569131046, 6100.450959413674, 6119.07606531266, 6231.345708700703, 6249.812505624838, 5678.432156784289, 5698.373178950229, 5710.771569137188, 5715.31416230055, 5719.399463056319, 5628.043232650377, 5668.801591944262, 5669.262995810684, 5684.9431505684415, 5693.4875861172695, 4501.167284052461, 5513.696746678971, 5536.363318218296, 5554.583406244467, 5634.267545219095, 5961.076033214858, 6004.8498787528915, 6039.275286965592, 6134.834381467507, 6144.2319710036245, 5327.733613319241, 5907.675077870758, 5923.437273459014, 5932.466078052996, 5938.584299099194], "value": 5583.909654213255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.3996344715317, 473.2191883392404, 494.69576210630464, 533.6424595521, 540.5810496864931, 39094.804525977364, 41722.582774172246, 41979.580204197984, 43755.0, 43819.78090109553, 43035.784821075926, 43532.12935741291, 43633.0, 43662.90842728933, 43673.12653746923, 9796.118349348575, 9990.150837178848, 9998.25013124015, 10017.148542373907, 10022.398656080659, 9869.259805514579, 9921.75195620108, 9936.0, 9951.303408761389, 9960.053794889474, 9920.702378928607, 9951.90048099517, 9973.252006099536, 9973.551190196458, 9987.450690212036, 9902.306838521306, 9945.353552019167, 9947.75130621733, 9952.452615106165, 9956.601735930553, 9739.707808765748, 9766.07222313886, 9770.804583908353, 9788.021197880225, 9813.558389872473, 41188.58811411878, 41244.968875778344, 41398.58601413977, 41562.58437415618, 41748.58251417477, 3317.104381816896, 3381.661833816623, 3571.821408929543, 3892.3772196448717, 3926.509186351706, 28485.287867803265, 28719.71280287212, 30850.0, 31262.21844453884, 32204.677953220402, 3190.7925984810913, 3228.660990595977, 3295.653956334574, 3330.2673411849355, 3401.3027329397414, 507705.0, 510782.0, 513338.0, 514698.0, 514801.0, 61413.0, 61417.38582614206, 61760.0, 61807.381926181064, 61835.381646183865, 64361.67819160968, 64464.67767661132, 64669.67665161644, 64714.35285647177, 64898.351016490175, 16593.50219493417, 16650.084245366623, 16705.0, 16787.0, 16841.157942102847, 10998.780024399468, 12857.228566286052, 12989.805152922525, 13009.21944683322, 13059.738805224033, 14720.484783032542, 14845.183514906785, 16725.163741813103, 17965.461036168937, 18006.0, 5286.60350473716, 6024.969875150597, 6454.225492940784, 6480.611163330121, 6480.935190648033, 815.8939337886037, 818.8444195602816, 826.1490664615455, 992.7815880506278, 1083.3770581915273, 29936.05415647976, 30463.847680761897, 30801.38397232043, 31133.377332453223, 31141.688583114334, 921.755734730297, 1025.820481415764, 1043.3479075577764, 1152.7060599547062, 1173.6537721372215, 15369.462068827537, 15913.761293580606, 15953.282102305191, 16032.272237089173, 16312.51062468128, 678362.0, 684263.0, 684940.9035457788, 685801.0, 686046.0, 57818.13272800911, 58680.119798203064, 58733.70633146807, 58958.41041589529, 59111.11333330003, 1350.4868150102898, 1360.7346567419456, 1372.1286982766017, 1381.730562540295, 1386.202933313349, 28976.0, 29838.10485685433, 30124.849375753856, 30360.935243530064, 30801.075967721004, 43397.56602433935, 43584.0, 52324.47675523196, 52384.47615523796, 52441.213381800066, 620262.0, 626044.0, 627770.0, 627945.8602706958, 631601.0, 26607.0, 26687.866560667073, 26976.055838045573, 27040.72959270382, 27354.0, 46891.29663055125, 47437.0, 48220.758896206695, 48413.757931210115, 48848.0, 34437.48343774895, 39386.606133938294, 39616.80191599023, 40346.0, 40412.79793601013, 37537.624623754506, 39025.414618780174, 39282.554250836205, 40272.597274026884, 40462.1907561853, 34977.475337869444, 37344.43983340306, 37833.810830945666, 38590.0, 38625.80687096546, 30900.690993089782, 34000.93991540773, 34695.65304347025, 34870.0, 35072.47391289082, 23929.16247931314, 25383.87308063448, 25462.490750184523, 25653.3586660335, 26052.869735651202], "value": 20128.072124053397, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.8088474877813, 380.00438850212447, 382.1916646293088, 383.2526573182294, 400.25552472401347, 18182.545436364097, 18944.52638684032, 20847.478813029662, 20966.790332096676, 21071.367858964237, 16646.0844653544, 20195.39413817584, 20734.585308293863, 21095.2616658417, 21105.050272737724, 5008.924866127011, 5750.597458177929, 5984.251968503937, 5992.610480318765, 6044.153818465418, 5924.200232968558, 5976.0, 5981.342052374235, 6055.727492262837, 6072.757089716428, 5721.828345149652, 5991.011483105304, 6022.217111775485, 6072.544559158081, 6112.572119951606, 5868.530517558585, 6060.545459090564, 6083.117947897552, 6083.908741368883, 6104.481119104881, 5853.47318741311, 5898.0, 5903.616264942765, 5928.851778705567, 5931.673757943311, 12969.54606588765, 13238.602841914759, 13269.203847769164, 13422.261775602337, 13451.394687239097, 1986.6424043672134, 2194.5830292244423, 2581.186926118267, 2937.3684657798462, 2962.955555666667, 10416.947915260374, 11006.614768483065, 13118.016148788784, 15165.0, 15955.20223988796, 1815.4553633909775, 1873.5971766070224, 1906.733057371969, 1910.7993660665568, 1964.5481539246055, 121995.0, 125484.0, 126667.0, 127018.72981270161, 128677.0, 9569.904300956901, 11074.944625276983, 11334.489947952361, 11490.712732181762, 11533.538658453735, 14416.783748243784, 14427.35076921541, 14438.133711977314, 14443.78334324986, 14444.988850780555, 8325.66697332112, 8485.95757021211, 8569.657213711507, 8671.56642167889, 8692.261157801659, 7000.614966176808, 7180.3537681608905, 7951.0, 8562.229399353964, 8577.01364343096, 4460.0, 4463.553644635575, 4477.440319960005, 4479.552044795494, 4490.191765482245, 1520.4982355822551, 1909.150428059528, 1917.712343148511, 1925.1433112264908, 1953.0, 860.337540094124, 890.9599068041954, 927.7912469694264, 947.6304241345881, 989.475577943691, 20382.388528344174, 21632.0, 22164.292028106094, 22792.43018924507, 22970.65544016841, 825.5718649877082, 868.7133246028795, 924.4499522784067, 924.4776701163821, 985.8718366612438, 10839.620613278497, 11018.834717479083, 11242.775144497227, 11263.43682815856, 11263.549458021751, 606218.0, 616928.0, 619860.0, 634006.0, 635495.0, 106023.0, 128742.0, 140461.2976935109, 143452.28273858564, 147198.0, 1016.6594190946116, 1020.5611587017505, 1050.4327663062013, 1098.4672433869566, 1100.2133474565724, 19176.0, 19911.26780090715, 19986.500337491678, 20144.89927550353, 20170.193192272145, 40730.59269407268, 55826.44173558213, 57615.711921440125, 57650.0, 58314.0, 58029.0, 73903.26096738964, 75035.62482187554, 80369.59815200887, 80504.3899122026, 4535.639308207458, 5414.83755487336, 6240.939040363059, 6255.71849266775, 6744.898826517704, 7241.891371629325, 9361.391509551857, 10397.220208484243, 10907.83638245411, 11751.471183796579, 9015.459072455411, 10195.337303075275, 10375.273730839072, 11493.94253028763, 11746.29522228669, 11188.776224475629, 11512.19414640967, 11540.94229528847, 11566.016888564229, 11888.227265227733, 11548.158851960936, 11665.650030499099, 11846.348450835287, 11966.940165299466, 11974.042076634023, 6963.825904352431, 8139.0, 8179.10029896699, 8189.50862948225, 8406.537640429835, 10838.512266948164, 11254.718632034264, 11633.069354451793, 11678.766424671629, 11737.530498780296], "value": 9413.557887029969, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.6327428320071, 1495.4840579999895, 1671.2479384277071, 1836.4582448177787, 1862.2550979608147, 8047.758567242978, 8327.91737074181, 8426.873596896052, 8972.596233169506, 9036.141566551176, 8521.488710677364, 8804.867926981084, 8834.60244289007, 8955.507447090407, 8982.37123401362, 2346.1671106757112, 2391.7249516305674, 2397.30478161333, 2400.3399065257017, 2401.2556107606697, 2036.3483685220735, 2076.805836643928, 2393.4734358441115, 2397.30478161333, 2408.5664580375524, 2356.2813341930705, 2375.2185860604545, 2378.5599664062115, 2394.1022116706235, 2405.494846082325, 2357.4577847095265, 2360.386299562109, 2378.143868207444, 2382.737898831127, 2388.5461762265113, 2150.817180539656, 2279.3959600705825, 2368.9052437902637, 2371.0, 2375.9762402375927, 8894.332925030583, 8898.688545900926, 8935.910640893639, 8943.55282235892, 8991.28069754418, 4427.003924117048, 5235.293235413209, 5246.580273578143, 5398.946010539923, 5406.351237851443, 3519.894403167909, 3627.437747149196, 3691.630836916314, 3692.6861216796606, 3699.8705045323286, 888.595688961521, 1060.9098226650744, 1061.7080302916681, 1069.6897899609105, 1083.3987137138886, 9538.380005299634, 11656.41717914101, 11661.941690291578, 11683.065354771683, 11697.47361368732, 3884.76691398517, 4714.88212794676, 4822.059698358787, 4837.588804951619, 4843.709377437365, 8666.78333041679, 9346.691463195159, 9959.900400995897, 9965.900340996497, 9994.600215991279, 4535.863924082283, 5334.786608535615, 5340.49265319794, 5353.304070470814, 5357.785688572413, 4381.452318460192, 4536.956500005017, 4713.316569097462, 4862.270659401047, 4874.025194961022, 3648.1973965727498, 3773.9433908491396, 3876.534815822063, 3986.421968814506, 4031.879043628696, 1149.3908228638668, 1300.830891984036, 1317.8155058291848, 1325.15190278222, 1328.5350127455313, 842.8326767427158, 852.3436953545735, 905.4567259644292, 913.1142791492242, 927.8515437529962, 5666.716664166775, 5684.8863022739315, 5928.822135335947, 6014.578979471483, 6070.0, 910.5356268303213, 942.4157022646003, 945.3004776465503, 958.0850287974968, 1001.2740762946805, 3938.6849052075763, 3954.8022598869943, 3998.220347032359, 4075.5109386873764, 4088.652464540488, 10658.680239592824, 10893.183011274186, 10909.0, 10913.781724365626, 10959.342439453658, 9346.299027572959, 10846.728831779268, 10849.240553161202, 10857.565697372016, 10884.40135792539, 8088.191180881865, 8201.753947381589, 8203.0, 8204.958975205085, 8211.876821847676, 4511.1654343946475, 5101.51535604117, 5660.716964151694, 5733.741981610754, 5770.422957704196, 8802.471851688919, 9807.313488055768, 9869.654562090293, 10001.649942252277, 10002.29983901149, 9840.852387214341, 10014.599416023277, 10075.244356673426, 10227.130693891102, 10311.07200351972, 6568.146141001639, 6758.357955994173, 6828.078209441662, 7040.647967601497, 7115.039469671735, 8277.213664701843, 8419.536925469158, 8447.070822209429, 8503.91496085056, 8505.617247223767, 6492.0, 7439.92560074414, 7538.509996850187, 7569.318761311509, 7709.151993280847, 6211.720472578835, 6437.0, 6557.9344206557325, 6756.4257038150345, 7354.154272258758, 6570.047343135314, 6873.828154296182, 6883.862322753416, 6954.9652251740445, 6969.128858892638, 4528.230200865926, 5000.099982003274, 5020.849374518771, 5039.445660977363, 5044.1424957756535, 4942.777575009205, 5015.84952451427, 5023.397192336943, 5092.567131793839, 5127.692338459704], "value": 4533.265972259539, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.9570862224976, 305.5783019433182, 310.3885345868638, 314.0766147526273, 318.1981406854726, 5176.249443830642, 5288.682679039251, 5357.598180136486, 5488.807891723791, 5518.751656175472, 5000.299958005873, 5007.399112106552, 5278.12910869707, 5316.229146773716, 5358.973205133969, 2886.4515742008953, 3965.4250133730593, 3993.9201215975663, 4111.0, 4116.382542618601, 3839.0786211309223, 4080.9387859182134, 4097.422492340441, 4113.675773188154, 4155.168966206756, 4007.6793856491413, 4054.837806487737, 4058.289799285128, 4070.328395814687, 4084.346504559271, 3862.343401621731, 4077.7145599808027, 4077.97961010196, 4087.305158123126, 4099.733517321394, 3138.450771115046, 3257.6742325767473, 3427.160345715291, 3550.946735798965, 3560.6439356064448, 4958.718989264942, 5058.696478211319, 5163.8192663256605, 5191.948080519184, 5233.555147812441, 4650.372199753024, 4660.440747110335, 4677.859664210079, 4681.859544213679, 4764.475907650156, 5097.974510127463, 5546.334439867242, 5667.1782591524, 5669.744861481243, 5680.046375884558, 3407.9659203407896, 3430.485427185917, 3531.3643544162296, 3739.5138631977943, 3759.3609086455094, 4750.61995040396, 5908.911366329508, 5940.2871655401195, 5987.221661184019, 6030.50230866101, 3882.3400021995762, 3885.592012838668, 3885.922281554353, 3894.883153505399, 3894.9610503894596, 3793.715471339661, 3830.272248272819, 3877.825497852547, 3940.822662980173, 3950.881473555798, 3960.9701477616027, 4335.544767799399, 4425.636516247675, 4552.908941821212, 4583.793729282191, 4758.595519380891, 5671.914921276184, 5676.0551416765775, 5707.885842283131, 5712.7714891403875, 1100.9669709908715, 1258.2702032820941, 1310.2269660900115, 1327.6922231601864, 1332.1274565159836, 786.2216405758372, 861.866410706329, 864.6930339729431, 871.877937088808, 886.2068448738343, 5213.452587478336, 5306.442823503554, 5318.484231993863, 5345.0, 5412.891742165135, 5746.511546518509, 5762.625429347079, 5771.59598828078, 5794.82615521535, 5795.3193573863955, 4911.852644420602, 5034.723090230073, 5282.392524859613, 5339.546138578265, 5360.472265404341, 2220.7668194839307, 2238.641817309223, 2595.4030572968322, 2626.6979297380663, 2638.630591717161, 4426.955730442719, 4654.767261636905, 4705.55297246761, 4904.117258893433, 5149.871253218699, 5047.974760126176, 5089.592832573385, 5097.9745101275, 5598.964191624563, 6083.574149809471, 5363.973180133997, 6102.131997960952, 6124.877502449926, 6180.690965451709, 6192.553941193113, 5643.097104463266, 5855.414458554111, 5927.733252003756, 5940.1683764272175, 5957.523398128053, 5490.368607610176, 5670.234518339971, 5812.796552120655, 5814.476697097281, 5860.443257890493, 5188.547206782107, 5338.958903013875, 6197.349278325892, 6199.876002480015, 6210.391635513186, 3612.7832330060282, 3770.6606405423645, 3807.5621303550447, 3897.8830635080994, 3911.3155197840833, 5547.611667183259, 5715.428457154251, 5791.218185544897, 5811.215485909348, 5833.883322333445, 5408.486193811582, 5515.0, 5634.408387119457, 5705.348576910864, 5732.426757324234, 5093.388793344822, 5260.816761044124, 5664.37691853904, 5666.914996275142, 5734.569907256889, 4712.986707857827, 5095.847124586268, 5193.558547523352, 5618.606697531133, 5665.745041473226, 4968.981358821361, 5636.5208957237455, 5672.149177623224, 5716.256886604715, 5721.256236689203, 5119.948800511947, 5326.36083669962, 5598.748056337556, 5616.494515493625, 5640.446518693197], "value": 4083.8199002824513, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.6042176802757, 768.7539987204093, 793.9523628582282, 796.1481215099843, 815.0993152566416, 15447.613809654751, 16079.83920160798, 16090.919545402287, 16100.83899161008, 16136.273867675938, 14373.20947347898, 14421.062630928982, 14470.131792092481, 14473.927630361859, 14530.418783248657, 665.2482694555146, 687.7867860963117, 750.7484992527483, 817.6851912013888, 818.9058258300312, 838.8238469921293, 854.747849384433, 854.8076682746363, 855.9443636163661, 859.9656013759442, 816.5998660656265, 905.1265528764741, 907.5190149220923, 907.587047893207, 909.495230147268, 667.8712975072112, 761.402299195132, 826.4215049465338, 900.4192295969096, 904.1275169461468, 660.4320284555279, 669.0566301514889, 669.0967194287673, 669.2704951602776, 670.3430637974764, 14599.854001460062, 14617.415303387852, 14678.853211467855, 14704.55886323412, 14759.0, 14528.200948947804, 14651.267436628126, 14660.780088298685, 14730.55808325752, 14806.851931480764, 10574.682759517149, 11644.243124196984, 11872.52509899603, 11946.044316454663, 12001.93999030008, 3802.790846503441, 3832.2143960488033, 3857.498525191735, 3871.5160604924386, 4010.83956641734, 117962.0, 120258.0, 121549.0, 122300.38849805783, 123310.0, 9546.284028697875, 11074.667759967213, 11184.60853870127, 11268.54925802975, 11516.078713702884, 22740.65889011666, 22750.0, 22788.544229115323, 22796.2021329256, 22871.771282287296, 8069.556174410463, 8141.0230772307705, 8154.796130096795, 8156.265936065783, 8221.54781487024, 4092.8158232878995, 4283.250431174532, 4293.69944103916, 4333.306670932636, 4399.6040356368085, 3491.6159222485508, 3613.530241068644, 3614.6023937366867, 3627.0750958505414, 3866.3233934061427, 710.9111361079865, 717.673706279158, 722.4401089155946, 726.2374506767873, 727.1092911183757, 554.3901708121115, 600.4145957691217, 611.6574718157846, 614.3457218062749, 645.6642545876213, 7872.567008814455, 9458.763530911645, 9577.425354478753, 9686.418814871131, 9706.90293097074, 624.7157543317779, 640.5804198250154, 659.535027805396, 670.2325836916704, 678.4301187002941, 4261.509926358509, 4281.101765854781, 4702.764861756898, 4840.1287768201355, 4853.878653033632, 88762.22475550453, 97473.51263243638, 132432.70269189123, 151301.0, 151686.0, 109935.0, 111764.76470470545, 115086.4245678783, 116576.41711791557, 116728.0, 79331.0, 80965.19034809695, 94569.0, 101052.0, 106815.7161926373, 7839.9216007839195, 9607.0, 9936.006399360007, 10045.69862904114, 10051.84403793573, 46864.0, 52225.73887130692, 60810.0, 60903.60120773423, 62532.68733656302, 78971.60514197392, 90973.54513227656, 94820.52589737007, 95409.0, 95696.0, 12703.0, 13176.934115329363, 13206.0, 13439.731205375641, 13694.808830587457, 13232.735345293233, 13715.1085179467, 13880.305984700522, 13986.790198146833, 14028.579142625738, 13168.868311316764, 13531.458741650224, 13710.52013179534, 13929.791053134413, 14049.0, 13173.538926137539, 13646.385912634154, 13828.723425531232, 14116.294185290899, 14301.35643896048, 11797.941010294893, 13569.728605428034, 13589.254498458376, 13830.226507270643, 13992.510262140777, 11236.381998990135, 11363.431828408711, 11423.371714555778, 11519.596814111466, 11788.764224715285, 8569.442986205877, 10459.58161673555, 10727.785444291227, 11025.44872756343, 11515.424228788695], "value": 7718.235728566588, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 119.0, 118.0, 113.0, 117.0, 118.0, 116.0, 119.0, 121.0, 153.0], "value": 120.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 113.0, 111.0, 137.0, 134.0, 137.0, 139.0, 118.0, 142.0, 109.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 208.0, 234.0, 197.0, 267.0, 200.0, 195.0, 195.0, 200.0, 273.0], "value": 217.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 56.0, 54.0, 83.0, 61.0, 59.0, 61.0, 78.0, 99.0, 59.0], "value": 69.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 87.0, 74.0, 71.0, 96.0, 113.0, 71.0, 72.0, 84.0], "value": 83.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 86.0, 89.0, 85.0, 89.0, 86.0, 89.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 99.0, 95.0, 101.0, 151.0, 119.0, 95.0, 96.0], "value": 104.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 140.0, 91.0, 90.0, 76.0, 143.0, 150.0, 143.0, 121.0, 93.0], "value": 119.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 57.0, 56.0, 58.0, 56.0, 57.0, 57.0, 56.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 74.0, 82.0, 79.0, 69.0, 71.0, 78.0, 100.0, 93.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 90.0, 88.0, 88.0, 84.0, 91.0, 92.0, 85.0, 111.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 138.0, 137.0, 143.0, 148.0, 158.0, 157.0, 153.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 225.0, 172.0, 170.0, 169.0, 172.0, 170.0, 168.0, 169.0, 169.0], "value": 180.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 70.0, 70.0, 69.0, 69.0, 70.0, 67.0, 69.0, 70.0], "value": 69.2, "unit": "score"}]}]} 19:55:09 INFO - Return code: 0 19:55:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:55:09 ERROR - # TBPL SUCCESS # 19:55:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:55:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:55:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:55:09 INFO - 2016-09-21 19:55:09.898 screenresolution[1959:17546] starting screenresolution argv=screenresolution get 19:55:09 INFO - 2016-09-21 19:55:09.901 screenresolution[1959:17546] Display 0: 1600x1200x32@60 19:55:09 INFO - 2016-09-21 19:55:09.907 screenresolution[1960:17549] starting screenresolution argv=screenresolution list 19:55:09 INFO - Available Modes on Display 0 19:55:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:55:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:55:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:55:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:55:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:55:10 INFO - Intel Iris: 19:55:10 INFO - Chipset Model: Intel Iris 19:55:10 INFO - Type: GPU 19:55:10 INFO - Bus: Built-In 19:55:10 INFO - VRAM (Dynamic, Max): 1536 MB 19:55:10 INFO - Vendor: Intel (0x8086) 19:55:10 INFO - Device ID: 0x0a2e 19:55:10 INFO - Revision ID: 0x0009 19:55:10 INFO - Displays: 19:55:10 INFO - Display: 19:55:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:55:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:55:10 INFO - Display Serial Number: 1600x1200 60 19:55:10 INFO - Main Display: Yes 19:55:10 INFO - Mirror: Off 19:55:10 INFO - Online: Yes 19:55:10 INFO - Rotation: Supported 19:55:10 INFO - Return code: 0 19:55:10 INFO - Running post-action listener: _resource_record_post_action 19:55:10 INFO - [mozharness: 2016-09-22 02:55:10.142452Z] Finished run-tests step (success) 19:55:10 INFO - Running post-run listener: _resource_record_post_run 19:55:10 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 1040384; Write bytes: 707068416; Read time: 46; Write time: 2120 19:55:10 INFO - TinderboxPrint: CPU usage
54.7% 19:55:10 INFO - TinderboxPrint: I/O read bytes / time
1,040,384 / 46 19:55:10 INFO - TinderboxPrint: I/O write bytes / time
707,068,416 / 2,120 19:55:10 INFO - TinderboxPrint: CPU idle
2,189.7 (45.3%) 19:55:10 INFO - TinderboxPrint: CPU system
986.7 (20.4%) 19:55:10 INFO - TinderboxPrint: CPU user
1,661.2 (34.3%) 19:55:10 INFO - TinderboxPrint: Swap in / out
406,798,336 / 0 19:55:10 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 386945536; Write bytes: 381203968; Read time: 29547; Write time: 685 19:55:10 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 1040384; Write bytes: 299424768; Read time: 46; Write time: 1385 19:55:10 INFO - Running post-run listener: _upload_blobber_files 19:55:10 INFO - Blob upload gear active. 19:55:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:55:10 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 19:55:10 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:55:10 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:55:11 INFO - (blobuploader) - INFO - Open directory for files ... 19:55:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:55:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:55:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:55:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:55:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:55:12 INFO - (blobuploader) - INFO - Done attempting. 19:55:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:55:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:55:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:55:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:55:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:55:13 INFO - (blobuploader) - INFO - Done attempting. 19:55:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:55:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:55:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:55:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:55:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:55:15 INFO - (blobuploader) - INFO - Done attempting. 19:55:15 INFO - (blobuploader) - INFO - Iteration through files over. 19:55:15 INFO - Return code: 0 19:55:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:55:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:55:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/aeb09bb640ff17645d78e01c30087824155c2449e9328e1f41c43bd8dcfd6af16c2c27e73c459799e846fd7d4cb39f1ff244eed0ad2ee149f356980abc945dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/1a443e4e8ff9fe7fe56a3574a160fd5b196a41042473e2f6fc539d0a0d0f097fc599c76234d7dc117314d3ea36a11027a62dc3942d5e74a64d15d72655b1b8be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/d3b44f0a19387f35e62e11e70c4e2d7e659590469b8157498439264a86a4d945d361121b0c0a48a4491ba193ca524862a3c8a58db19319bfb9adb84cc2576a04"} 19:55:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:55:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:55:15 INFO - Contents: 19:55:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/aeb09bb640ff17645d78e01c30087824155c2449e9328e1f41c43bd8dcfd6af16c2c27e73c459799e846fd7d4cb39f1ff244eed0ad2ee149f356980abc945dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/1a443e4e8ff9fe7fe56a3574a160fd5b196a41042473e2f6fc539d0a0d0f097fc599c76234d7dc117314d3ea36a11027a62dc3942d5e74a64d15d72655b1b8be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/d3b44f0a19387f35e62e11e70c4e2d7e659590469b8157498439264a86a4d945d361121b0c0a48a4491ba193ca524862a3c8a58db19319bfb9adb84cc2576a04"} 19:55:15 INFO - Running post-run listener: copy_logs_to_upload_dir 19:55:15 INFO - Copying logs to upload dir... 19:55:15 INFO - mkdir: /builds/slave/test/build/upload/logs 19:55:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.686688 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-21 19:55:15.928721) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 19:55:15.932353) ========= 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.5hxi2y0kSd/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.UXonUZfis7/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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/Larch/sha512/aeb09bb640ff17645d78e01c30087824155c2449e9328e1f41c43bd8dcfd6af16c2c27e73c459799e846fd7d4cb39f1ff244eed0ad2ee149f356980abc945dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/1a443e4e8ff9fe7fe56a3574a160fd5b196a41042473e2f6fc539d0a0d0f097fc599c76234d7dc117314d3ea36a11027a62dc3942d5e74a64d15d72655b1b8be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/d3b44f0a19387f35e62e11e70c4e2d7e659590469b8157498439264a86a4d945d361121b0c0a48a4491ba193ca524862a3c8a58db19319bfb9adb84cc2576a04"} build_url:https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011114 build_url: 'https://queue.taskcluster.net/v1/task/ej-J74EcTi2bu1sFO0u2lA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/aeb09bb640ff17645d78e01c30087824155c2449e9328e1f41c43bd8dcfd6af16c2c27e73c459799e846fd7d4cb39f1ff244eed0ad2ee149f356980abc945dcc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/1a443e4e8ff9fe7fe56a3574a160fd5b196a41042473e2f6fc539d0a0d0f097fc599c76234d7dc117314d3ea36a11027a62dc3942d5e74a64d15d72655b1b8be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/d3b44f0a19387f35e62e11e70c4e2d7e659590469b8157498439264a86a4d945d361121b0c0a48a4491ba193ca524862a3c8a58db19319bfb9adb84cc2576a04"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 19:55:15.969288) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 19:55:15.970001) ========= 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.5hxi2y0kSd/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.UXonUZfis7/Listeners TMPDIR=/var/folders/_w/3j13m0p51h30tjlqbj_z4n9800000w/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.005134 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 19:55:16.019632) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 19:55:16.019949) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 19:55:16.020318) ========= ========= Total master_lag: 0.28 =========