builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0110 starttime: 1473327850.66 results: success (0) buildid: 20160907175716 builduid: 0aad801a4896498f96ec88398c84536c revision: 77940cbf0c2a9f52c209fbbde5b2e7d4c74a1501 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:10.660021) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:10.660382) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:10.660653) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:10.745758) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:10.746010) ========= 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.7JNrFIs9R4/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.ZJCogcDOkA/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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-08 02:44:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.67M=0.001s 2016-09-08 02:44:11 (9.67 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.488133 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:11.267645) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:11.267977) ========= 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.7JNrFIs9R4/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.ZJCogcDOkA/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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.028655 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:11.326145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-08 02:44:11.326509) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 77940cbf0c2a9f52c209fbbde5b2e7d4c74a1501 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 77940cbf0c2a9f52c209fbbde5b2e7d4c74a1501 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7JNrFIs9R4/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.ZJCogcDOkA/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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-08 02:44:11,413 truncating revision to first 12 chars 2016-09-08 02:44:11,413 Setting DEBUG logging. 2016-09-08 02:44:11,413 attempt 1/10 2016-09-08 02:44:11,413 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/77940cbf0c2a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-08 02:44:12,434 unpacking tar archive at: mozilla-central-77940cbf0c2a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.281823 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-08 02:44:12.636794) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:12.637148) ========= script_repo_revision: 77940cbf0c2a9f52c209fbbde5b2e7d4c74a1501 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:12.637656) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:12.637966) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 02:44:12.657037) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-08 02:44:12.657499) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7JNrFIs9R4/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.ZJCogcDOkA/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 02:44:12 INFO - MultiFileLogger online at 20160908 02:44:12 in /builds/slave/test 02:44:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:44:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:44:12 INFO - {'append_to_log': False, 02:44:12 INFO - 'base_work_dir': '/builds/slave/test', 02:44:12 INFO - 'blob_upload_branch': 'Firefox', 02:44:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:44:12 INFO - 'branch': 'Firefox', 02:44:12 INFO - 'buildbot_json_path': 'buildprops.json', 02:44:12 INFO - 'config_files': ('talos/mac_config.py',), 02:44:12 INFO - 'default_actions': ('clobber', 02:44:12 INFO - 'read-buildbot-config', 02:44:12 INFO - 'download-and-extract', 02:44:12 INFO - 'populate-webroot', 02:44:12 INFO - 'create-virtualenv', 02:44:12 INFO - 'install', 02:44:12 INFO - 'run-tests'), 02:44:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:44:12 INFO - 'download_minidump_stackwalk': True, 02:44:12 INFO - 'download_symbols': 'ondemand', 02:44:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:44:12 INFO - 'tooltool.py': '/tools/tooltool.py', 02:44:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:44:12 INFO - '/tools/misc-python/virtualenv.py')}, 02:44:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:44:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:44:12 INFO - 'installer_path': 'installer.exe', 02:44:12 INFO - 'log_level': 'info', 02:44:12 INFO - 'log_name': 'talos', 02:44:12 INFO - 'log_to_console': True, 02:44:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:44:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:44:12 INFO - 'opt_config_files': (), 02:44:12 INFO - 'pip_index': False, 02:44:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:44:12 INFO - 'cmd': ('bash', 02:44:12 INFO - '-c', 02:44:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:44:12 INFO - 'enabled': True, 02:44:12 INFO - 'halt_on_failure': False, 02:44:12 INFO - 'name': 'check_screen_resolution'},), 02:44:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:44:12 INFO - 'cmd': ('bash', 02:44:12 INFO - '-c', 02:44:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:44:12 INFO - 'enabled': True, 02:44:12 INFO - 'halt_on_failure': False, 02:44:12 INFO - 'name': 'check_screen_resolution'},), 02:44:12 INFO - 'run_cmd_checks_enabled': True, 02:44:12 INFO - 'sps_profile': False, 02:44:12 INFO - 'sps_profile_interval': 0, 02:44:12 INFO - 'suite': 'dromaeojs-e10s', 02:44:12 INFO - 'system_bits': '32', 02:44:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:44:12 INFO - 'title': 't-yosemite-r7-0110', 02:44:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:44:12 INFO - 'use_talos_json': True, 02:44:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:44:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:44:12 INFO - 'work_dir': 'build'} 02:44:12 INFO - [mozharness: 2016-09-08 09:44:12.863341Z] Running clobber step. 02:44:12 INFO - Running pre-action listener: _resource_record_pre_action 02:44:12 INFO - Running main action method: clobber 02:44:12 INFO - rmtree: /builds/slave/test/build 02:44:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:44:15 INFO - Running post-action listener: _resource_record_post_action 02:44:15 INFO - [mozharness: 2016-09-08 09:44:15.064656Z] Finished clobber step (success) 02:44:15 INFO - [mozharness: 2016-09-08 09:44:15.064815Z] Running read-buildbot-config step. 02:44:15 INFO - Running pre-action listener: _resource_record_pre_action 02:44:15 INFO - Running main action method: read_buildbot_config 02:44:15 INFO - Using buildbot properties: 02:44:15 INFO - { 02:44:15 INFO - "project": "", 02:44:15 INFO - "product": "firefox", 02:44:15 INFO - "script_repo_revision": "production", 02:44:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 02:44:15 INFO - "repository": "", 02:44:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 02:44:15 INFO - "buildid": "20160907175716", 02:44:15 INFO - "pgo_build": "False", 02:44:15 INFO - "basedir": "/builds/slave/test", 02:44:15 INFO - "buildnumber": 30, 02:44:15 INFO - "slavename": "t-yosemite-r7-0110", 02:44:15 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 02:44:15 INFO - "platform": "yosemite_r7", 02:44:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:44:15 INFO - "branch": "mozilla-central", 02:44:15 INFO - "repo_path": "mozilla-central", 02:44:15 INFO - "revision": "77940cbf0c2a9f52c209fbbde5b2e7d4c74a1501", 02:44:15 INFO - "stage_platform": "macosx64", 02:44:15 INFO - "builduid": "0aad801a4896498f96ec88398c84536c", 02:44:15 INFO - "slavebuilddir": "test" 02:44:15 INFO - } 02:44:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 02:44:15 INFO - Running post-action listener: _resource_record_post_action 02:44:15 INFO - [mozharness: 2016-09-08 09:44:15.067862Z] Finished read-buildbot-config step (success) 02:44:15 INFO - [mozharness: 2016-09-08 09:44:15.067976Z] Running download-and-extract step. 02:44:15 INFO - Running pre-action listener: _resource_record_pre_action 02:44:15 INFO - Running main action method: download_and_extract 02:44:15 INFO - mkdir: /builds/slave/test/build/tests 02:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:15 INFO - trying https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 02:44:15 INFO - Downloading https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 02:44:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 02:44:15 INFO - Downloaded 1199 bytes. 02:44:15 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 02:44:15 INFO - Using the following test package requirements: 02:44:15 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 02:44:15 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:44:15 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 02:44:15 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:44:15 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 02:44:15 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:44:15 INFO - u'jsshell-mac.zip'], 02:44:15 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:44:15 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 02:44:15 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 02:44:15 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:44:15 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 02:44:15 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:44:15 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 02:44:15 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:44:15 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 02:44:15 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 02:44:15 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 02:44:15 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:44:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:44:16 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 02:44:23 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:44:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 02:44:23 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 02:44:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 02:44:31 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 02:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:31 INFO - trying https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:44:31 INFO - Downloading https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 02:44:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 02:44:34 INFO - Downloaded 111456518 bytes. 02:44:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:44:34 INFO - mkdir: /builds/slave/test/properties 02:44:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:44:34 INFO - Writing to file /builds/slave/test/properties/build_url 02:44:34 INFO - Contents: 02:44:34 INFO - build_url:https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 02:44:35 INFO - Running post-action listener: _resource_record_post_action 02:44:35 INFO - Running post-action listener: set_extra_try_arguments 02:44:35 INFO - [mozharness: 2016-09-08 09:44:35.527373Z] Finished download-and-extract step (success) 02:44:35 INFO - [mozharness: 2016-09-08 09:44:35.527507Z] Running populate-webroot step. 02:44:35 INFO - Running pre-action listener: _resource_record_pre_action 02:44:35 INFO - Running main action method: populate_webroot 02:44:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:44:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:44:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:44:35 INFO - '--tppagecycles', 02:44:35 INFO - '7'], 02:44:35 INFO - 'tests': ['tsvgm']}}, 02:44:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:44:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:44:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:44:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:44:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:44:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:44:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:35 INFO - 'talos_options': ['--disable-e10s'], 02:44:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:44:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:35 INFO - 'talos_options': ['--disable-e10s'], 02:44:35 INFO - 'tests': ['damp', 'tps']}, 02:44:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:35 INFO - 'tests': ['damp', 'tps']}, 02:44:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:44:35 INFO - 'tests': ['dromaeo_dom']}, 02:44:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:44:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:44:35 INFO - 'tests': ['basic_compositor_video']}, 02:44:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:44:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:44:35 INFO - 'tests': ['a11yr', 02:44:35 INFO - 'ts_paint', 02:44:35 INFO - 'tpaint', 02:44:35 INFO - 'sessionrestore', 02:44:35 INFO - 'sessionrestore_no_auto_restore', 02:44:35 INFO - 'tabpaint']}, 02:44:35 INFO - 'other-e10s': {'tests': ['a11yr', 02:44:35 INFO - 'ts_paint', 02:44:35 INFO - 'tpaint', 02:44:35 INFO - 'sessionrestore', 02:44:35 INFO - 'sessionrestore_no_auto_restore', 02:44:35 INFO - 'tabpaint']}, 02:44:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:44:35 INFO - 'ts_paint', 02:44:35 INFO - 'tpaint', 02:44:35 INFO - 'sessionrestore', 02:44:35 INFO - 'sessionrestore_no_auto_restore', 02:44:35 INFO - 'tabpaint']}, 02:44:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:44:35 INFO - 'ts_paint', 02:44:35 INFO - 'tpaint', 02:44:35 INFO - 'sessionrestore', 02:44:35 INFO - 'sessionrestore_no_auto_restore', 02:44:35 INFO - 'tabpaint']}, 02:44:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:44:35 INFO - 'tests': ['a11yr', 02:44:35 INFO - 'ts_paint', 02:44:35 INFO - 'tpaint', 02:44:35 INFO - 'sessionrestore', 02:44:35 INFO - 'sessionrestore_no_auto_restore', 02:44:35 INFO - 'tabpaint']}, 02:44:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:44:35 INFO - 'tests': ['a11yr', 02:44:35 INFO - 'ts_paint', 02:44:35 INFO - 'tpaint', 02:44:35 INFO - 'sessionrestore', 02:44:35 INFO - 'sessionrestore_no_auto_restore', 02:44:35 INFO - 'tabpaint']}, 02:44:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:44:35 INFO - 'tests': ['tsvgx', 02:44:35 INFO - 'tsvgr_opacity', 02:44:35 INFO - 'tart', 02:44:35 INFO - 'tscrollx', 02:44:35 INFO - 'cart']}, 02:44:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:44:35 INFO - 'tsvgr_opacity', 02:44:35 INFO - 'tart', 02:44:35 INFO - 'tscrollx', 02:44:35 INFO - 'cart']}, 02:44:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:35 INFO - 'talos_options': ['--disable-e10s'], 02:44:35 INFO - 'tests': ['tp5o']}, 02:44:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:35 INFO - 'tests': ['tp5o']}, 02:44:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:35 INFO - 'talos_options': ['--disable-e10s', 02:44:35 INFO - '--xperf_path', 02:44:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:35 INFO - 'tests': ['tp5n']}, 02:44:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:44:35 INFO - 'talos_options': ['--xperf_path', 02:44:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:44:35 INFO - 'tests': ['tp5n']}}, 02:44:35 INFO - 'talos.zip': {'path': '', 02:44:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:44:35 INFO - Running post-action listener: _resource_record_post_action 02:44:35 INFO - [mozharness: 2016-09-08 09:44:35.546337Z] Finished populate-webroot step (success) 02:44:35 INFO - [mozharness: 2016-09-08 09:44:35.546444Z] Running create-virtualenv step. 02:44:35 INFO - Running pre-action listener: _resource_record_pre_action 02:44:35 INFO - Running main action method: create_virtualenv 02:44:35 INFO - Creating virtualenv /builds/slave/test/build/venv 02:44:35 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 02:44:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:44:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:44:35 INFO - Using real prefix '/tools/python27' 02:44:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:44:36 INFO - Installing distribute.............................................................................................................................................................................................done. 02:44:39 INFO - Installing pip.................done. 02:44:39 INFO - Return code: 0 02:44:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:44:39 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')]} 02:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:39 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')]} 02:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:39 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 0x103f1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fb1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3d77f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e80d30>, '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 0x103be5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e78b20>, '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.7JNrFIs9R4/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.ZJCogcDOkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 02:44:39 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 02:44:39 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 02:44:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7JNrFIs9R4/Render', 02:44:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:39 INFO - 'HOME': '/Users/cltbld', 02:44:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:39 INFO - 'LOGNAME': 'cltbld', 02:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:39 INFO - 'MOZ_NO_REMOTE': '1', 02:44:39 INFO - 'NO_EM_RESTART': '1', 02:44:39 INFO - 'PAGER': '/bin/cat', 02:44:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:39 INFO - 'PWD': '/builds/slave/test', 02:44:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:39 INFO - 'SHELL': '/bin/bash', 02:44:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJCogcDOkA/Listeners', 02:44:39 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 02:44:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:39 INFO - 'USER': 'cltbld', 02:44:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:39 INFO - 'XPC_FLAGS': '0x0', 02:44:39 INFO - 'XPC_SERVICE_NAME': '0', 02:44:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:39 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 02:44:39 INFO - Cleaning up... 02:44:39 INFO - Return code: 0 02:44:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:44:39 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')]} 02:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:39 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')]} 02:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:39 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 0x103f1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fb1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3d77f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e80d30>, '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 0x103be5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e78b20>, '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.7JNrFIs9R4/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.ZJCogcDOkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 02:44:39 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 02:44:39 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 02:44:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7JNrFIs9R4/Render', 02:44:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:39 INFO - 'HOME': '/Users/cltbld', 02:44:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:39 INFO - 'LOGNAME': 'cltbld', 02:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:39 INFO - 'MOZ_NO_REMOTE': '1', 02:44:39 INFO - 'NO_EM_RESTART': '1', 02:44:39 INFO - 'PAGER': '/bin/cat', 02:44:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:39 INFO - 'PWD': '/builds/slave/test', 02:44:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:39 INFO - 'SHELL': '/bin/bash', 02:44:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJCogcDOkA/Listeners', 02:44:39 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 02:44:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:39 INFO - 'USER': 'cltbld', 02:44:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:39 INFO - 'XPC_FLAGS': '0x0', 02:44:39 INFO - 'XPC_SERVICE_NAME': '0', 02:44:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:39 INFO - Downloading/unpacking psutil>=3.1.1 02:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:44:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:44:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:44:43 INFO - Installing collected packages: psutil 02:44:43 INFO - Running setup.py install for psutil 02:44:43 INFO - building 'psutil._psutil_osx' extension 02:44:43 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 02:44:44 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 02:44:44 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 02:44:44 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 02:44:44 INFO - building 'psutil._psutil_posix' extension 02:44:44 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 02:44:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:44:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:44:44 INFO - ^ 02:44:44 INFO - 1 warning generated. 02:44:44 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 02:44:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:44:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:44:44 INFO - Successfully installed psutil 02:44:44 INFO - Cleaning up... 02:44:44 INFO - Return code: 0 02:44:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:44: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')]} 02:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44: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')]} 02:44:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103f1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fb1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3d77f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e80d30>, '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 0x103be5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e78b20>, '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.7JNrFIs9R4/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.ZJCogcDOkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 02:44: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:44: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 mozsystemmonitor==0.3 02:44:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7JNrFIs9R4/Render', 02:44:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:44 INFO - 'HOME': '/Users/cltbld', 02:44:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:44 INFO - 'LOGNAME': 'cltbld', 02:44:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:44 INFO - 'MOZ_NO_REMOTE': '1', 02:44:44 INFO - 'NO_EM_RESTART': '1', 02:44:44 INFO - 'PAGER': '/bin/cat', 02:44:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:44 INFO - 'PWD': '/builds/slave/test', 02:44:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:44 INFO - 'SHELL': '/bin/bash', 02:44:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJCogcDOkA/Listeners', 02:44:44 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 02:44:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:44 INFO - 'USER': 'cltbld', 02:44:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:44 INFO - 'XPC_FLAGS': '0x0', 02:44:44 INFO - 'XPC_SERVICE_NAME': '0', 02:44:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:44:45 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 02:44:45 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 02:44:45 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 02:44:45 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 02:44:45 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 02:44:45 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 02:44:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:44:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:44:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:44:47 INFO - Installing collected packages: mozsystemmonitor 02:44:47 INFO - Running setup.py install for mozsystemmonitor 02:44:47 INFO - Successfully installed mozsystemmonitor 02:44:47 INFO - Cleaning up... 02:44:47 INFO - Return code: 0 02:44:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:44:47 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')]} 02:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:47 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')]} 02:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:47 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 0x103f1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fb1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3d77f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e80d30>, '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 0x103be5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e78b20>, '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.7JNrFIs9R4/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.ZJCogcDOkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 02:44:47 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 02:44:47 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 02:44:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7JNrFIs9R4/Render', 02:44:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:47 INFO - 'HOME': '/Users/cltbld', 02:44:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:47 INFO - 'LOGNAME': 'cltbld', 02:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:47 INFO - 'MOZ_NO_REMOTE': '1', 02:44:47 INFO - 'NO_EM_RESTART': '1', 02:44:47 INFO - 'PAGER': '/bin/cat', 02:44:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:47 INFO - 'PWD': '/builds/slave/test', 02:44:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:47 INFO - 'SHELL': '/bin/bash', 02:44:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJCogcDOkA/Listeners', 02:44:47 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 02:44:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:47 INFO - 'USER': 'cltbld', 02:44:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:47 INFO - 'XPC_FLAGS': '0x0', 02:44:47 INFO - 'XPC_SERVICE_NAME': '0', 02:44:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:48 INFO - Downloading/unpacking jsonschema==2.5.1 02:44: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 02:44: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 02:44: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 02:44: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 02:44: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 02:44: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 02:44:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:44:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:44:50 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 02:44:50 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 02:44:50 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 02:44:50 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 02:44:50 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 02:44:50 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 02:44:51 INFO - Downloading functools32-3.2.3-2.tar.gz 02:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:44:51 INFO - warning: no files found matching '*.txt' 02:44:51 INFO - no previously-included directories found matching 'build' 02:44:51 INFO - no previously-included directories found matching 'dist' 02:44:51 INFO - no previously-included directories found matching '.git*' 02:44:51 INFO - Installing collected packages: jsonschema, functools32 02:44:51 INFO - Running setup.py install for functools32 02:44:51 INFO - warning: no files found matching '*.txt' 02:44:51 INFO - no previously-included directories found matching 'build' 02:44:51 INFO - no previously-included directories found matching 'dist' 02:44:51 INFO - no previously-included directories found matching '.git*' 02:44:51 INFO - Successfully installed jsonschema functools32 02:44:51 INFO - Cleaning up... 02:44:51 INFO - Return code: 0 02:44:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:51 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 0x103f1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fb1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3d77f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e80d30>, '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 0x103be5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e78b20>, '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.7JNrFIs9R4/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.ZJCogcDOkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 02:44:51 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 02:44:51 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 02:44:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7JNrFIs9R4/Render', 02:44:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:51 INFO - 'HOME': '/Users/cltbld', 02:44:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:51 INFO - 'LOGNAME': 'cltbld', 02:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:51 INFO - 'MOZ_NO_REMOTE': '1', 02:44:51 INFO - 'NO_EM_RESTART': '1', 02:44:51 INFO - 'PAGER': '/bin/cat', 02:44:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:51 INFO - 'PWD': '/builds/slave/test', 02:44:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:51 INFO - 'SHELL': '/bin/bash', 02:44:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJCogcDOkA/Listeners', 02:44:51 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 02:44:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:51 INFO - 'USER': 'cltbld', 02:44:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:51 INFO - 'XPC_FLAGS': '0x0', 02:44:51 INFO - 'XPC_SERVICE_NAME': '0', 02:44:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:44:51 INFO - Cleaning up... 02:44:51 INFO - Return code: 0 02:44:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:51 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 0x103f1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fb1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3d77f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e80d30>, '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 0x103be5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e78b20>, '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.7JNrFIs9R4/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.ZJCogcDOkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 02:44:51 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 02:44:51 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 02:44:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7JNrFIs9R4/Render', 02:44:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:51 INFO - 'HOME': '/Users/cltbld', 02:44:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:51 INFO - 'LOGNAME': 'cltbld', 02:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:51 INFO - 'MOZ_NO_REMOTE': '1', 02:44:51 INFO - 'NO_EM_RESTART': '1', 02:44:51 INFO - 'PAGER': '/bin/cat', 02:44:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:51 INFO - 'PWD': '/builds/slave/test', 02:44:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:51 INFO - 'SHELL': '/bin/bash', 02:44:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJCogcDOkA/Listeners', 02:44:51 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 02:44:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:51 INFO - 'USER': 'cltbld', 02:44:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:51 INFO - 'XPC_FLAGS': '0x0', 02:44:51 INFO - 'XPC_SERVICE_NAME': '0', 02:44:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:52 INFO - Downloading/unpacking blobuploader==1.2.4 02:44:52 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 02:44:52 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 02:44:52 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 02:44:52 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 02:44:52 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 02:44:52 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 02:44:54 INFO - Downloading blobuploader-1.2.4.tar.gz 02:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:44:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:44:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:44:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:44:55 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 02:44:55 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 02:44:55 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 02:44:55 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 02:44:55 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 02:44:55 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 02:44:55 INFO - Downloading docopt-0.6.1.tar.gz 02:44:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:44:55 INFO - Installing collected packages: blobuploader, requests, docopt 02:44:55 INFO - Running setup.py install for blobuploader 02:44:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:44:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:44:55 INFO - Running setup.py install for requests 02:44:56 INFO - Running setup.py install for docopt 02:44:56 INFO - Successfully installed blobuploader requests docopt 02:44:56 INFO - Cleaning up... 02:44:56 INFO - Return code: 0 02:44:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:44:56 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 0x103f1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fb1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3d77f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e80d30>, '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 0x103be5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e78b20>, '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.7JNrFIs9R4/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.ZJCogcDOkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 02:44:56 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 02:44:56 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 02:44:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7JNrFIs9R4/Render', 02:44:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:44:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:44:56 INFO - 'HOME': '/Users/cltbld', 02:44:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:44:56 INFO - 'LOGNAME': 'cltbld', 02:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:44:56 INFO - 'MOZ_NO_REMOTE': '1', 02:44:56 INFO - 'NO_EM_RESTART': '1', 02:44:56 INFO - 'PAGER': '/bin/cat', 02:44:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:44:56 INFO - 'PWD': '/builds/slave/test', 02:44:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:44:56 INFO - 'SHELL': '/bin/bash', 02:44:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJCogcDOkA/Listeners', 02:44:56 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 02:44:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:44:56 INFO - 'USER': 'cltbld', 02:44:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:44:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:44:56 INFO - 'XPC_FLAGS': '0x0', 02:44:56 INFO - 'XPC_SERVICE_NAME': '0', 02:44:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:44:56 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-cA2cGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:44:57 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-p9sMaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:44:57 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-6MYQQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:44:57 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-VnPlrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:44:57 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-xcpd9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:44:57 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-GjySq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:44:57 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-EfV09G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:44:57 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-D71OCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:44:57 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-r8kzJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:44:57 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-QLLSNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:44:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:44:57 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-djkRq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:44:58 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-j854Hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:44:58 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-xZ8fDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:44:58 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-dPYnJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:58 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-5LyFKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:44:58 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-YXzgV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:44:58 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-Q20hjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:44:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:44:58 INFO - Running setup.py install for manifestparser 02:44:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:44:58 INFO - Running setup.py install for mozcrash 02:44:58 INFO - Running setup.py install for mozdebug 02:44:59 INFO - Running setup.py install for mozdevice 02:44:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Running setup.py install for mozfile 02:44:59 INFO - Running setup.py install for mozhttpd 02:44:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Running setup.py install for mozinfo 02:44:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Running setup.py install for mozInstall 02:44:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:44:59 INFO - Running setup.py install for mozleak 02:44:59 INFO - Running setup.py install for mozlog 02:45:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:45:00 INFO - Running setup.py install for moznetwork 02:45:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:45:00 INFO - Running setup.py install for mozprocess 02:45:00 INFO - Running setup.py install for mozprofile 02:45:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:45:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:45:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:45:00 INFO - Running setup.py install for mozrunner 02:45:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:45:00 INFO - Running setup.py install for mozscreenshot 02:45:00 INFO - Running setup.py install for moztest 02:45:01 INFO - Running setup.py install for mozversion 02:45:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:45:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:45:01 INFO - Cleaning up... 02:45:01 INFO - Return code: 0 02:45:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:01 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')]} 02:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:01 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')]} 02:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:01 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 0x103f1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fb1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3d77f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e80d30>, '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 0x103be5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e78b20>, '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.7JNrFIs9R4/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.ZJCogcDOkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 02:45:01 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 02:45:01 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 02:45:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7JNrFIs9R4/Render', 02:45:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:01 INFO - 'HOME': '/Users/cltbld', 02:45:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:01 INFO - 'LOGNAME': 'cltbld', 02:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:01 INFO - 'MOZ_NO_REMOTE': '1', 02:45:01 INFO - 'NO_EM_RESTART': '1', 02:45:01 INFO - 'PAGER': '/bin/cat', 02:45:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:01 INFO - 'PWD': '/builds/slave/test', 02:45:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:01 INFO - 'SHELL': '/bin/bash', 02:45:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJCogcDOkA/Listeners', 02:45:01 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 02:45:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:01 INFO - 'USER': 'cltbld', 02:45:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:01 INFO - 'XPC_FLAGS': '0x0', 02:45:01 INFO - 'XPC_SERVICE_NAME': '0', 02:45:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:45:01 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-50t4vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:45:01 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)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:45:01 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-aa332v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:45:01 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)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:45:01 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-AUzu80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:45:01 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)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:45:01 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-YVTtmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:45:01 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)) 02:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:45:01 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-sLH9zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:45:02 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)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:45:02 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-62Ix05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:45:02 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)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:45:02 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-jW6jc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:45:02 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)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:45:02 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-RIKBp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:45:02 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)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:45:02 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-y8hIWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:45:02 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)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:45:02 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-sMY69e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:45:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:45:02 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-kLBklp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:45:02 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)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:45:02 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-4jxwhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:45:02 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)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:45:02 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-Dpw_R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:45:02 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)) 02:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:45:02 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-73k6n9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:45:03 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)) 02:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:03 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-JbcSud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:03 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)) 02:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:45:03 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-wpYe8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:45:03 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)) 02:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:45:03 INFO - Running setup.py (path:/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/pip-GZdf2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:45:03 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)) 02:45:03 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)) 02:45:03 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)) 02:45:03 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)) 02:45:03 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)) 02:45:03 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)) 02:45:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:45:03 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 02:45:03 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 02:45:03 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 02:45:03 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 02:45:03 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 02:45:03 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 02:45:05 INFO - Downloading blessings-1.6.tar.gz 02:45:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:45:05 INFO - Installing collected packages: blessings 02:45:05 INFO - Running setup.py install for blessings 02:45:06 INFO - Successfully installed blessings 02:45:06 INFO - Cleaning up... 02:45:06 INFO - Return code: 0 02:45:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:45:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:45:06 INFO - Reading from file tmpfile_stdout 02:45:06 INFO - Current package versions: 02:45:06 INFO - blessings == 1.6 02:45:06 INFO - blobuploader == 1.2.4 02:45:06 INFO - docopt == 0.6.1 02:45:06 INFO - functools32 == 3.2.3-2 02:45:06 INFO - jsonschema == 2.5.1 02:45:06 INFO - manifestparser == 1.1 02:45:06 INFO - mozInstall == 1.12 02:45:06 INFO - mozcrash == 0.17 02:45:06 INFO - mozdebug == 0.1 02:45:06 INFO - mozdevice == 0.48 02:45:06 INFO - mozfile == 1.2 02:45:06 INFO - mozhttpd == 0.7 02:45:06 INFO - mozinfo == 0.9 02:45:06 INFO - mozleak == 0.1 02:45:06 INFO - mozlog == 3.3 02:45:06 INFO - moznetwork == 0.27 02:45:06 INFO - mozprocess == 0.23 02:45:06 INFO - mozprofile == 0.28 02:45:06 INFO - mozrunner == 6.12 02:45:06 INFO - mozscreenshot == 0.1 02:45:06 INFO - mozsystemmonitor == 0.3 02:45:06 INFO - moztest == 0.7 02:45:06 INFO - mozversion == 1.4 02:45:06 INFO - psutil == 3.1.1 02:45:06 INFO - requests == 1.2.3 02:45:06 INFO - wsgiref == 0.1.2 02:45:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:06 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')]} 02:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:06 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')]} 02:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:06 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 0x103f1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fb1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3d77f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e80d30>, '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 0x103be5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e78b20>, '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.7JNrFIs9R4/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.ZJCogcDOkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 02:45:06 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 02:45:06 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 02:45:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7JNrFIs9R4/Render', 02:45:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:06 INFO - 'HOME': '/Users/cltbld', 02:45:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:06 INFO - 'LOGNAME': 'cltbld', 02:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:06 INFO - 'MOZ_NO_REMOTE': '1', 02:45:06 INFO - 'NO_EM_RESTART': '1', 02:45:06 INFO - 'PAGER': '/bin/cat', 02:45:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:06 INFO - 'PWD': '/builds/slave/test', 02:45:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:06 INFO - 'SHELL': '/bin/bash', 02:45:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJCogcDOkA/Listeners', 02:45:06 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 02:45:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:06 INFO - 'USER': 'cltbld', 02:45:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:06 INFO - 'XPC_FLAGS': '0x0', 02:45:06 INFO - 'XPC_SERVICE_NAME': '0', 02:45:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:06 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)) 02:45:06 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)) 02:45:06 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)) 02:45:06 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)) 02:45:06 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)) 02:45:06 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)) 02:45:06 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)) 02:45:06 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)) 02:45:06 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)) 02:45:06 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)) 02:45:06 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)) 02:45:06 INFO - Cleaning up... 02:45:06 INFO - Return code: 0 02:45:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:45:06 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')]} 02:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:06 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')]} 02:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:45:06 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 0x103f1ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fb1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa8f3d77f10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103e80d30>, '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 0x103be5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e78b20>, '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.7JNrFIs9R4/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.ZJCogcDOkA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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 02:45:06 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 02:45:06 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 02:45:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7JNrFIs9R4/Render', 02:45:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:06 INFO - 'HOME': '/Users/cltbld', 02:45:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:06 INFO - 'LOGNAME': 'cltbld', 02:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:06 INFO - 'MOZ_NO_REMOTE': '1', 02:45:06 INFO - 'NO_EM_RESTART': '1', 02:45:06 INFO - 'PAGER': '/bin/cat', 02:45:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:06 INFO - 'PWD': '/builds/slave/test', 02:45:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:06 INFO - 'SHELL': '/bin/bash', 02:45:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJCogcDOkA/Listeners', 02:45:06 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 02:45:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:06 INFO - 'USER': 'cltbld', 02:45:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:06 INFO - 'XPC_FLAGS': '0x0', 02:45:06 INFO - 'XPC_SERVICE_NAME': '0', 02:45:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:45:06 INFO - Cleaning up... 02:45:07 INFO - Return code: 0 02:45:07 INFO - Running post-action listener: _resource_record_post_action 02:45:07 INFO - Running post-action listener: _start_resource_monitoring 02:45:07 INFO - Starting resource monitoring. 02:45:07 INFO - [mozharness: 2016-09-08 09:45:07.035577Z] Finished create-virtualenv step (success) 02:45:07 INFO - [mozharness: 2016-09-08 09:45:07.036646Z] Running install step. 02:45:07 INFO - Running pre-action listener: _resource_record_pre_action 02:45:07 INFO - Running main action method: install 02:45:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:45:07 INFO - Reading from file tmpfile_stdout 02:45:07 INFO - Detecting whether we're running mozinstall >=1.0... 02:45:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:45:07 INFO - Reading from file tmpfile_stdout 02:45:07 INFO - Output received: 02:45:07 INFO - Usage: mozinstall [options] installer 02:45:07 INFO - Options: 02:45:07 INFO - -h, --help show this help message and exit 02:45:07 INFO - -d DEST, --destination=DEST 02:45:07 INFO - Directory to install application into. [default: 02:45:07 INFO - "/builds/slave/test"] 02:45:07 INFO - --app=APP Application being installed. [default: firefox] 02:45:07 INFO - mkdir: /builds/slave/test/build/application 02:45:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:45:41 INFO - Reading from file tmpfile_stdout 02:45:41 INFO - Output received: 02:45:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:45:41 INFO - Running post-action listener: _resource_record_post_action 02:45:41 INFO - [mozharness: 2016-09-08 09:45:41.199081Z] Finished install step (success) 02:45:41 INFO - [mozharness: 2016-09-08 09:45:41.199242Z] Running run-tests step. 02:45:41 INFO - Running pre-action listener: _resource_record_pre_action 02:45:41 INFO - Running main action method: run_tests 02:45:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:45:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:45:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:45:41 INFO - 2016-09-08 02:45:41.213 screenresolution[1650:7896] starting screenresolution argv=screenresolution get 02:45:41 INFO - 2016-09-08 02:45:41.216 screenresolution[1650:7896] Display 0: 1600x1200x32@60 02:45:41 INFO - 2016-09-08 02:45:41.222 screenresolution[1651:7898] starting screenresolution argv=screenresolution list 02:45:41 INFO - Available Modes on Display 0 02:45:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:45:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:45:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:45:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:45:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:45:41 INFO - Intel Iris: 02:45:41 INFO - Chipset Model: Intel Iris 02:45:41 INFO - Type: GPU 02:45:41 INFO - Bus: Built-In 02:45:41 INFO - VRAM (Dynamic, Max): 1536 MB 02:45:41 INFO - Vendor: Intel (0x8086) 02:45:41 INFO - Device ID: 0x0a2e 02:45:41 INFO - Revision ID: 0x0009 02:45:41 INFO - Displays: 02:45:41 INFO - Display: 02:45:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:45:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:45:41 INFO - Display Serial Number: 1600x1200 60 02:45:41 INFO - Main Display: Yes 02:45:41 INFO - Mirror: Off 02:45:41 INFO - Online: Yes 02:45:41 INFO - Rotation: Supported 02:45:41 INFO - Return code: 0 02:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:45:41 INFO - Python 2.7.3 02:45:41 INFO - Return code: 0 02:45:41 INFO - grabbing minidump binary from tooltool 02:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:41 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 0x103e80d30>, '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 0x103be5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103e78b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:45:41 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 02:45:41 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 02:45:41 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 02:45:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:45:41 INFO - Return code: 0 02:45:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:45:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:45:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:45:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:45:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0110', '--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 02:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0110 --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 02:45:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7JNrFIs9R4/Render', 02:45:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:45:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:45:41 INFO - 'HOME': '/Users/cltbld', 02:45:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:45:41 INFO - 'LOGNAME': 'cltbld', 02:45:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:45:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:41 INFO - 'MOZ_NO_REMOTE': '1', 02:45:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:45:41 INFO - 'NO_EM_RESTART': '1', 02:45:41 INFO - 'PAGER': '/bin/cat', 02:45:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:41 INFO - 'PWD': '/builds/slave/test', 02:45:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:45:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:45:41 INFO - 'SHELL': '/bin/bash', 02:45:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJCogcDOkA/Listeners', 02:45:41 INFO - 'TMPDIR': '/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/', 02:45:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:45:41 INFO - 'USER': 'cltbld', 02:45:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:45:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:41 INFO - 'XPC_FLAGS': '0x0', 02:45:41 INFO - 'XPC_SERVICE_NAME': '0', 02:45:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:45:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0110', '--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 02:45:41 INFO - mozversion application_buildid: 20160907175716 02:45:41 INFO - mozversion application_changeset: 77940cbf0c2a9f52c209fbbde5b2e7d4c74a1501 02:45:41 INFO - mozversion application_display_name: Nightly 02:45:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:45:41 INFO - mozversion application_name: Firefox 02:45:41 INFO - mozversion application_remotingname: firefox 02:45:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:45:41 INFO - mozversion application_vendor: Mozilla 02:45:41 INFO - mozversion application_version: 51.0a1 02:45:41 INFO - mozversion platform_buildid: 20160907175716 02:45:41 INFO - mozversion platform_changeset: 77940cbf0c2a9f52c209fbbde5b2e7d4c74a1501 02:45:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:45:41 INFO - mozversion platform_version: 51.0a1 02:45:41 INFO - using testdate: 1473327941 02:45:41 INFO - actual date: 1473327941 02:45:41 INFO - starting webserver on 'localhost:49286' 02:45:41 INFO - SUITE-START | Running 2 tests 02:45:41 INFO - TEST-START | dromaeo_css 02:45:41 INFO - operating with platform_type : mac_ 02:45:41 INFO - Initialising browser for dromaeo_css test... 02:45:41 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmp83iOdW/profile http://localhost:49286/getInfo.html) 02:45:44 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 02:45:44 INFO - PROCESS | 1661 | colorDepth:24 02:45:44 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 02:45:44 INFO - PROCESS | 1661 | __metrics 02:45:44 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 02:45:45 INFO - TEST-INFO | 1661: exit 0 02:45:45 INFO - Browser initialized. 02:45:45 INFO - Running cycle 1/1 for dromaeo_css test... 02:45:45 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmp83iOdW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:57 INFO - PROCESS | 1664 | RSS: Main: 243986432 02:45:57 INFO - PROCESS | 1664 | 02:46:47 INFO - PROCESS | 1664 | 1473328007010 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] 02:48:59 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49286/tests/dromaeo/cssquery-ext.html) 02:49:00 INFO - PROCESS | 1664 | RSS: Main: 266481664 02:49:00 INFO - PROCESS | 1664 | 02:52:02 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-ext.html (next: http://localhost:49286/tests/dromaeo/cssquery-jquery.html) 02:52:03 INFO - PROCESS | 1664 | RSS: Main: 274395136 02:52:03 INFO - PROCESS | 1664 | 02:55:05 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49286/tests/dromaeo/cssquery-mootools.html) 02:55:05 INFO - PROCESS | 1664 | RSS: Main: 275968000 02:55:05 INFO - PROCESS | 1664 | 02:58:07 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49286/tests/dromaeo/cssquery-prototype.html) 02:58:08 INFO - PROCESS | 1664 | RSS: Main: 270217216 02:58:08 INFO - PROCESS | 1664 | 03:01:11 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49286/tests/dromaeo/cssquery-yui.html) 03:01:11 INFO - PROCESS | 1664 | RSS: Main: 277131264 03:01:11 INFO - PROCESS | 1664 | 03:04:14 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49286/tests/dromaeo/cssquery-yui.html (next: http://localhost:49286/tests/dromaeo/cssquery-dojo.html) 03:04:14 INFO - PROCESS | 1664 | RSS: Main: 279314432 03:04:14 INFO - PROCESS | 1664 | 03:04:14 INFO - PROCESS | 1664 | __start_tp_report 03:04:14 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 03:04:14 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 03:04:14 INFO - PROCESS | 1664 | |i|pagename|runs| 03:04:14 INFO - PROCESS | 1664 | |0;dojo.html;3399.6600339966008;3407.2844702612456;3409.573803274591;3423.1271025888404;3437.501562273472;4856.271559266112;4982.87542811429;5589.357223919251;5701.771929122835;5805.477507024361;5676.035074037413;5690.4025077366905;5704.971475142629;5742.511886489653;5765.019946609076;5109.565686916617;5195.87010324743;5200.739963001834;5269.2886460327745;5314.362276526822;5281.841544753664;5344.091504444254;5352.116900711378;5366.409694933554;5377.569794416438;5158.819441319536;5186.688798672092;5212.192110222922;5218.295530103425;5248.21276808478;5193.68837869729;5227.895442091137;5231.738413079369;5241.842744717665;5286.550643195333;5203.713795741232;5214.687118772886;5237.685738855643;5244.213367994793;5250.842474725764;5482.2873026506295;5572.219889215513;5624;5696;5721.141828725683;6249.312575616724;6252.812415627538;6274.215723034621;6284.842878928018;6298.866204083263;6296.811095667137;6310.779122730728;6322.620642761403;6339.8098057057905;6344.49244060474;5679.403662615448;5724.398938111522;5733.226014488074;5795.768169273266;5870.677112758796;6192.473639740672;6212.316645169028;6212.534059945522;6224.37756224383;6278.560500764903;5236.685798852005;5380.838574842683;6164.229471316085;6164.7842325518395;6174.845628859224;4846.418429788448;6155.692215389302;6205.503559715212;6269.7492100316385;6283.497320214372;5015.974920125449;6152.323244443108;6169.259688837368;6209.65846878417;6225.066240064027;6233.1273621693;6241.282252541016;6242.687865606701;6253.343398943045;6260.467860231931;4327.0480494291205;4872.585830204473;4910.042541704404;4983.177775667047;4988.201887697951;4427.092446048552;4432.227109156363;4439.600435960779;4460.420145381079;4512.368268442421;5590.217369568264;5695.060315047971;5701.486866182064;5748.310202775694;5763.769449221984;6187.978983467678;6282.434580887742;6296.118543403927;6305.621662700252;6318.8420289492215;5290.418054014055;5744.684042377709;5771.9711401443565;5805.216295800013;5838.9124163137585;5405.8107966221;5417.214503896992;5422.457754224546;5429.647072940246;5431;6181.505479561534;6300.653464059521;6305.96847015762;6317.715702793477;6326.145970294044;6216.968915155395;6254.8123556293385;6268.216472940882;6299.212598425197;6301.590396624205;6270;6309.936900630935;6325.905111423424;6331.778387756406;6332.986722124438;6051.697415129314;6240.251169859646;6248.218972628421;6262.311145774052;6268.937310626835;6214.40963108504;6222.160008398808;6262.060690896402;6308.747650093945;6333.841653958503;6123.081537769192;6166.475849552839;6186.845328866814;6190.690465476618;6202.193714817045;6078.209832721718;6115.327313995546;6178.814635560941;6197.318294987638;6213.2233470816145;5902.5277977762535;5939.138824870283;5968.731407086605;6003.189569408074;6021.096835474714;6141.938580614136;6150.138980542817;6151.507879369729;6152.630842149485;6160.383961603804;5687.033204355187;5881.206037185097;5964.224650795369;5972.58191926561;5984.640921544721 03:04:14 INFO - PROCESS | 1664 | |1;ext.html;483.6952719786535;502.482443083624;515.8890838469729;529.8237911835723;532.1857557936357;36197;38445.807770961175;38447.84656460304;38471.42292865602;38496.615033849615;39868.60131398685;40475;40517.594824051754;40616.39075413871;40653.186936261256;9518.048195180478;9660.98559651237;9737.464439455827;9759.756006099833;9776.266779991494;9658.855117173249;9744.853827192563;9767.853482197772;9771.56027978739;9793.314467987244;9743.902560974406;9790.020997900188;9795.02049795022;9802.264830137732;9805.31362804604;8308.7091951782;8676.175763302475;8735.825283494358;9557.522123893812;9775.51122443875;9588.808223835484;9608.231341492663;9626.75933101671;9694.563744631509;9723.805523889554;30931.216190542735;38323;38585.80707096474;38666.61333386658;38696.03259918497;2965.8368789716556;3253.544503769474;3297.274599588111;3360.294338188983;4085.44846445729;23277.883610581837;28792.790812682022;29559.113226603236;29924.251893702614;30419.847900760575;3227.289996200832;3232.6767323267723;3235.8705651773903;3239.3359361331104;3327.2014716468116;345386.27306863555;349814.5018549782;351078;351577;351589.2420537881;51331.716707081876;53355.46644533583;53537;53659.73170134125;53767.462325377026;33026;34122.48816267758;34240.82879585636;57246.42753572411;57294.713526432104;15669.216539173223;15822.920885395499;15885.205739712968;15897.68204635924;15928.203589820694;12287.877121228674;12370.690732731753;12373.876261237452;12414.875851241553;12414.944729697896;15294.311755971008;17464.301427942995;17526;17571.56071098207;17645.55886102832;6590.472762179014;7620.80947976305;7741.419393545507;7777.766666999999;7818.296353328228;836.1721895323586;836.5608055770768;913.0139449394638;937.4047479850344;1120.4453795371344;21194.470138246357;26042.86978565095;28708.138755837357;29005.70994290072;29040.854795725885;1041.3959903256093;1059.078601616583;1122.680036189682;1138.4592318648577;1159.8956093951585;12281.87819452521;15041.774373384407;15131.848681513264;15222.847771522365;15269.083854968738;642976;657358;657574;659054;660595;52480.212796808075;54549.72725136428;54939.45060549343;55412.445875540725;55656;1313.7175507265983;1345.2668295778824;1366.5626999360109;1374.312843578211;1377.4283672276094;27901.58147627828;28732.85633571819;28747.28131796722;29321.85339073291;29326.706732932398;46503.76748116238;46830;46940.295895560914;47071.52928470672;47277.29084063673;578887;583233;583458;584279;585084;25081.87459062693;25302.873485632455;25405.745942541078;25505.48989020246;25544.744552554235;44298.55701442944;44521.10957780761;44629.77685111554;45301;45497.77251113856;37017.25965480729;37216;37216;38213.617863821004;38371.80814095912;36888.26223475569;36982;37481.06297342479;37703.81148094242;37818;28203.43593128167;29124.854375727984;35566.82216589004;36138.4579231317;36356.81821590875;31776.36447271088;32101.35797284088;33609.663903360655;33624.49563256504;33793.83103084469;22743.545129097656;23500.01741995528;24377.756222437547;24770.25689229326;25224.62163067519 03:04:14 INFO - PROCESS | 1664 | |2;jquery.html;321.53377602476405;369.69315468161415;370.7812390689493;380.73158423311565;405.69164444665955;19383.612327753453;19457.70813437798;20698;20808.89595552024;20862.895685521587;20118.295859644917;20590.588188236226;20837.68743468849;20885;21021.68467472989;5900.996830538797;5912.467877890989;6082;6182.690865456731;6204.4416002559765;6045.6674882881425;6133.539984501181;6141;6145.047517634752;6166.105914642374;5916.142159386886;6021.126936594192;6030.336662967092;6084.665343406111;6093.207882975207;5940.316863560703;6012.939870601282;6032.306284777263;6048.123022161806;6068.605540639866;5245.6852588844795;5505.229267902497;5526.005319042571;5590.832275031756;5634.887302253973;13084.738305233937;13316.467341306336;17894;24648.260552183285;25121.246362609152;2100.5646572292067;2138.016512404296;2255.5263394687136;2317.9420514487106;2510.234378514552;7895.368370530401;9656.855147172799;9920.206383489303;10225.693229203136;10233.437160956144;1876.3432798520546;1885.566319746466;1895.9431217063511;1912.416712902564;1930.6138772245467;112330.99999999919;115544;115954.42022789831;118024.40987795006;118493;9334.486603236752;11307.60423385194;11350.14873884462;11569.479373428216;11941.402929853473;14161.78757318641;14165;14170.504032358818;14175.78736318956;14207.64480887986;8290.626921788535;8427.199416055464;8428.241458268785;8442.746717598482;8574.95712521446;7418.332350088518;7893.802654933673;8376.6677562179;8444.366672499587;8572.657093716181;4043.9191216175514;4046.393041043808;4152.730072545275;4508.233600287959;4520.525344838745;1897.8481721462526;1935.796741342167;1945.7178709087102;1950.0542237015036;1978.240349744156;845.8392905347964;893.2809088683672;901.1754244866005;935.8970513243538;970.1656575345197;19330.8066919329;19976.3008294709;20181.49546261355;20244.392668219683;20314.59370812605;932.3939439364332;969.0842154164247;970.5441837244134;978.9118979291898;996.9800603988025;10678.786424271471;10805.459727013618;10814.56741730322;10816.405097719544;10834.945825270823;547151;550835;551940;563671;565986;45851.541484585396;53157;85619.58184599689;96846;104699.42950855743;882.188386684252;972.2999440402899;997.835357166074;1026.856240126383;1027.4503140819625;14395.848332133613;17881;17972.460826175236;18547.53631159178;18667.346642867433;50817.23774143317;51343.48656513387;52754;53484.46515534795;54045;61338;78532;78631;78861.60569197117;80048.19951800407;7796.883046754417;7932.920670793449;7943.4836735612;8093.433459658003;8150.510969341858;10214.233932455245;12440.937795310965;12697.238165710087;12812;13010.934945325213;10593.947030265108;10765.569377224823;10919;10991.61529346469;11169.218154729091;10559.577616895545;10676.733081673021;10723.731906702395;10763.730906727395;10955.83566246491;8055.919440805517;8628.654853806029;11111;11252.21234513609;11257.943710281395;7763.340116089969;7853.921460785319;7896.052473703192;7948.523088614702;8107.554084525408;10193.592256309665;10201.183905287411;10429.843552346872;10579.62971296001;10687.732806679584 03:04:14 INFO - PROCESS | 1664 | |3;mootools.html;1451.0713143588105;1476.1807197005658;1666.2085509383037;1682.663467306539;1864.2729335559143;8038.839223215532;8419.36854735895;8581.270591999672;8926.241269492084;8974.820503589925;8542.97484301883;8716.25911797498;8722.127787221274;8728.127187281269;8741.169588889044;2037.4193354893857;2398.9160379386767;2402.147237730607;2408.7350391456926;2424.806015518763;1862.3947217154412;2366.597678394677;2407.759224077587;2408.8434251773665;2416.4200591858003;2400.327908185711;2405.4226985523437;2412.2763171048705;2417.709874815016;2418.2503423938633;2383.380321116505;2400.7719266669724;2404.182577923497;2405.3625789165885;2411.3007227903972;2364.8344615876895;2378.5361854438393;2378.9532605653458;2380.0598763488497;2386.72552656445;8776.60505277264;8797.47215167092;8824.823503529959;8825.735227943173;8843.159899809507;5246.475352464723;5313.681179129226;5363.544098751572;5386.569074474032;5405.459454054563;3604.5314109165643;3637.909052273714;3641.3809652359164;3644.9817750911075;3679.1537946272238;1098.9230753847235;1098.961536346224;1101.1081024370285;1109.6393672056613;1126.0372381613765;9724.465154416434;9767.267454940837;11087.168462365275;11341.26281791681;11415.771684566262;4553.3397657340165;4655.627549796076;4797.472278049412;4824.252240902666;4829.348038014893;9726.90273097274;9742;9777.511124443892;9797.31418800677;9816.361936474106;5243.895122097537;5341.252224688546;5344.412114667383;5347.86630334237;5349.545288650431;4435.578620031092;4760.880977975578;4899.485554016848;4913.508649135129;4949.9605082932985;3888.902777430587;3917.05990562263;3989.122393073519;4003.11931375097;4057.69567282455;1090.2368342160519;1235.745718096133;1315.9736805263842;1316.9539066132832;1328.920264784116;830.5971603772166;900.7207765592688;910.2217603948528;919.388606576619;952.9094736000069;5466.316710411199;5638.774449022075;5951.613145145551;6134.938650613526;6139.10982907476;374.63473113714457;444.42890885212347;452.77813871203534;850.2701120630265;938.5776400619612;3722.664960153545;3989.108846822001;4027.6979226558124;4058.2492238935893;4132.648724858361;10481.475926203659;10665.253432259668;10752.354858708502;10755;10811.405372704578;10631.681049568526;10744.838827417596;10746.838797418044;10765.623203188008;10796.67609971702;7715.498492597963;8101.270885620323;8234.094249632535;8245.752627421187;8251.2986396157;5076.974615127048;5908.143319218775;5980.461758441761;6040.939590604214;6157.784477543264;7651.617419129133;9562.90437095648;9723.978982206767;9847.538115471132;9848.753781155528;9937.65218217359;10006.749831254278;10055.798884022424;10075.496225188857;10086.899131008597;7042.591481703577;7444.404447644284;7541.924580754122;7605.46761726696;7679.310551678622;8414.915850841413;8500.107488713844;8502.617382217939;8513.787155321166;8521.318294536299;7398.630068496446;7404.777856664308;7521.285477879593;7551.886721699069;7623.69505219785;7221.277872212737;7391.002214701161;7440.032795736736;7526.059242594676;7539.0576177977755;6786.423154031962;6809.114815074008;6847.760328388483;6849.383555479832;6867.553609015398;4945.357103576656;5028.497150284942;5081.8475445736685;5082.822101226439;5120.8222108914415;5005.424376196784;5008.799648014185;5133.974330128325;5166.586673066071;5184.326037615086 03:04:14 INFO - PROCESS | 1664 | |4;prototype.html;298.2647773238967;306.4636885450462;312.2957730318132;313.59702781925233;314.10793346894826;4685.4143232095985;5398.3521977362725;5499.642523235987;5643.520300774439;5665.4334566543375;4577.450705915287;4891.48639392864;5090.414602320725;5603.831885043445;5655.670917334423;3938.2714197873343;4058.046359105615;4303.720258183223;4325.767156360438;4327.242732521796;3942.5071866016747;4200.180964711883;4316.482022157345;4365.36702178184;4372.2130016597;4172.415861779338;4194.30793919003;4196.3705444183315;4210.200061988213;4233.872983810491;3932.292187406266;4176.1230141670285;4202.600752928467;4222.619964203206;4254.87235382939;3622.728295377857;3627.5828279747902;3628.727845411605;3647.1064589175558;3660.396034654279;5264.947350526484;5425.321834770653;5489.204065410533;5508.944910550883;5516.7517461714315;3989.9227208653792;4336.376492222192;4791.233402655594;4870.6347023972985;4878.463369029404;4688.835890743808;4780.904381912343;4888.315635810989;5320.015797077514;5980.372060933626;3689.2252626948375;3769.9623003769884;3998.8000599969887;4014.8996275093064;4017.27689015977;5890.970545147246;5974.641521508724;6287.245530536319;6287.371262873722;6356.586821856565;3238.2713889374704;3631.5460567429072;4102.794860256975;4109.876703698894;4109.8972525687095;3435.3129374125274;3585.6055833858254;3740.6259374062374;4096.91806163875;4170.16596680665;4538.909221815546;4768.260919557474;4818.301346304836;4846.055019271279;4888.2178851383605;5135.35529202461;5257.78968841242;5953.553483488756;6063.211782468339;6094.268687757498;1189.79178643737;1324.4503531034513;1354.8348420358484;1393.226759148662;1401.7897315402772;908.0193391137556;912.3440954667391;937.381328323317;940.2994768897215;940.7083804020775;5401.621886467988;5587.608867379326;5590.552755779528;5600.635958662674;5642.576806739429;4874.4150701916;5078.806480477085;6032.426919442646;6087.817365479043;6140.4648837790555;5279.149259399957;5454.072807622713;5513.889722205534;5567.49892509668;5584.050711379075;2560.0911676355;2582.0704546363295;2642.696089949642;2709.2955831483564;2746.6541394716846;4778.450478194983;4949.752512374367;4975.4527002029745;5167.4832516748775;5286.259923610698;4229.398919664446;5033.6224783141415;5089.847304580869;5303.939212157584;5310.972745535085;4495.605817607685;5234.345706786576;5236.476352364733;5263.7894484220205;5289.280983680243;4742.549457801641;5080.822171223989;5088.491150884882;5161.354830646169;5163.845084647316;4433.512313645432;4528.320751887111;5054.69671819692;5190.455002224863;5232.450592687713;4600.6319494439695;4883.487233840538;4999.825041115408;5228.816991405282;5262.842114736564;3196.785221615771;3516.2440075383915;3530.7175425966375;3580.7135429165082;3583.802890841029;4100.17996400727;4206.789660516901;4448.35498852671;4822.614190864652;5202.684805261622;4480.417545719036;5527.530159936289;5742.741576628978;5836.795712150054;5983.401659833982;4989.975050124726;5012.498750124958;5803;5966.612170208922;6054.426868580924;5542.528885044816;5748.338941021836;5752.367239603556;5783.942160578508;5932.762689492372;5191.9751296994955;5691.943080569141;5933.9109913352195;5973.820785376446;5980.551458640706;5348.232098347745;5442.047641662773;5826.650400975955;5875.853103672443;5934.190072028073 03:04:14 INFO - PROCESS | 1664 | |5;yui.html;673.909022281992;686.9484788640854;695.3984803145281;726.2120599149922;819.9545579386283;15241.695166096672;15353.84646153538;15696.84303156968;15841.603959901007;15887.68224635508;10816.621418250363;14380.065295755769;14384.85615143851;14485.058471199365;14958.850411495881;844.3878188313485;863.6156910174975;864.8529749942525;866.761640548851;870.0994470722803;671.0772687554612;832.196929962586;858.159004175908;865.0916537635458;865.9911203448007;905.7509184974152;908.8318661047695;909.2271569166222;910.2717825739383;910.8451563234266;890.5369208011863;898.9146031127033;904.0462312260562;905.6241659711212;908.6320040383622;650.6779144323543;663.0452148905608;663.2207156590986;664.8504086580529;665.7969319357594;14168.291585420791;14198.148111113367;14206.289685515683;14219.289035548285;14253.216073115975;14409.06341087826;14441;14608.415663373453;14683.779743303752;14777.408903643842;10273.86338721574;10378.688639340831;11782.351970641612;11874.871887170704;11963.581274655346;3796.8718220917112;3878.5151856017997;3888.844446222148;3894;3915.158240978175;118252;121338;122026;122530;122819.99999999911;8974.820503589892;11097.500612472459;11305.378204198849;11439.714007149722;11545.36500492481;22799.088036478686;22974.310770676908;23252.117055418214;23330.300090997298;23510.882445587664;7868.606569671493;7934.166912474107;7954.323882470055;8045.275925166763;8070.071941726659;3494.4234201357;4023.6378725914224;4103.138340948434;4122.628963393249;4153.7507749535125;3552.289542091592;3695.7412981091065;3699.574548926854;3699.6855267302044;3714.9442758358646;591.6657088744845;643.9967800161063;660.5640277416882;660.6795704083515;667.3160010988776;578.254052272572;592.6503363015842;593.5637306579661;674.4536925090692;675.5136301862651;8502.532360720219;9068.8639670405;9075.13786190324;9367.297452690938;9456.52717364129;581.9039858423397;586.8620874094585;611.953559413408;626.9874602507924;665.9167604049494;3599.600599101348;3791.4881490998364;3819;3820.8662696805477;4571.085782843445;117496.94247899258;147423;163588;163961;168288.1585592064;142766;143721;143997.2401103965;144319;147525;86396.27207455816;121785;121910;126473;126725.3663731657;8714.825703486022;8750;8757.562121894007;8896.243819275434;9091.499967501586;58088.4191158083;64730;68556;69500.95748563876;70622.29377706157;67790;97974.51012745175;101602.49198753959;102931.4853425728;103364;11694.649160525198;11991.76016479648;12015.45930433115;12117.636470905887;12359.134860559674;12964.611061668165;13003.349832508526;13157.53948611794;13504.594862154152;13706.383212755649;10968.738595061352;12161.087918405978;12190.207636503954;12330.383480826102;12633.494660213857;10892.455377230948;11917.404129793302;12035.578754743541;12341.75316493683;12463.813042804184;11903.523859045888;12060.155789094679;12154.718087035006;12401.441935112762;12431.751364972832;8512.008560557786;10395.792084158425;10624.84062739075;10631.255812093079;10752.731181720519;9196.218321442751;9535.284853635867;9553.283503737386;10554.894451055392;10621.575136994743 03:04:14 INFO - PROCESS | 1664 | __end_tp_report 03:04:14 INFO - PROCESS | 1664 | __start_cc_report 03:04:14 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,383 03:04:14 INFO - PROCESS | 1664 | __end_cc_report 03:04:14 INFO - PROCESS | 1664 | __startTimestamp1473329054728__endTimestamp 03:04:14 INFO - PROCESS | 1664 | 03:04:14 INFO - PROCESS | 1664 | ------- Summary: start ------- 03:04:14 INFO - PROCESS | 1664 | Number of tests: 6 03:04:14 INFO - PROCESS | 1664 | 03:04:14 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5726.84 Median:5939.14 stddev:651.50 (11.0%) stddev-sans-first:627.40 03:04:14 INFO - PROCESS | 1664 | Values: 3399.7 3407.3 3409.6 3423.1 3437.5 4856.3 4982.9 5589.4 5701.8 5805.5 5676.0 5690.4 5705.0 5742.5 5765.0 5109.6 5195.9 5200.7 5269.3 5314.4 5281.8 5344.1 5352.1 5366.4 5377.6 5158.8 5186.7 5212.2 5218.3 5248.2 5193.7 5227.9 5231.7 5241.8 5286.6 5203.7 5214.7 5237.7 5244.2 5250.8 5482.3 5572.2 5624.0 5696.0 5721.1 6249.3 6252.8 6274.2 6284.8 6298.9 6296.8 6310.8 6322.6 6339.8 6344.5 5679.4 5724.4 5733.2 5795.8 5870.7 6192.5 6212.3 6212.5 6224.4 6278.6 5236.7 5380.8 6164.2 6164.8 6174.8 4846.4 6155.7 6205.5 6269.7 6283.5 5016.0 6152.3 6169.3 6209.7 6225.1 6233.1 6241.3 6242.7 6253.3 6260.5 4327.0 4872.6 4910.0 4983.2 4988.2 4427.1 4432.2 4439.6 4460.4 4512.4 5590.2 5695.1 5701.5 5748.3 5763.8 6188.0 6282.4 6296.1 6305.6 6318.8 5290.4 5744.7 5772.0 5805.2 5838.9 5405.8 5417.2 5422.5 5429.6 5431.0 6181.5 6300.7 6306.0 6317.7 6326.1 6217.0 6254.8 6268.2 6299.2 6301.6 6270.0 6309.9 6325.9 6331.8 6333.0 6051.7 6240.3 6248.2 6262.3 6268.9 6214.4 6222.2 6262.1 6308.7 6333.8 6123.1 6166.5 6186.8 6190.7 6202.2 6078.2 6115.3 6178.8 6197.3 6213.2 5902.5 5939.1 5968.7 6003.2 6021.1 6141.9 6150.1 6151.5 6152.6 6160.4 5687.0 5881.2 5964.2 5972.6 5984.6 03:04:14 INFO - PROCESS | 1664 | 03:04:14 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:65192.77 Median:37592.44 stddev:146235.58 (389.0%) stddev-sans-first:146565.10 03:04:14 INFO - PROCESS | 1664 | Values: 483.7 502.5 515.9 529.8 532.2 36197.0 38445.8 38447.8 38471.4 38496.6 39868.6 40475.0 40517.6 40616.4 40653.2 9518.0 9661.0 9737.5 9759.8 9776.3 9658.9 9744.9 9767.9 9771.6 9793.3 9743.9 9790.0 9795.0 9802.3 9805.3 8308.7 8676.2 8735.8 9557.5 9775.5 9588.8 9608.2 9626.8 9694.6 9723.8 30931.2 38323.0 38585.8 38666.6 38696.0 2965.8 3253.5 3297.3 3360.3 4085.4 23277.9 28792.8 29559.1 29924.3 30419.8 3227.3 3232.7 3235.9 3239.3 3327.2 345386.3 349814.5 351078.0 351577.0 351589.2 51331.7 53355.5 53537.0 53659.7 53767.5 33026.0 34122.5 34240.8 57246.4 57294.7 15669.2 15822.9 15885.2 15897.7 15928.2 12287.9 12370.7 12373.9 12414.9 12414.9 15294.3 17464.3 17526.0 17571.6 17645.6 6590.5 7620.8 7741.4 7777.8 7818.3 836.2 836.6 913.0 937.4 1120.4 21194.5 26042.9 28708.1 29005.7 29040.9 1041.4 1059.1 1122.7 1138.5 1159.9 12281.9 15041.8 15131.8 15222.8 15269.1 642976.0 657358.0 657574.0 659054.0 660595.0 52480.2 54549.7 54939.5 55412.4 55656.0 1313.7 1345.3 1366.6 1374.3 1377.4 27901.6 28732.9 28747.3 29321.9 29326.7 46503.8 46830.0 46940.3 47071.5 47277.3 578887.0 583233.0 583458.0 584279.0 585084.0 25081.9 25302.9 25405.7 25505.5 25544.7 44298.6 44521.1 44629.8 45301.0 45497.8 37017.3 37216.0 37216.0 38213.6 38371.8 36888.3 36982.0 37481.1 37703.8 37818.0 28203.4 29124.9 35566.8 36138.5 36356.8 31776.4 32101.4 33609.7 33624.5 33793.8 22743.5 23500.0 24377.8 24770.3 25224.6 03:04:14 INFO - PROCESS | 1664 | 03:04:14 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:31950.72 Median:2212.33 stddev:92208.18 (4167.9%) stddev-sans-first:92436.26 03:04:14 INFO - PROCESS | 1664 | Values: 321.5 369.7 370.8 380.7 405.7 19383.6 19457.7 20698.0 20808.9 20862.9 20118.3 20590.6 20837.7 20885.0 21021.7 5901.0 5912.5 6082.0 6182.7 6204.4 6045.7 6133.5 6141.0 6145.0 6166.1 5916.1 6021.1 6030.3 6084.7 6093.2 5940.3 6012.9 6032.3 6048.1 6068.6 5245.7 5505.2 5526.0 5590.8 5634.9 13084.7 13316.5 17894.0 24648.3 25121.2 2100.6 2138.0 2255.5 2317.9 2510.2 7895.4 9656.9 9920.2 10225.7 10233.4 1876.3 1885.6 1895.9 1912.4 1930.6 112331.0 115544.0 115954.4 118024.4 118493.0 9334.5 11307.6 11350.1 11569.5 11941.4 14161.8 14165.0 14170.5 14175.8 14207.6 8290.6 8427.2 8428.2 8442.7 8575.0 7418.3 7893.8 8376.7 8444.4 8572.7 4043.9 4046.4 4152.7 4508.2 4520.5 1897.8 1935.8 1945.7 1950.1 1978.2 845.8 893.3 901.2 935.9 970.2 19330.8 19976.3 20181.5 20244.4 20314.6 932.4 969.1 970.5 978.9 997.0 10678.8 10805.5 10814.6 10816.4 10834.9 547151.0 550835.0 551940.0 563671.0 565986.0 45851.5 53157.0 85619.6 96846.0 104699.4 882.2 972.3 997.8 1026.9 1027.5 14395.8 17881.0 17972.5 18547.5 18667.3 50817.2 51343.5 52754.0 53484.5 54045.0 61338.0 78532.0 78631.0 78861.6 80048.2 7796.9 7932.9 7943.5 8093.4 8150.5 10214.2 12440.9 12697.2 12812.0 13010.9 10593.9 10765.6 10919.0 10991.6 11169.2 10559.6 10676.7 10723.7 10763.7 10955.8 8055.9 8628.7 11111.0 11252.2 11257.9 7763.3 7853.9 7896.1 7948.5 8107.6 10193.6 10201.2 10429.8 10579.6 10687.7 03:04:14 INFO - PROCESS | 1664 | 03:04:14 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5669.59 Median:5082.33 stddev:3134.08 (61.7%) stddev-sans-first:3126.84 03:04:14 INFO - PROCESS | 1664 | Values: 1451.1 1476.2 1666.2 1682.7 1864.3 8038.8 8419.4 8581.3 8926.2 8974.8 8543.0 8716.3 8722.1 8728.1 8741.2 2037.4 2398.9 2402.1 2408.7 2424.8 1862.4 2366.6 2407.8 2408.8 2416.4 2400.3 2405.4 2412.3 2417.7 2418.3 2383.4 2400.8 2404.2 2405.4 2411.3 2364.8 2378.5 2379.0 2380.1 2386.7 8776.6 8797.5 8824.8 8825.7 8843.2 5246.5 5313.7 5363.5 5386.6 5405.5 3604.5 3637.9 3641.4 3645.0 3679.2 1098.9 1099.0 1101.1 1109.6 1126.0 9724.5 9767.3 11087.2 11341.3 11415.8 4553.3 4655.6 4797.5 4824.3 4829.3 9726.9 9742.0 9777.5 9797.3 9816.4 5243.9 5341.3 5344.4 5347.9 5349.5 4435.6 4760.9 4899.5 4913.5 4950.0 3888.9 3917.1 3989.1 4003.1 4057.7 1090.2 1235.7 1316.0 1317.0 1328.9 830.6 900.7 910.2 919.4 952.9 5466.3 5638.8 5951.6 6134.9 6139.1 374.6 444.4 452.8 850.3 938.6 3722.7 3989.1 4027.7 4058.2 4132.6 10481.5 10665.3 10752.4 10755.0 10811.4 10631.7 10744.8 10746.8 10765.6 10796.7 7715.5 8101.3 8234.1 8245.8 8251.3 5077.0 5908.1 5980.5 6040.9 6157.8 7651.6 9562.9 9724.0 9847.5 9848.8 9937.7 10006.7 10055.8 10075.5 10086.9 7042.6 7444.4 7541.9 7605.5 7679.3 8414.9 8500.1 8502.6 8513.8 8521.3 7398.6 7404.8 7521.3 7551.9 7623.7 7221.3 7391.0 7440.0 7526.1 7539.1 6786.4 6809.1 6847.8 6849.4 6867.6 4945.4 5028.5 5081.8 5082.8 5120.8 5005.4 5008.8 5134.0 5166.6 5184.3 03:04:14 INFO - PROCESS | 1664 | 03:04:14 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:4515.62 Median:4962.60 stddev:1383.55 (27.9%) stddev-sans-first:1350.74 03:04:14 INFO - PROCESS | 1664 | Values: 298.3 306.5 312.3 313.6 314.1 4685.4 5398.4 5499.6 5643.5 5665.4 4577.5 4891.5 5090.4 5603.8 5655.7 3938.3 4058.0 4303.7 4325.8 4327.2 3942.5 4200.2 4316.5 4365.4 4372.2 4172.4 4194.3 4196.4 4210.2 4233.9 3932.3 4176.1 4202.6 4222.6 4254.9 3622.7 3627.6 3628.7 3647.1 3660.4 5264.9 5425.3 5489.2 5508.9 5516.8 3989.9 4336.4 4791.2 4870.6 4878.5 4688.8 4780.9 4888.3 5320.0 5980.4 3689.2 3770.0 3998.8 4014.9 4017.3 5891.0 5974.6 6287.2 6287.4 6356.6 3238.3 3631.5 4102.8 4109.9 4109.9 3435.3 3585.6 3740.6 4096.9 4170.2 4538.9 4768.3 4818.3 4846.1 4888.2 5135.4 5257.8 5953.6 6063.2 6094.3 1189.8 1324.5 1354.8 1393.2 1401.8 908.0 912.3 937.4 940.3 940.7 5401.6 5587.6 5590.6 5600.6 5642.6 4874.4 5078.8 6032.4 6087.8 6140.5 5279.1 5454.1 5513.9 5567.5 5584.1 2560.1 2582.1 2642.7 2709.3 2746.7 4778.5 4949.8 4975.5 5167.5 5286.3 4229.4 5033.6 5089.8 5303.9 5311.0 4495.6 5234.3 5236.5 5263.8 5289.3 4742.5 5080.8 5088.5 5161.4 5163.8 4433.5 4528.3 5054.7 5190.5 5232.5 4600.6 4883.5 4999.8 5228.8 5262.8 3196.8 3516.2 3530.7 3580.7 3583.8 4100.2 4206.8 4448.4 4822.6 5202.7 4480.4 5527.5 5742.7 5836.8 5983.4 4990.0 5012.5 5803.0 5966.6 6054.4 5542.5 5748.3 5752.4 5783.9 5932.8 5192.0 5691.9 5933.9 5973.8 5980.6 5348.2 5442.0 5826.7 5875.9 5934.2 03:04:14 INFO - PROCESS | 1664 | 03:04:14 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:25802.00 Median:3697.66 stddev:42757.30 (1156.3%) stddev-sans-first:42835.62 03:04:14 INFO - PROCESS | 1664 | Values: 673.9 686.9 695.4 726.2 820.0 15241.7 15353.8 15696.8 15841.6 15887.7 10816.6 14380.1 14384.9 14485.1 14958.9 844.4 863.6 864.9 866.8 870.1 671.1 832.2 858.2 865.1 866.0 905.8 908.8 909.2 910.3 910.8 890.5 898.9 904.0 905.6 908.6 650.7 663.0 663.2 664.9 665.8 14168.3 14198.1 14206.3 14219.3 14253.2 14409.1 14441.0 14608.4 14683.8 14777.4 10273.9 10378.7 11782.4 11874.9 11963.6 3796.9 3878.5 3888.8 3894.0 3915.2 118252.0 121338.0 122026.0 122530.0 122820.0 8974.8 11097.5 11305.4 11439.7 11545.4 22799.1 22974.3 23252.1 23330.3 23510.9 7868.6 7934.2 7954.3 8045.3 8070.1 3494.4 4023.6 4103.1 4122.6 4153.8 3552.3 3695.7 3699.6 3699.7 3714.9 591.7 644.0 660.6 660.7 667.3 578.3 592.7 593.6 674.5 675.5 8502.5 9068.9 9075.1 9367.3 9456.5 581.9 586.9 612.0 627.0 665.9 3599.6 3791.5 3819.0 3820.9 4571.1 117496.9 147423.0 163588.0 163961.0 168288.2 142766.0 143721.0 143997.2 144319.0 147525.0 86396.3 121785.0 121910.0 126473.0 126725.4 8714.8 8750.0 8757.6 8896.2 9091.5 58088.4 64730.0 68556.0 69501.0 70622.3 67790.0 97974.5 101602.5 102931.5 103364.0 11694.6 11991.8 12015.5 12117.6 12359.1 12964.6 13003.3 13157.5 13504.6 13706.4 10968.7 12161.1 12190.2 12330.4 12633.5 10892.5 11917.4 12035.6 12341.8 12463.8 11903.5 12060.2 12154.7 12401.4 12431.8 8512.0 10395.8 10624.8 10631.3 10752.7 9196.2 9535.3 9553.3 10554.9 10621.6 03:04:14 INFO - PROCESS | 1664 | -------- Summary: end -------- 03:04:14 INFO - PROCESS | 1664 | 03:04:15 INFO - TEST-INFO | 1664: exit 0 03:04:15 INFO - TEST-OK | dromaeo_css | took 1113527ms 03:04:15 INFO - TEST-START | kraken 03:04:15 INFO - operating with platform_type : mac_ 03:04:15 INFO - Initialising browser for kraken test... 03:04:15 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmp7dQ928/profile http://localhost:49286/getInfo.html) 03:04:18 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 03:04:18 INFO - PROCESS | 1674 | colorDepth:24 03:04:18 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 03:04:18 INFO - PROCESS | 1674 | __metrics 03:04:18 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 03:04:18 INFO - TEST-INFO | 1674: exit 0 03:04:18 INFO - Browser initialized. 03:04:18 INFO - Running cycle 1/1 for kraken test... 03:04:18 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/T/tmp7dQ928/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:04:30 INFO - PROCESS | 1676 | RSS: Main: 243920896 03:04:30 INFO - PROCESS | 1676 | 03:04:33 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49286/tests/kraken/driver.html?testName=audio-beat-detection) 03:04:34 INFO - PROCESS | 1676 | RSS: Main: 256589824 03:04:34 INFO - PROCESS | 1676 | 03:04:37 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49286/tests/kraken/driver.html?testName=audio-dft) 03:04:38 INFO - PROCESS | 1676 | RSS: Main: 265240576 03:04:38 INFO - PROCESS | 1676 | 03:04:41 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49286/tests/kraken/driver.html?testName=audio-fft) 03:04:42 INFO - PROCESS | 1676 | RSS: Main: 265187328 03:04:42 INFO - PROCESS | 1676 | 03:04:44 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49286/tests/kraken/driver.html?testName=audio-oscillator) 03:04:44 INFO - PROCESS | 1676 | RSS: Main: 266481664 03:04:44 INFO - PROCESS | 1676 | 03:04:46 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49286/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:04:47 INFO - PROCESS | 1676 | RSS: Main: 266846208 03:04:47 INFO - PROCESS | 1676 | 03:04:50 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49286/tests/kraken/driver.html?testName=imaging-darkroom) 03:04:50 INFO - PROCESS | 1676 | RSS: Main: 267071488 03:04:50 INFO - PROCESS | 1676 | 03:04:53 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49286/tests/kraken/driver.html?testName=imaging-desaturate) 03:04:54 INFO - PROCESS | 1676 | RSS: Main: 267407360 03:04:54 INFO - PROCESS | 1676 | 03:04:57 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49286/tests/kraken/driver.html?testName=json-parse-financial) 03:04:58 INFO - PROCESS | 1676 | RSS: Main: 267849728 03:04:58 INFO - PROCESS | 1676 | 03:04:59 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49286/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:05:00 INFO - PROCESS | 1676 | RSS: Main: 268595200 03:05:00 INFO - PROCESS | 1676 | 03:05:02 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:05:03 INFO - PROCESS | 1676 | RSS: Main: 268517376 03:05:03 INFO - PROCESS | 1676 | 03:05:05 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:05:06 INFO - PROCESS | 1676 | RSS: Main: 268902400 03:05:06 INFO - PROCESS | 1676 | 03:05:08 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:05:09 INFO - PROCESS | 1676 | RSS: Main: 269090816 03:05:09 INFO - PROCESS | 1676 | 03:05:12 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:05:13 INFO - PROCESS | 1676 | RSS: Main: 269221888 03:05:13 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49286/tests/kraken/driver.html?testName=ai-astar) 03:05:15 INFO - PROCESS | 1676 | RSS: Main: 270929920 03:05:15 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | __start_tp_report 03:05:15 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 03:05:15 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 03:05:15 INFO - PROCESS | 1676 | |i|pagename|runs| 03:05:15 INFO - PROCESS | 1676 | |0;ai-astar;115;116;113;117;116;93;142;97;172;173 03:05:15 INFO - PROCESS | 1676 | |1;audio-beat-detection;149;96;127;184;145;164;134;111;158;109 03:05:15 INFO - PROCESS | 1676 | |2;audio-dft;278;251;213;195;197;202;198;205;271;224 03:05:15 INFO - PROCESS | 1676 | |3;audio-fft;75;81;76;147;60;59;60;64;132;59 03:05:15 INFO - PROCESS | 1676 | |4;audio-oscillator;68;73;121;72;70;92;110;71;73;114 03:05:15 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;89;87;88;88;89;85;89;86;91;85 03:05:15 INFO - PROCESS | 1676 | |6;imaging-darkroom;98;132;95;115;115;96;95;105;96;109 03:05:15 INFO - PROCESS | 1676 | |7;imaging-desaturate;89;151;142;115;146;159;107;90;94;96 03:05:15 INFO - PROCESS | 1676 | |8;json-parse-financial;56;58;57;56;58;58;59;58;56;56 03:05:15 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;65;71;69;72;74;80;74;68;70;77 03:05:15 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;86;87;90;89;86;87;77;93;112;109 03:05:15 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;138;139;139;159;144;150;157;157;178;160 03:05:15 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;170;181;221;238;172;182;179;217;170;173 03:05:15 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;69;70;69;70;68;67;69;67;80;92 03:05:15 INFO - PROCESS | 1676 | __end_tp_report 03:05:15 INFO - PROCESS | 1676 | __start_cc_report 03:05:15 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,958 03:05:15 INFO - PROCESS | 1676 | __end_cc_report 03:05:15 INFO - PROCESS | 1676 | __startTimestamp1473329115281__endTimestamp 03:05:15 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | ------- Summary: start ------- 03:05:15 INFO - PROCESS | 1676 | Number of tests: 14 03:05:15 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:125.40 Median:157.00 stddev:28.04 (17.9%) stddev-sans-first:29.49 03:05:15 INFO - PROCESS | 1676 | Values: 115.0 116.0 113.0 117.0 116.0 93.0 142.0 97.0 172.0 173.0 03:05:15 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:153.50 stddev:27.55 (17.9%) stddev-sans-first:28.92 03:05:15 INFO - PROCESS | 1676 | Values: 149.0 96.0 127.0 184.0 145.0 164.0 134.0 111.0 158.0 109.0 03:05:15 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:223.40 Median:218.50 stddev:31.73 (14.5%) stddev-sans-first:26.81 03:05:15 INFO - PROCESS | 1676 | Values: 278.0 251.0 213.0 195.0 197.0 202.0 198.0 205.0 271.0 224.0 03:05:15 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:81.30 Median:62.00 stddev:31.90 (51.4%) stddev-sans-first:33.75 03:05:15 INFO - PROCESS | 1676 | Values: 75.0 81.0 76.0 147.0 60.0 59.0 60.0 64.0 132.0 59.0 03:05:15 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:71.50 stddev:20.97 (29.3%) stddev-sans-first:21.16 03:05:15 INFO - PROCESS | 1676 | Values: 68.0 73.0 121.0 72.0 70.0 92.0 110.0 71.0 73.0 114.0 03:05:15 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:88.50 stddev:1.95 (2.2%) stddev-sans-first:2.01 03:05:15 INFO - PROCESS | 1676 | Values: 89.0 87.0 88.0 88.0 89.0 85.0 89.0 86.0 91.0 85.0 03:05:15 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:105.60 Median:95.00 stddev:12.26 (12.9%) stddev-sans-first:12.69 03:05:15 INFO - PROCESS | 1676 | Values: 98.0 132.0 95.0 115.0 115.0 96.0 95.0 105.0 96.0 109.0 03:05:15 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:118.90 Median:124.00 stddev:27.76 (22.4%) stddev-sans-first:27.26 03:05:15 INFO - PROCESS | 1676 | Values: 89.0 151.0 142.0 115.0 146.0 159.0 107.0 90.0 94.0 96.0 03:05:15 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:58.00 stddev:1.14 (2.0%) stddev-sans-first:1.12 03:05:15 INFO - PROCESS | 1676 | Values: 56.0 58.0 57.0 56.0 58.0 58.0 59.0 58.0 56.0 56.0 03:05:15 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:73.00 stddev:4.42 (6.1%) stddev-sans-first:3.90 03:05:15 INFO - PROCESS | 1676 | Values: 65.0 71.0 69.0 72.0 74.0 80.0 74.0 68.0 70.0 77.0 03:05:15 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:87.00 stddev:10.79 (12.4%) stddev-sans-first:11.26 03:05:15 INFO - PROCESS | 1676 | Values: 86.0 87.0 90.0 89.0 86.0 87.0 77.0 93.0 112.0 109.0 03:05:15 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:152.10 Median:157.00 stddev:12.65 (8.1%) stddev-sans-first:12.35 03:05:15 INFO - PROCESS | 1676 | Values: 138.0 139.0 139.0 159.0 144.0 150.0 157.0 157.0 178.0 160.0 03:05:15 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.30 Median:181.50 stddev:25.10 (13.8%) stddev-sans-first:25.53 03:05:15 INFO - PROCESS | 1676 | Values: 170.0 181.0 221.0 238.0 172.0 182.0 179.0 217.0 170.0 173.0 03:05:15 INFO - PROCESS | 1676 | 03:05:15 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:69.50 stddev:7.92 (11.4%) stddev-sans-first:8.32 03:05:15 INFO - PROCESS | 1676 | Values: 69.0 70.0 69.0 70.0 68.0 67.0 69.0 67.0 80.0 92.0 03:05:15 INFO - PROCESS | 1676 | -------- Summary: end -------- 03:05:15 INFO - PROCESS | 1676 | 03:05:16 INFO - TEST-INFO | 1676: exit 0 03:05:16 INFO - TEST-OK | kraken | took 60737ms 03:05:16 INFO - SUITE-END | took 1174s 03:05:16 INFO - Completed test suite (00:19:34) 03:05:16 INFO - javascript benchmark 03:05:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7209.562585335403, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3399.6600339966008, 3407.2844702612456, 3409.573803274591, 3423.1271025888404, 3437.501562273472, 4856.271559266112, 4982.87542811429, 5589.357223919251, 5701.771929122835, 5805.477507024361, 5676.035074037413, 5690.4025077366905, 5704.971475142629, 5742.511886489653, 5765.019946609076, 5109.565686916617, 5195.87010324743, 5200.739963001834, 5269.2886460327745, 5314.362276526822, 5281.841544753664, 5344.091504444254, 5352.116900711378, 5366.409694933554, 5377.569794416438, 5158.819441319536, 5186.688798672092, 5212.192110222922, 5218.295530103425, 5248.21276808478, 5193.68837869729, 5227.895442091137, 5231.738413079369, 5241.842744717665, 5286.550643195333, 5203.713795741232, 5214.687118772886, 5237.685738855643, 5244.213367994793, 5250.842474725764, 5482.2873026506295, 5572.219889215513, 5624.0, 5696.0, 5721.141828725683, 6249.312575616724, 6252.812415627538, 6274.215723034621, 6284.842878928018, 6298.866204083263, 6296.811095667137, 6310.779122730728, 6322.620642761403, 6339.8098057057905, 6344.49244060474, 5679.403662615448, 5724.398938111522, 5733.226014488074, 5795.768169273266, 5870.677112758796, 6192.473639740672, 6212.316645169028, 6212.534059945522, 6224.37756224383, 6278.560500764903, 5236.685798852005, 5380.838574842683, 6164.229471316085, 6164.7842325518395, 6174.845628859224, 4846.418429788448, 6155.692215389302, 6205.503559715212, 6269.7492100316385, 6283.497320214372, 5015.974920125449, 6152.323244443108, 6169.259688837368, 6209.65846878417, 6225.066240064027, 6233.1273621693, 6241.282252541016, 6242.687865606701, 6253.343398943045, 6260.467860231931, 4327.0480494291205, 4872.585830204473, 4910.042541704404, 4983.177775667047, 4988.201887697951, 4427.092446048552, 4432.227109156363, 4439.600435960779, 4460.420145381079, 4512.368268442421, 5590.217369568264, 5695.060315047971, 5701.486866182064, 5748.310202775694, 5763.769449221984, 6187.978983467678, 6282.434580887742, 6296.118543403927, 6305.621662700252, 6318.8420289492215, 5290.418054014055, 5744.684042377709, 5771.9711401443565, 5805.216295800013, 5838.9124163137585, 5405.8107966221, 5417.214503896992, 5422.457754224546, 5429.647072940246, 5431.0, 6181.505479561534, 6300.653464059521, 6305.96847015762, 6317.715702793477, 6326.145970294044, 6216.968915155395, 6254.8123556293385, 6268.216472940882, 6299.212598425197, 6301.590396624205, 6270.0, 6309.936900630935, 6325.905111423424, 6331.778387756406, 6332.986722124438, 6051.697415129314, 6240.251169859646, 6248.218972628421, 6262.311145774052, 6268.937310626835, 6214.40963108504, 6222.160008398808, 6262.060690896402, 6308.747650093945, 6333.841653958503, 6123.081537769192, 6166.475849552839, 6186.845328866814, 6190.690465476618, 6202.193714817045, 6078.209832721718, 6115.327313995546, 6178.814635560941, 6197.318294987638, 6213.2233470816145, 5902.5277977762535, 5939.138824870283, 5968.731407086605, 6003.189569408074, 6021.096835474714, 6141.938580614136, 6150.138980542817, 6151.507879369729, 6152.630842149485, 6160.383961603804, 5687.033204355187, 5881.206037185097, 5964.224650795369, 5972.58191926561, 5984.640921544721], "value": 5686.660478429366, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.6952719786535, 502.482443083624, 515.8890838469729, 529.8237911835723, 532.1857557936357, 36197.0, 38445.807770961175, 38447.84656460304, 38471.42292865602, 38496.615033849615, 39868.60131398685, 40475.0, 40517.594824051754, 40616.39075413871, 40653.186936261256, 9518.048195180478, 9660.98559651237, 9737.464439455827, 9759.756006099833, 9776.266779991494, 9658.855117173249, 9744.853827192563, 9767.853482197772, 9771.56027978739, 9793.314467987244, 9743.902560974406, 9790.020997900188, 9795.02049795022, 9802.264830137732, 9805.31362804604, 8308.7091951782, 8676.175763302475, 8735.825283494358, 9557.522123893812, 9775.51122443875, 9588.808223835484, 9608.231341492663, 9626.75933101671, 9694.563744631509, 9723.805523889554, 30931.216190542735, 38323.0, 38585.80707096474, 38666.61333386658, 38696.03259918497, 2965.8368789716556, 3253.544503769474, 3297.274599588111, 3360.294338188983, 4085.44846445729, 23277.883610581837, 28792.790812682022, 29559.113226603236, 29924.251893702614, 30419.847900760575, 3227.289996200832, 3232.6767323267723, 3235.8705651773903, 3239.3359361331104, 3327.2014716468116, 345386.27306863555, 349814.5018549782, 351078.0, 351577.0, 351589.2420537881, 51331.716707081876, 53355.46644533583, 53537.0, 53659.73170134125, 53767.462325377026, 33026.0, 34122.48816267758, 34240.82879585636, 57246.42753572411, 57294.713526432104, 15669.216539173223, 15822.920885395499, 15885.205739712968, 15897.68204635924, 15928.203589820694, 12287.877121228674, 12370.690732731753, 12373.876261237452, 12414.875851241553, 12414.944729697896, 15294.311755971008, 17464.301427942995, 17526.0, 17571.56071098207, 17645.55886102832, 6590.472762179014, 7620.80947976305, 7741.419393545507, 7777.766666999999, 7818.296353328228, 836.1721895323586, 836.5608055770768, 913.0139449394638, 937.4047479850344, 1120.4453795371344, 21194.470138246357, 26042.86978565095, 28708.138755837357, 29005.70994290072, 29040.854795725885, 1041.3959903256093, 1059.078601616583, 1122.680036189682, 1138.4592318648577, 1159.8956093951585, 12281.87819452521, 15041.774373384407, 15131.848681513264, 15222.847771522365, 15269.083854968738, 642976.0, 657358.0, 657574.0, 659054.0, 660595.0, 52480.212796808075, 54549.72725136428, 54939.45060549343, 55412.445875540725, 55656.0, 1313.7175507265983, 1345.2668295778824, 1366.5626999360109, 1374.312843578211, 1377.4283672276094, 27901.58147627828, 28732.85633571819, 28747.28131796722, 29321.85339073291, 29326.706732932398, 46503.76748116238, 46830.0, 46940.295895560914, 47071.52928470672, 47277.29084063673, 578887.0, 583233.0, 583458.0, 584279.0, 585084.0, 25081.87459062693, 25302.873485632455, 25405.745942541078, 25505.48989020246, 25544.744552554235, 44298.55701442944, 44521.10957780761, 44629.77685111554, 45301.0, 45497.77251113856, 37017.25965480729, 37216.0, 37216.0, 38213.617863821004, 38371.80814095912, 36888.26223475569, 36982.0, 37481.06297342479, 37703.81148094242, 37818.0, 28203.43593128167, 29124.854375727984, 35566.82216589004, 36138.4579231317, 36356.81821590875, 31776.36447271088, 32101.35797284088, 33609.663903360655, 33624.49563256504, 33793.83103084469, 22743.545129097656, 23500.01741995528, 24377.756222437547, 24770.25689229326, 25224.62163067519], "value": 18937.446381584472, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.53377602476405, 369.69315468161415, 370.7812390689493, 380.73158423311565, 405.69164444665955, 19383.612327753453, 19457.70813437798, 20698.0, 20808.89595552024, 20862.895685521587, 20118.295859644917, 20590.588188236226, 20837.68743468849, 20885.0, 21021.68467472989, 5900.996830538797, 5912.467877890989, 6082.0, 6182.690865456731, 6204.4416002559765, 6045.6674882881425, 6133.539984501181, 6141.0, 6145.047517634752, 6166.105914642374, 5916.142159386886, 6021.126936594192, 6030.336662967092, 6084.665343406111, 6093.207882975207, 5940.316863560703, 6012.939870601282, 6032.306284777263, 6048.123022161806, 6068.605540639866, 5245.6852588844795, 5505.229267902497, 5526.005319042571, 5590.832275031756, 5634.887302253973, 13084.738305233937, 13316.467341306336, 17894.0, 24648.260552183285, 25121.246362609152, 2100.5646572292067, 2138.016512404296, 2255.5263394687136, 2317.9420514487106, 2510.234378514552, 7895.368370530401, 9656.855147172799, 9920.206383489303, 10225.693229203136, 10233.437160956144, 1876.3432798520546, 1885.566319746466, 1895.9431217063511, 1912.416712902564, 1930.6138772245467, 112330.99999999919, 115544.0, 115954.42022789831, 118024.40987795006, 118493.0, 9334.486603236752, 11307.60423385194, 11350.14873884462, 11569.479373428216, 11941.402929853473, 14161.78757318641, 14165.0, 14170.504032358818, 14175.78736318956, 14207.64480887986, 8290.626921788535, 8427.199416055464, 8428.241458268785, 8442.746717598482, 8574.95712521446, 7418.332350088518, 7893.802654933673, 8376.6677562179, 8444.366672499587, 8572.657093716181, 4043.9191216175514, 4046.393041043808, 4152.730072545275, 4508.233600287959, 4520.525344838745, 1897.8481721462526, 1935.796741342167, 1945.7178709087102, 1950.0542237015036, 1978.240349744156, 845.8392905347964, 893.2809088683672, 901.1754244866005, 935.8970513243538, 970.1656575345197, 19330.8066919329, 19976.3008294709, 20181.49546261355, 20244.392668219683, 20314.59370812605, 932.3939439364332, 969.0842154164247, 970.5441837244134, 978.9118979291898, 996.9800603988025, 10678.786424271471, 10805.459727013618, 10814.56741730322, 10816.405097719544, 10834.945825270823, 547151.0, 550835.0, 551940.0, 563671.0, 565986.0, 45851.541484585396, 53157.0, 85619.58184599689, 96846.0, 104699.42950855743, 882.188386684252, 972.2999440402899, 997.835357166074, 1026.856240126383, 1027.4503140819625, 14395.848332133613, 17881.0, 17972.460826175236, 18547.53631159178, 18667.346642867433, 50817.23774143317, 51343.48656513387, 52754.0, 53484.46515534795, 54045.0, 61338.0, 78532.0, 78631.0, 78861.60569197117, 80048.19951800407, 7796.883046754417, 7932.920670793449, 7943.4836735612, 8093.433459658003, 8150.510969341858, 10214.233932455245, 12440.937795310965, 12697.238165710087, 12812.0, 13010.934945325213, 10593.947030265108, 10765.569377224823, 10919.0, 10991.61529346469, 11169.218154729091, 10559.577616895545, 10676.733081673021, 10723.731906702395, 10763.730906727395, 10955.83566246491, 8055.919440805517, 8628.654853806029, 11111.0, 11252.21234513609, 11257.943710281395, 7763.340116089969, 7853.921460785319, 7896.052473703192, 7948.523088614702, 8107.554084525408, 10193.592256309665, 10201.183905287411, 10429.843552346872, 10579.62971296001, 10687.732806679584], "value": 9195.501786109768, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.0713143588105, 1476.1807197005658, 1666.2085509383037, 1682.663467306539, 1864.2729335559143, 8038.839223215532, 8419.36854735895, 8581.270591999672, 8926.241269492084, 8974.820503589925, 8542.97484301883, 8716.25911797498, 8722.127787221274, 8728.127187281269, 8741.169588889044, 2037.4193354893857, 2398.9160379386767, 2402.147237730607, 2408.7350391456926, 2424.806015518763, 1862.3947217154412, 2366.597678394677, 2407.759224077587, 2408.8434251773665, 2416.4200591858003, 2400.327908185711, 2405.4226985523437, 2412.2763171048705, 2417.709874815016, 2418.2503423938633, 2383.380321116505, 2400.7719266669724, 2404.182577923497, 2405.3625789165885, 2411.3007227903972, 2364.8344615876895, 2378.5361854438393, 2378.9532605653458, 2380.0598763488497, 2386.72552656445, 8776.60505277264, 8797.47215167092, 8824.823503529959, 8825.735227943173, 8843.159899809507, 5246.475352464723, 5313.681179129226, 5363.544098751572, 5386.569074474032, 5405.459454054563, 3604.5314109165643, 3637.909052273714, 3641.3809652359164, 3644.9817750911075, 3679.1537946272238, 1098.9230753847235, 1098.961536346224, 1101.1081024370285, 1109.6393672056613, 1126.0372381613765, 9724.465154416434, 9767.267454940837, 11087.168462365275, 11341.26281791681, 11415.771684566262, 4553.3397657340165, 4655.627549796076, 4797.472278049412, 4824.252240902666, 4829.348038014893, 9726.90273097274, 9742.0, 9777.511124443892, 9797.31418800677, 9816.361936474106, 5243.895122097537, 5341.252224688546, 5344.412114667383, 5347.86630334237, 5349.545288650431, 4435.578620031092, 4760.880977975578, 4899.485554016848, 4913.508649135129, 4949.9605082932985, 3888.902777430587, 3917.05990562263, 3989.122393073519, 4003.11931375097, 4057.69567282455, 1090.2368342160519, 1235.745718096133, 1315.9736805263842, 1316.9539066132832, 1328.920264784116, 830.5971603772166, 900.7207765592688, 910.2217603948528, 919.388606576619, 952.9094736000069, 5466.316710411199, 5638.774449022075, 5951.613145145551, 6134.938650613526, 6139.10982907476, 374.63473113714457, 444.42890885212347, 452.77813871203534, 850.2701120630265, 938.5776400619612, 3722.664960153545, 3989.108846822001, 4027.6979226558124, 4058.2492238935893, 4132.648724858361, 10481.475926203659, 10665.253432259668, 10752.354858708502, 10755.0, 10811.405372704578, 10631.681049568526, 10744.838827417596, 10746.838797418044, 10765.623203188008, 10796.67609971702, 7715.498492597963, 8101.270885620323, 8234.094249632535, 8245.752627421187, 8251.2986396157, 5076.974615127048, 5908.143319218775, 5980.461758441761, 6040.939590604214, 6157.784477543264, 7651.617419129133, 9562.90437095648, 9723.978982206767, 9847.538115471132, 9848.753781155528, 9937.65218217359, 10006.749831254278, 10055.798884022424, 10075.496225188857, 10086.899131008597, 7042.591481703577, 7444.404447644284, 7541.924580754122, 7605.46761726696, 7679.310551678622, 8414.915850841413, 8500.107488713844, 8502.617382217939, 8513.787155321166, 8521.318294536299, 7398.630068496446, 7404.777856664308, 7521.285477879593, 7551.886721699069, 7623.69505219785, 7221.277872212737, 7391.002214701161, 7440.032795736736, 7526.059242594676, 7539.0576177977755, 6786.423154031962, 6809.114815074008, 6847.760328388483, 6849.383555479832, 6867.553609015398, 4945.357103576656, 5028.497150284942, 5081.8475445736685, 5082.822101226439, 5120.8222108914415, 5005.424376196784, 5008.799648014185, 5133.974330128325, 5166.586673066071, 5184.326037615086], "value": 4536.04230686266, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.2647773238967, 306.4636885450462, 312.2957730318132, 313.59702781925233, 314.10793346894826, 4685.4143232095985, 5398.3521977362725, 5499.642523235987, 5643.520300774439, 5665.4334566543375, 4577.450705915287, 4891.48639392864, 5090.414602320725, 5603.831885043445, 5655.670917334423, 3938.2714197873343, 4058.046359105615, 4303.720258183223, 4325.767156360438, 4327.242732521796, 3942.5071866016747, 4200.180964711883, 4316.482022157345, 4365.36702178184, 4372.2130016597, 4172.415861779338, 4194.30793919003, 4196.3705444183315, 4210.200061988213, 4233.872983810491, 3932.292187406266, 4176.1230141670285, 4202.600752928467, 4222.619964203206, 4254.87235382939, 3622.728295377857, 3627.5828279747902, 3628.727845411605, 3647.1064589175558, 3660.396034654279, 5264.947350526484, 5425.321834770653, 5489.204065410533, 5508.944910550883, 5516.7517461714315, 3989.9227208653792, 4336.376492222192, 4791.233402655594, 4870.6347023972985, 4878.463369029404, 4688.835890743808, 4780.904381912343, 4888.315635810989, 5320.015797077514, 5980.372060933626, 3689.2252626948375, 3769.9623003769884, 3998.8000599969887, 4014.8996275093064, 4017.27689015977, 5890.970545147246, 5974.641521508724, 6287.245530536319, 6287.371262873722, 6356.586821856565, 3238.2713889374704, 3631.5460567429072, 4102.794860256975, 4109.876703698894, 4109.8972525687095, 3435.3129374125274, 3585.6055833858254, 3740.6259374062374, 4096.91806163875, 4170.16596680665, 4538.909221815546, 4768.260919557474, 4818.301346304836, 4846.055019271279, 4888.2178851383605, 5135.35529202461, 5257.78968841242, 5953.553483488756, 6063.211782468339, 6094.268687757498, 1189.79178643737, 1324.4503531034513, 1354.8348420358484, 1393.226759148662, 1401.7897315402772, 908.0193391137556, 912.3440954667391, 937.381328323317, 940.2994768897215, 940.7083804020775, 5401.621886467988, 5587.608867379326, 5590.552755779528, 5600.635958662674, 5642.576806739429, 4874.4150701916, 5078.806480477085, 6032.426919442646, 6087.817365479043, 6140.4648837790555, 5279.149259399957, 5454.072807622713, 5513.889722205534, 5567.49892509668, 5584.050711379075, 2560.0911676355, 2582.0704546363295, 2642.696089949642, 2709.2955831483564, 2746.6541394716846, 4778.450478194983, 4949.752512374367, 4975.4527002029745, 5167.4832516748775, 5286.259923610698, 4229.398919664446, 5033.6224783141415, 5089.847304580869, 5303.939212157584, 5310.972745535085, 4495.605817607685, 5234.345706786576, 5236.476352364733, 5263.7894484220205, 5289.280983680243, 4742.549457801641, 5080.822171223989, 5088.491150884882, 5161.354830646169, 5163.845084647316, 4433.512313645432, 4528.320751887111, 5054.69671819692, 5190.455002224863, 5232.450592687713, 4600.6319494439695, 4883.487233840538, 4999.825041115408, 5228.816991405282, 5262.842114736564, 3196.785221615771, 3516.2440075383915, 3530.7175425966375, 3580.7135429165082, 3583.802890841029, 4100.17996400727, 4206.789660516901, 4448.35498852671, 4822.614190864652, 5202.684805261622, 4480.417545719036, 5527.530159936289, 5742.741576628978, 5836.795712150054, 5983.401659833982, 4989.975050124726, 5012.498750124958, 5803.0, 5966.612170208922, 6054.426868580924, 5542.528885044816, 5748.338941021836, 5752.367239603556, 5783.942160578508, 5932.762689492372, 5191.9751296994955, 5691.943080569141, 5933.9109913352195, 5973.820785376446, 5980.551458640706, 5348.232098347745, 5442.047641662773, 5826.650400975955, 5875.853103672443, 5934.190072028073], "value": 4080.2785603040347, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.909022281992, 686.9484788640854, 695.3984803145281, 726.2120599149922, 819.9545579386283, 15241.695166096672, 15353.84646153538, 15696.84303156968, 15841.603959901007, 15887.68224635508, 10816.621418250363, 14380.065295755769, 14384.85615143851, 14485.058471199365, 14958.850411495881, 844.3878188313485, 863.6156910174975, 864.8529749942525, 866.761640548851, 870.0994470722803, 671.0772687554612, 832.196929962586, 858.159004175908, 865.0916537635458, 865.9911203448007, 905.7509184974152, 908.8318661047695, 909.2271569166222, 910.2717825739383, 910.8451563234266, 890.5369208011863, 898.9146031127033, 904.0462312260562, 905.6241659711212, 908.6320040383622, 650.6779144323543, 663.0452148905608, 663.2207156590986, 664.8504086580529, 665.7969319357594, 14168.291585420791, 14198.148111113367, 14206.289685515683, 14219.289035548285, 14253.216073115975, 14409.06341087826, 14441.0, 14608.415663373453, 14683.779743303752, 14777.408903643842, 10273.86338721574, 10378.688639340831, 11782.351970641612, 11874.871887170704, 11963.581274655346, 3796.8718220917112, 3878.5151856017997, 3888.844446222148, 3894.0, 3915.158240978175, 118252.0, 121338.0, 122026.0, 122530.0, 122819.99999999911, 8974.820503589892, 11097.500612472459, 11305.378204198849, 11439.714007149722, 11545.36500492481, 22799.088036478686, 22974.310770676908, 23252.117055418214, 23330.300090997298, 23510.882445587664, 7868.606569671493, 7934.166912474107, 7954.323882470055, 8045.275925166763, 8070.071941726659, 3494.4234201357, 4023.6378725914224, 4103.138340948434, 4122.628963393249, 4153.7507749535125, 3552.289542091592, 3695.7412981091065, 3699.574548926854, 3699.6855267302044, 3714.9442758358646, 591.6657088744845, 643.9967800161063, 660.5640277416882, 660.6795704083515, 667.3160010988776, 578.254052272572, 592.6503363015842, 593.5637306579661, 674.4536925090692, 675.5136301862651, 8502.532360720219, 9068.8639670405, 9075.13786190324, 9367.297452690938, 9456.52717364129, 581.9039858423397, 586.8620874094585, 611.953559413408, 626.9874602507924, 665.9167604049494, 3599.600599101348, 3791.4881490998364, 3819.0, 3820.8662696805477, 4571.085782843445, 117496.94247899258, 147423.0, 163588.0, 163961.0, 168288.1585592064, 142766.0, 143721.0, 143997.2401103965, 144319.0, 147525.0, 86396.27207455816, 121785.0, 121910.0, 126473.0, 126725.3663731657, 8714.825703486022, 8750.0, 8757.562121894007, 8896.243819275434, 9091.499967501586, 58088.4191158083, 64730.0, 68556.0, 69500.95748563876, 70622.29377706157, 67790.0, 97974.51012745175, 101602.49198753959, 102931.4853425728, 103364.0, 11694.649160525198, 11991.76016479648, 12015.45930433115, 12117.636470905887, 12359.134860559674, 12964.611061668165, 13003.349832508526, 13157.53948611794, 13504.594862154152, 13706.383212755649, 10968.738595061352, 12161.087918405978, 12190.207636503954, 12330.383480826102, 12633.494660213857, 10892.455377230948, 11917.404129793302, 12035.578754743541, 12341.75316493683, 12463.813042804184, 11903.523859045888, 12060.155789094679, 12154.718087035006, 12401.441935112762, 12431.751364972832, 8512.008560557786, 10395.792084158425, 10624.84062739075, 10631.255812093079, 10752.731181720519, 9196.218321442751, 9535.284853635867, 9553.283503737386, 10554.894451055392, 10621.575136994743], "value": 7661.0532490565865, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1601.6999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 113.0, 117.0, 116.0, 93.0, 142.0, 97.0, 172.0, 173.0], "value": 125.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 96.0, 127.0, 184.0, 145.0, 164.0, 134.0, 111.0, 158.0, 109.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [278.0, 251.0, 213.0, 195.0, 197.0, 202.0, 198.0, 205.0, 271.0, 224.0], "value": 223.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 81.0, 76.0, 147.0, 60.0, 59.0, 60.0, 64.0, 132.0, 59.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 121.0, 72.0, 70.0, 92.0, 110.0, 71.0, 73.0, 114.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 88.0, 89.0, 85.0, 89.0, 86.0, 91.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 132.0, 95.0, 115.0, 115.0, 96.0, 95.0, 105.0, 96.0, 109.0], "value": 105.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 151.0, 142.0, 115.0, 146.0, 159.0, 107.0, 90.0, 94.0, 96.0], "value": 118.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 56.0, 58.0, 58.0, 59.0, 58.0, 56.0, 56.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 69.0, 72.0, 74.0, 80.0, 74.0, 68.0, 70.0, 77.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 90.0, 89.0, 86.0, 87.0, 77.0, 93.0, 112.0, 109.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 139.0, 159.0, 144.0, 150.0, 157.0, 157.0, 178.0, 160.0], "value": 152.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 181.0, 221.0, 238.0, 172.0, 182.0, 179.0, 217.0, 170.0, 173.0], "value": 190.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 70.0, 68.0, 67.0, 69.0, 67.0, 80.0, 92.0], "value": 72.1, "unit": "score"}]}]} 03:05:16 INFO - Return code: 0 03:05:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:05:16 ERROR - # TBPL SUCCESS # 03:05:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:05:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:05:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:05:16 INFO - 2016-09-08 03:05:16.578 screenresolution[1681:11062] starting screenresolution argv=screenresolution get 03:05:16 INFO - 2016-09-08 03:05:16.581 screenresolution[1681:11062] Display 0: 1600x1200x32@60 03:05:16 INFO - 2016-09-08 03:05:16.587 screenresolution[1682:11065] starting screenresolution argv=screenresolution list 03:05:16 INFO - Available Modes on Display 0 03:05:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:05:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:05:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:05:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:05:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:05:16 INFO - Intel Iris: 03:05:16 INFO - Chipset Model: Intel Iris 03:05:16 INFO - Type: GPU 03:05:16 INFO - Bus: Built-In 03:05:16 INFO - VRAM (Dynamic, Max): 1536 MB 03:05:16 INFO - Vendor: Intel (0x8086) 03:05:16 INFO - Device ID: 0x0a2e 03:05:16 INFO - Revision ID: 0x0009 03:05:16 INFO - Displays: 03:05:16 INFO - Display: 03:05:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:05:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:05:16 INFO - Display Serial Number: 1600x1200 60 03:05:16 INFO - Main Display: Yes 03:05:16 INFO - Mirror: Off 03:05:16 INFO - Online: Yes 03:05:16 INFO - Rotation: Supported 03:05:16 INFO - Return code: 0 03:05:16 INFO - Running post-action listener: _resource_record_post_action 03:05:16 INFO - [mozharness: 2016-09-08 10:05:16.822536Z] Finished run-tests step (success) 03:05:16 INFO - Running post-run listener: _resource_record_post_run 03:05:16 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 33094656; Write bytes: 707435520; Read time: 311; Write time: 1970 03:05:16 INFO - TinderboxPrint: CPU usage
54.5% 03:05:16 INFO - TinderboxPrint: I/O read bytes / time
33,094,656 / 311 03:05:16 INFO - TinderboxPrint: I/O write bytes / time
707,435,520 / 1,970 03:05:16 INFO - TinderboxPrint: CPU idle
2,198.8 (45.5%) 03:05:16 INFO - TinderboxPrint: CPU system
976.6 (20.2%) 03:05:16 INFO - TinderboxPrint: CPU user
1,662.3 (34.4%) 03:05:16 INFO - TinderboxPrint: Swap in / out
434,769,920 / 0 03:05:16 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 406534656; Write bytes: 408098816; Read time: 29845; Write time: 778 03:05:16 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 29236224; Write bytes: 297878528; Read time: 279; Write time: 1186 03:05:17 INFO - Running post-run listener: _upload_blobber_files 03:05:17 INFO - Blob upload gear active. 03:05:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:05:17 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 03:05:17 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:05:17 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:05:17 INFO - (blobuploader) - INFO - Open directory for files ... 03:05:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:05:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:05:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:18 INFO - (blobuploader) - INFO - Done attempting. 03:05:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:05:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:05:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:20 INFO - (blobuploader) - INFO - Done attempting. 03:05:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:05:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:05:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:05:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:05:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:05:23 INFO - (blobuploader) - INFO - Done attempting. 03:05:23 INFO - (blobuploader) - INFO - Iteration through files over. 03:05:23 INFO - Return code: 0 03:05:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:05:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:05:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/407bc710d8656e704521b65976d8f862d39bf5e8f70446b7d7efc74c24a91db51ed7578d6e5cee9ea2849bca42735bfc2c79d4cad8e6c9ec73363ba5b344a9a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91325a686fd014cf02794046ae3126054eede0f366ba74d502d8c4b63555204bf9efa5e40d6ebb1c6614d1227b6e551f7f4a1e93e87e2c06faa16e70b8fa2041", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a1dab8e01f110ad11d3a0ab6a26f8f7cd86c80d1eeaea23791cc411e38e989d97b25ba92c58166cc32a410cb473e058539dc8710d3af9a5bb95968efb5d757a"} 03:05:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:05:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:05:23 INFO - Contents: 03:05:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/407bc710d8656e704521b65976d8f862d39bf5e8f70446b7d7efc74c24a91db51ed7578d6e5cee9ea2849bca42735bfc2c79d4cad8e6c9ec73363ba5b344a9a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91325a686fd014cf02794046ae3126054eede0f366ba74d502d8c4b63555204bf9efa5e40d6ebb1c6614d1227b6e551f7f4a1e93e87e2c06faa16e70b8fa2041", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a1dab8e01f110ad11d3a0ab6a26f8f7cd86c80d1eeaea23791cc411e38e989d97b25ba92c58166cc32a410cb473e058539dc8710d3af9a5bb95968efb5d757a"} 03:05:23 INFO - Running post-run listener: copy_logs_to_upload_dir 03:05:23 INFO - Copying logs to upload dir... 03:05:23 INFO - mkdir: /builds/slave/test/build/upload/logs 03:05:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.628408 ========= master_lag: 1.50 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-09-08 03:05:24.784430) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-09-08 03:05:24.788834) ========= 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.7JNrFIs9R4/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.ZJCogcDOkA/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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/Firefox/sha512/407bc710d8656e704521b65976d8f862d39bf5e8f70446b7d7efc74c24a91db51ed7578d6e5cee9ea2849bca42735bfc2c79d4cad8e6c9ec73363ba5b344a9a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91325a686fd014cf02794046ae3126054eede0f366ba74d502d8c4b63555204bf9efa5e40d6ebb1c6614d1227b6e551f7f4a1e93e87e2c06faa16e70b8fa2041", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a1dab8e01f110ad11d3a0ab6a26f8f7cd86c80d1eeaea23791cc411e38e989d97b25ba92c58166cc32a410cb473e058539dc8710d3af9a5bb95968efb5d757a"} build_url:https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/WErXzaZMT_ibL3BgSYCYhQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/407bc710d8656e704521b65976d8f862d39bf5e8f70446b7d7efc74c24a91db51ed7578d6e5cee9ea2849bca42735bfc2c79d4cad8e6c9ec73363ba5b344a9a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91325a686fd014cf02794046ae3126054eede0f366ba74d502d8c4b63555204bf9efa5e40d6ebb1c6614d1227b6e551f7f4a1e93e87e2c06faa16e70b8fa2041", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a1dab8e01f110ad11d3a0ab6a26f8f7cd86c80d1eeaea23791cc411e38e989d97b25ba92c58166cc32a410cb473e058539dc8710d3af9a5bb95968efb5d757a"}' ========= master_lag: 1.58 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-09-08 03:05:26.380974) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 03:05:26.381431) ========= 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.7JNrFIs9R4/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.ZJCogcDOkA/Listeners TMPDIR=/var/folders/8m/g8ffl9g56c9dzc7qx0hn0b_r00000w/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.004803 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 03:05:26.512938) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-09-08 03:05:26.513203) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-09-08 03:05:30.274193) ========= ========= Total master_lag: 3.30 =========