builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0287 starttime: 1473733559.0 results: success (0) buildid: 20160912172009 builduid: 24dc1eb70c114775a3e43666a4a660be revision: b1156b0eb96fcb49966b20e5fcf6a01f634ea2ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-12 19:25:58.997284) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-12 19:25:58.997759) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-12 19:25:58.998156) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-12 19:25:59.029010) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 19:25:59.029261) ========= 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.ozxh5TTvCx/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.UADzV5W6pj/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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-12 19:25:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 156M=0s 2016-09-12 19:25:59 (156 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156279 ========= master_lag: 0.60 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 19:25:59.786697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 19:25:59.787017) ========= 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.ozxh5TTvCx/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.UADzV5W6pj/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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.035943 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 19:25:59.852459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-12 19:25:59.852796) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b1156b0eb96fcb49966b20e5fcf6a01f634ea2ee --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 b1156b0eb96fcb49966b20e5fcf6a01f634ea2ee --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ozxh5TTvCx/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.UADzV5W6pj/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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-12 19:25:59,932 truncating revision to first 12 chars 2016-09-12 19:25:59,933 Setting DEBUG logging. 2016-09-12 19:25:59,933 attempt 1/10 2016-09-12 19:25:59,933 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b1156b0eb96f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-12 19:26:00,964 unpacking tar archive at: mozilla-central-b1156b0eb96f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.293043 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-12 19:26:01.167959) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-12 19:26:01.168263) ========= script_repo_revision: b1156b0eb96fcb49966b20e5fcf6a01f634ea2ee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-12 19:26:01.168652) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-12 19:26:01.168917) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-12 19:26:01.188158) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2016-09-12 19:26:01.188869) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.ozxh5TTvCx/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.UADzV5W6pj/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 19:26:01 INFO - MultiFileLogger online at 20160912 19:26:01 in /builds/slave/test 19:26:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:26:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:26:01 INFO - {'append_to_log': False, 19:26:01 INFO - 'base_work_dir': '/builds/slave/test', 19:26:01 INFO - 'blob_upload_branch': 'Firefox', 19:26:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:26:01 INFO - 'branch': 'Firefox', 19:26:01 INFO - 'buildbot_json_path': 'buildprops.json', 19:26:01 INFO - 'config_files': ('talos/mac_config.py',), 19:26:01 INFO - 'default_actions': ('clobber', 19:26:01 INFO - 'read-buildbot-config', 19:26:01 INFO - 'download-and-extract', 19:26:01 INFO - 'populate-webroot', 19:26:01 INFO - 'create-virtualenv', 19:26:01 INFO - 'install', 19:26:01 INFO - 'run-tests'), 19:26:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:26:01 INFO - 'download_minidump_stackwalk': True, 19:26:01 INFO - 'download_symbols': 'ondemand', 19:26:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:26:01 INFO - 'tooltool.py': '/tools/tooltool.py', 19:26:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:26:01 INFO - '/tools/misc-python/virtualenv.py')}, 19:26:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:26:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:26:01 INFO - 'installer_path': 'installer.exe', 19:26:01 INFO - 'log_level': 'info', 19:26:01 INFO - 'log_name': 'talos', 19:26:01 INFO - 'log_to_console': True, 19:26:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:26:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:26:01 INFO - 'opt_config_files': (), 19:26:01 INFO - 'pip_index': False, 19:26:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:26:01 INFO - 'cmd': ('bash', 19:26:01 INFO - '-c', 19:26:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:26:01 INFO - 'enabled': True, 19:26:01 INFO - 'halt_on_failure': False, 19:26:01 INFO - 'name': 'check_screen_resolution'},), 19:26:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:26:01 INFO - 'cmd': ('bash', 19:26:01 INFO - '-c', 19:26:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:26:01 INFO - 'enabled': True, 19:26:01 INFO - 'halt_on_failure': False, 19:26:01 INFO - 'name': 'check_screen_resolution'},), 19:26:01 INFO - 'run_cmd_checks_enabled': True, 19:26:01 INFO - 'sps_profile': False, 19:26:01 INFO - 'sps_profile_interval': 0, 19:26:01 INFO - 'suite': 'dromaeojs', 19:26:01 INFO - 'system_bits': '32', 19:26:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:26:01 INFO - 'title': 't-yosemite-r7-0287', 19:26:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:26:01 INFO - 'use_talos_json': True, 19:26:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:26:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:26:01 INFO - 'work_dir': 'build'} 19:26:01 INFO - [mozharness: 2016-09-13 02:26:01.394080Z] Running clobber step. 19:26:01 INFO - Running pre-action listener: _resource_record_pre_action 19:26:01 INFO - Running main action method: clobber 19:26:01 INFO - rmtree: /builds/slave/test/build 19:26:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:26:03 INFO - Running post-action listener: _resource_record_post_action 19:26:03 INFO - [mozharness: 2016-09-13 02:26:03.576123Z] Finished clobber step (success) 19:26:03 INFO - [mozharness: 2016-09-13 02:26:03.576270Z] Running read-buildbot-config step. 19:26:03 INFO - Running pre-action listener: _resource_record_pre_action 19:26:03 INFO - Running main action method: read_buildbot_config 19:26:03 INFO - Using buildbot properties: 19:26:03 INFO - { 19:26:03 INFO - "project": "", 19:26:03 INFO - "product": "firefox", 19:26:03 INFO - "script_repo_revision": "production", 19:26:03 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 19:26:03 INFO - "repository": "", 19:26:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 19:26:03 INFO - "buildid": "20160912172009", 19:26:03 INFO - "pgo_build": "False", 19:26:03 INFO - "basedir": "/builds/slave/test", 19:26:03 INFO - "buildnumber": 27, 19:26:03 INFO - "slavename": "t-yosemite-r7-0287", 19:26:03 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 19:26:03 INFO - "platform": "yosemite_r7", 19:26:03 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:26:03 INFO - "branch": "mozilla-central", 19:26:03 INFO - "repo_path": "mozilla-central", 19:26:03 INFO - "revision": "b1156b0eb96fcb49966b20e5fcf6a01f634ea2ee", 19:26:03 INFO - "stage_platform": "macosx64", 19:26:03 INFO - "builduid": "24dc1eb70c114775a3e43666a4a660be", 19:26:03 INFO - "slavebuilddir": "test" 19:26:03 INFO - } 19:26:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 19:26:03 INFO - Running post-action listener: _resource_record_post_action 19:26:03 INFO - [mozharness: 2016-09-13 02:26:03.579445Z] Finished read-buildbot-config step (success) 19:26:03 INFO - [mozharness: 2016-09-13 02:26:03.579553Z] Running download-and-extract step. 19:26:03 INFO - Running pre-action listener: _resource_record_pre_action 19:26:03 INFO - Running main action method: download_and_extract 19:26:03 INFO - mkdir: /builds/slave/test/build/tests 19:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:03 INFO - trying https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 19:26:03 INFO - Downloading https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/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 19:26:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/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 19:26:04 INFO - Downloaded 1199 bytes. 19:26:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 19:26:04 INFO - Using the following test package requirements: 19:26:04 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:26:04 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:26:04 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 19:26:04 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:26:04 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 19:26:04 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:26:04 INFO - u'jsshell-mac.zip'], 19:26:04 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:26:04 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 19:26:04 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:26:04 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:26:04 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 19:26:04 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:26:04 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 19:26:04 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:26:04 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 19:26:04 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:26:04 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 19:26:04 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:26:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:26:05 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 19:26:12 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 19:26:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:26:13 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 19:26:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 19:26:21 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 19:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:26:21 INFO - trying https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:26:21 INFO - Downloading https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 19:26:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/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 19:26:53 WARNING - Socket error when accessing https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg: The read operation timed out 19:26:53 INFO - retry: attempt #1 caught exception: The read operation timed out 19:26:53 INFO - retry: Failed, sleeping 30 seconds before retrying 19:27:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #2 19:27:26 INFO - Downloaded 111425108 bytes. 19:27:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:27:26 INFO - mkdir: /builds/slave/test/properties 19:27:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:27:26 INFO - Writing to file /builds/slave/test/properties/build_url 19:27:26 INFO - Contents: 19:27:26 INFO - build_url:https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:27:27 INFO - Running post-action listener: _resource_record_post_action 19:27:27 INFO - Running post-action listener: set_extra_try_arguments 19:27:27 INFO - [mozharness: 2016-09-13 02:27:27.370979Z] Finished download-and-extract step (success) 19:27:27 INFO - [mozharness: 2016-09-13 02:27:27.371098Z] Running populate-webroot step. 19:27:27 INFO - Running pre-action listener: _resource_record_pre_action 19:27:27 INFO - Running main action method: populate_webroot 19:27:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:27:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:27:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:27:27 INFO - '--tppagecycles', 19:27:27 INFO - '7'], 19:27:27 INFO - 'tests': ['tsvgm']}}, 19:27:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:27:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:27:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:27:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:27:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:27:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:27:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:27 INFO - 'talos_options': ['--disable-e10s'], 19:27:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:27 INFO - 'talos_options': ['--disable-e10s'], 19:27:27 INFO - 'tests': ['damp', 'tps']}, 19:27:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:27 INFO - 'tests': ['damp', 'tps']}, 19:27:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:27:27 INFO - 'tests': ['dromaeo_dom']}, 19:27:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:27:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:27:27 INFO - 'tests': ['basic_compositor_video']}, 19:27:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:27:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:27:27 INFO - 'tests': ['a11yr', 19:27:27 INFO - 'ts_paint', 19:27:27 INFO - 'tpaint', 19:27:27 INFO - 'sessionrestore', 19:27:27 INFO - 'sessionrestore_no_auto_restore', 19:27:27 INFO - 'tabpaint']}, 19:27:27 INFO - 'other-e10s': {'tests': ['a11yr', 19:27:27 INFO - 'ts_paint', 19:27:27 INFO - 'tpaint', 19:27:27 INFO - 'sessionrestore', 19:27:27 INFO - 'sessionrestore_no_auto_restore', 19:27:27 INFO - 'tabpaint']}, 19:27:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:27:27 INFO - 'ts_paint', 19:27:27 INFO - 'tpaint', 19:27:27 INFO - 'sessionrestore', 19:27:27 INFO - 'sessionrestore_no_auto_restore', 19:27:27 INFO - 'tabpaint']}, 19:27:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:27:27 INFO - 'ts_paint', 19:27:27 INFO - 'tpaint', 19:27:27 INFO - 'sessionrestore', 19:27:27 INFO - 'sessionrestore_no_auto_restore', 19:27:27 INFO - 'tabpaint']}, 19:27:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:27:27 INFO - 'tests': ['a11yr', 19:27:27 INFO - 'ts_paint', 19:27:27 INFO - 'tpaint', 19:27:27 INFO - 'sessionrestore', 19:27:27 INFO - 'sessionrestore_no_auto_restore', 19:27:27 INFO - 'tabpaint']}, 19:27:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:27:27 INFO - 'tests': ['a11yr', 19:27:27 INFO - 'ts_paint', 19:27:27 INFO - 'tpaint', 19:27:27 INFO - 'sessionrestore', 19:27:27 INFO - 'sessionrestore_no_auto_restore', 19:27:27 INFO - 'tabpaint']}, 19:27:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:27:27 INFO - 'tests': ['tsvgx', 19:27:27 INFO - 'tsvgr_opacity', 19:27:27 INFO - 'tart', 19:27:27 INFO - 'tscrollx', 19:27:27 INFO - 'cart']}, 19:27:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:27:27 INFO - 'tsvgr_opacity', 19:27:27 INFO - 'tart', 19:27:27 INFO - 'tscrollx', 19:27:27 INFO - 'cart']}, 19:27:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:27 INFO - 'talos_options': ['--disable-e10s'], 19:27:27 INFO - 'tests': ['tp5o']}, 19:27:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:27 INFO - 'tests': ['tp5o']}, 19:27:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:27 INFO - 'talos_options': ['--disable-e10s', 19:27:27 INFO - '--xperf_path', 19:27:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:27 INFO - 'tests': ['tp5n']}, 19:27:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:27 INFO - 'talos_options': ['--xperf_path', 19:27:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:27 INFO - 'tests': ['tp5n']}}, 19:27:27 INFO - 'talos.zip': {'path': '', 19:27:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:27:27 INFO - Running post-action listener: _resource_record_post_action 19:27:27 INFO - [mozharness: 2016-09-13 02:27:27.389844Z] Finished populate-webroot step (success) 19:27:27 INFO - [mozharness: 2016-09-13 02:27:27.389979Z] Running create-virtualenv step. 19:27:27 INFO - Running pre-action listener: _resource_record_pre_action 19:27:27 INFO - Running main action method: create_virtualenv 19:27:27 INFO - Creating virtualenv /builds/slave/test/build/venv 19:27:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:27:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:27:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:27:27 INFO - Using real prefix '/tools/python27' 19:27:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:27:28 INFO - Installing distribute.............................................................................................................................................................................................done. 19:27:31 INFO - Installing pip.................done. 19:27:31 INFO - Return code: 0 19:27:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:31 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 0x10f704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f67a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352ccee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f518d30>, '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 0x10f33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f510b20>, '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.ozxh5TTvCx/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.UADzV5W6pj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:27:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ozxh5TTvCx/Render', 19:27:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:31 INFO - 'HOME': '/Users/cltbld', 19:27:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:31 INFO - 'LOGNAME': 'cltbld', 19:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:31 INFO - 'MOZ_NO_REMOTE': '1', 19:27:31 INFO - 'NO_EM_RESTART': '1', 19:27:31 INFO - 'PAGER': '/bin/cat', 19:27:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:31 INFO - 'PWD': '/builds/slave/test', 19:27:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:31 INFO - 'SHELL': '/bin/bash', 19:27:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UADzV5W6pj/Listeners', 19:27:31 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 19:27:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:31 INFO - 'USER': 'cltbld', 19:27:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:31 INFO - 'XPC_FLAGS': '0x0', 19:27:31 INFO - 'XPC_SERVICE_NAME': '0', 19:27:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:27:31 INFO - Cleaning up... 19:27:31 INFO - Return code: 0 19:27:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:31 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 0x10f704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f67a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352ccee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f518d30>, '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 0x10f33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f510b20>, '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.ozxh5TTvCx/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.UADzV5W6pj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:27:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ozxh5TTvCx/Render', 19:27:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:31 INFO - 'HOME': '/Users/cltbld', 19:27:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:31 INFO - 'LOGNAME': 'cltbld', 19:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:31 INFO - 'MOZ_NO_REMOTE': '1', 19:27:31 INFO - 'NO_EM_RESTART': '1', 19:27:31 INFO - 'PAGER': '/bin/cat', 19:27:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:31 INFO - 'PWD': '/builds/slave/test', 19:27:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:31 INFO - 'SHELL': '/bin/bash', 19:27:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UADzV5W6pj/Listeners', 19:27:31 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 19:27:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:31 INFO - 'USER': 'cltbld', 19:27:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:31 INFO - 'XPC_FLAGS': '0x0', 19:27:31 INFO - 'XPC_SERVICE_NAME': '0', 19:27:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:31 INFO - Downloading/unpacking psutil>=3.1.1 19:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:27:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:35 INFO - Installing collected packages: psutil 19:27:35 INFO - Running setup.py install for psutil 19:27:35 INFO - building 'psutil._psutil_osx' extension 19:27:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 19:27:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:27:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:27:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:27:36 INFO - building 'psutil._psutil_posix' extension 19:27:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 19:27:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:27:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:27:36 INFO - ^ 19:27:36 INFO - 1 warning generated. 19:27:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 19:27:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:36 INFO - Successfully installed psutil 19:27:36 INFO - Cleaning up... 19:27:36 INFO - Return code: 0 19:27:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f67a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352ccee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f518d30>, '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 0x10f33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f510b20>, '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.ozxh5TTvCx/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.UADzV5W6pj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:27:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:27:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ozxh5TTvCx/Render', 19:27:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:36 INFO - 'HOME': '/Users/cltbld', 19:27:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:36 INFO - 'LOGNAME': 'cltbld', 19:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:36 INFO - 'MOZ_NO_REMOTE': '1', 19:27:36 INFO - 'NO_EM_RESTART': '1', 19:27:36 INFO - 'PAGER': '/bin/cat', 19:27:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:36 INFO - 'PWD': '/builds/slave/test', 19:27:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:36 INFO - 'SHELL': '/bin/bash', 19:27:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UADzV5W6pj/Listeners', 19:27:36 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 19:27:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:36 INFO - 'USER': 'cltbld', 19:27:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:36 INFO - 'XPC_FLAGS': '0x0', 19:27:36 INFO - 'XPC_SERVICE_NAME': '0', 19:27:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:27:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:27:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:27:39 INFO - Installing collected packages: mozsystemmonitor 19:27:39 INFO - Running setup.py install for mozsystemmonitor 19:27:39 INFO - Successfully installed mozsystemmonitor 19:27:39 INFO - Cleaning up... 19:27:39 INFO - Return code: 0 19:27:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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', '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 0x10f704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f67a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352ccee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f518d30>, '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 0x10f33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f510b20>, '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.ozxh5TTvCx/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.UADzV5W6pj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:27: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 jsonschema==2.5.1 19:27:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ozxh5TTvCx/Render', 19:27:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:39 INFO - 'HOME': '/Users/cltbld', 19:27:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:39 INFO - 'LOGNAME': 'cltbld', 19:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:39 INFO - 'MOZ_NO_REMOTE': '1', 19:27:39 INFO - 'NO_EM_RESTART': '1', 19:27:39 INFO - 'PAGER': '/bin/cat', 19:27:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:39 INFO - 'PWD': '/builds/slave/test', 19:27:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:39 INFO - 'SHELL': '/bin/bash', 19:27:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UADzV5W6pj/Listeners', 19:27:39 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 19:27:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:39 INFO - 'USER': 'cltbld', 19:27:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:39 INFO - 'XPC_FLAGS': '0x0', 19:27:39 INFO - 'XPC_SERVICE_NAME': '0', 19:27:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:39 INFO - Downloading/unpacking jsonschema==2.5.1 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:27:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:42 INFO - Downloading functools32-3.2.3-2.tar.gz 19:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:27:42 INFO - warning: no files found matching '*.txt' 19:27:42 INFO - no previously-included directories found matching 'build' 19:27:42 INFO - no previously-included directories found matching 'dist' 19:27:42 INFO - no previously-included directories found matching '.git*' 19:27:42 INFO - Installing collected packages: jsonschema, functools32 19:27:42 INFO - Running setup.py install for functools32 19:27:43 INFO - warning: no files found matching '*.txt' 19:27:43 INFO - no previously-included directories found matching 'build' 19:27:43 INFO - no previously-included directories found matching 'dist' 19:27:43 INFO - no previously-included directories found matching '.git*' 19:27:43 INFO - Successfully installed jsonschema functools32 19:27:43 INFO - Cleaning up... 19:27:43 INFO - Return code: 0 19:27:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:43 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 0x10f704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f67a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352ccee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f518d30>, '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 0x10f33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f510b20>, '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.ozxh5TTvCx/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.UADzV5W6pj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:27:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ozxh5TTvCx/Render', 19:27:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:43 INFO - 'HOME': '/Users/cltbld', 19:27:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:43 INFO - 'LOGNAME': 'cltbld', 19:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:43 INFO - 'MOZ_NO_REMOTE': '1', 19:27:43 INFO - 'NO_EM_RESTART': '1', 19:27:43 INFO - 'PAGER': '/bin/cat', 19:27:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:43 INFO - 'PWD': '/builds/slave/test', 19:27:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:43 INFO - 'SHELL': '/bin/bash', 19:27:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UADzV5W6pj/Listeners', 19:27:43 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 19:27:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:43 INFO - 'USER': 'cltbld', 19:27:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:43 INFO - 'XPC_FLAGS': '0x0', 19:27:43 INFO - 'XPC_SERVICE_NAME': '0', 19:27:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:27:43 INFO - Cleaning up... 19:27:43 INFO - Return code: 0 19:27:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:43 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 0x10f704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f67a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352ccee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f518d30>, '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 0x10f33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f510b20>, '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.ozxh5TTvCx/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.UADzV5W6pj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:27:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ozxh5TTvCx/Render', 19:27:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:43 INFO - 'HOME': '/Users/cltbld', 19:27:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:43 INFO - 'LOGNAME': 'cltbld', 19:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:43 INFO - 'MOZ_NO_REMOTE': '1', 19:27:43 INFO - 'NO_EM_RESTART': '1', 19:27:43 INFO - 'PAGER': '/bin/cat', 19:27:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:43 INFO - 'PWD': '/builds/slave/test', 19:27:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:43 INFO - 'SHELL': '/bin/bash', 19:27:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UADzV5W6pj/Listeners', 19:27:43 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 19:27:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:43 INFO - 'USER': 'cltbld', 19:27:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:43 INFO - 'XPC_FLAGS': '0x0', 19:27:43 INFO - 'XPC_SERVICE_NAME': '0', 19:27:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:43 INFO - Downloading/unpacking blobuploader==1.2.4 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:46 INFO - Downloading blobuploader-1.2.4.tar.gz 19:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:27:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:27:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:47 INFO - Downloading docopt-0.6.1.tar.gz 19:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:27:47 INFO - Installing collected packages: blobuploader, requests, docopt 19:27:47 INFO - Running setup.py install for blobuploader 19:27:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:27:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:27:47 INFO - Running setup.py install for requests 19:27:48 INFO - Running setup.py install for docopt 19:27:48 INFO - Successfully installed blobuploader requests docopt 19:27:48 INFO - Cleaning up... 19:27:48 INFO - Return code: 0 19:27:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:48 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 0x10f704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f67a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352ccee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f518d30>, '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 0x10f33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f510b20>, '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.ozxh5TTvCx/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.UADzV5W6pj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:27:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ozxh5TTvCx/Render', 19:27:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:48 INFO - 'HOME': '/Users/cltbld', 19:27:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:48 INFO - 'LOGNAME': 'cltbld', 19:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:48 INFO - 'MOZ_NO_REMOTE': '1', 19:27:48 INFO - 'NO_EM_RESTART': '1', 19:27:48 INFO - 'PAGER': '/bin/cat', 19:27:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:48 INFO - 'PWD': '/builds/slave/test', 19:27:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:48 INFO - 'SHELL': '/bin/bash', 19:27:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UADzV5W6pj/Listeners', 19:27:48 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 19:27:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:48 INFO - 'USER': 'cltbld', 19:27:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:48 INFO - 'XPC_FLAGS': '0x0', 19:27:48 INFO - 'XPC_SERVICE_NAME': '0', 19:27:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:48 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-stmSPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:48 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-O__1N5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:48 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-zT8QR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:48 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-1ynGKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:49 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-B2EGwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:49 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-54i6Jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:49 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-2qMeV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:49 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-kCrBa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:49 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-46vS1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:49 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-EE7JTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:49 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-GSImXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:49 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-GhRgBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:49 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-d9dWQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:50 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-RW5irz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:50 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-fGUFIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:50 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-d0q5Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:50 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-ohL5Rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:27:50 INFO - Running setup.py install for manifestparser 19:27:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:27:50 INFO - Running setup.py install for mozcrash 19:27:50 INFO - Running setup.py install for mozdebug 19:27:50 INFO - Running setup.py install for mozdevice 19:27:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Running setup.py install for mozfile 19:27:51 INFO - Running setup.py install for mozhttpd 19:27:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Running setup.py install for mozinfo 19:27:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Running setup.py install for mozInstall 19:27:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Running setup.py install for mozleak 19:27:51 INFO - Running setup.py install for mozlog 19:27:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:27:51 INFO - Running setup.py install for moznetwork 19:27:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:27:52 INFO - Running setup.py install for mozprocess 19:27:52 INFO - Running setup.py install for mozprofile 19:27:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:27:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:27:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:27:52 INFO - Running setup.py install for mozrunner 19:27:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:27:52 INFO - Running setup.py install for mozscreenshot 19:27:52 INFO - Running setup.py install for moztest 19:27:52 INFO - Running setup.py install for mozversion 19:27:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:27:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:27:52 INFO - Cleaning up... 19:27:53 INFO - Return code: 0 19:27:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:53 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 0x10f704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f67a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352ccee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f518d30>, '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 0x10f33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f510b20>, '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.ozxh5TTvCx/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.UADzV5W6pj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:27:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ozxh5TTvCx/Render', 19:27:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:53 INFO - 'HOME': '/Users/cltbld', 19:27:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:53 INFO - 'LOGNAME': 'cltbld', 19:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:53 INFO - 'MOZ_NO_REMOTE': '1', 19:27:53 INFO - 'NO_EM_RESTART': '1', 19:27:53 INFO - 'PAGER': '/bin/cat', 19:27:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:53 INFO - 'PWD': '/builds/slave/test', 19:27:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:53 INFO - 'SHELL': '/bin/bash', 19:27:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UADzV5W6pj/Listeners', 19:27:53 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 19:27:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:53 INFO - 'USER': 'cltbld', 19:27:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:53 INFO - 'XPC_FLAGS': '0x0', 19:27:53 INFO - 'XPC_SERVICE_NAME': '0', 19:27:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:53 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-1K1dYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:53 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-l5Y_WY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:53 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-AIifOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:53 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-gOnA79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:53 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-aLCMpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:53 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-WnFg8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:53 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-MfOnLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:54 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-GMRNHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:54 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-JS2Ich-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:54 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-N5YVcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:54 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)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:54 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-i0Vwbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:54 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-KuTHT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:54 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-ltRWwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:54 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-Ar0xrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:54 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-dWaV8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:54 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-gznHnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:55 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-tJvA78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:27:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:27:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:27:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:27:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:27:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:27:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:57 INFO - Downloading blessings-1.6.tar.gz 19:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:27:57 INFO - Installing collected packages: blessings 19:27:57 INFO - Running setup.py install for blessings 19:27:57 INFO - Successfully installed blessings 19:27:57 INFO - Cleaning up... 19:27:58 INFO - Return code: 0 19:27:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:27:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:27:58 INFO - Reading from file tmpfile_stdout 19:27:58 INFO - Current package versions: 19:27:58 INFO - blessings == 1.6 19:27:58 INFO - blobuploader == 1.2.4 19:27:58 INFO - docopt == 0.6.1 19:27:58 INFO - functools32 == 3.2.3-2 19:27:58 INFO - jsonschema == 2.5.1 19:27:58 INFO - manifestparser == 1.1 19:27:58 INFO - mozInstall == 1.12 19:27:58 INFO - mozcrash == 0.17 19:27:58 INFO - mozdebug == 0.1 19:27:58 INFO - mozdevice == 0.48 19:27:58 INFO - mozfile == 1.2 19:27:58 INFO - mozhttpd == 0.7 19:27:58 INFO - mozinfo == 0.9 19:27:58 INFO - mozleak == 0.1 19:27:58 INFO - mozlog == 3.3 19:27:58 INFO - moznetwork == 0.27 19:27:58 INFO - mozprocess == 0.23 19:27:58 INFO - mozprofile == 0.28 19:27:58 INFO - mozrunner == 6.12 19:27:58 INFO - mozscreenshot == 0.1 19:27:58 INFO - mozsystemmonitor == 0.3 19:27:58 INFO - moztest == 0.7 19:27:58 INFO - mozversion == 1.4 19:27:58 INFO - psutil == 3.1.1 19:27:58 INFO - requests == 1.2.3 19:27:58 INFO - wsgiref == 0.1.2 19:27:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:58 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 0x10f704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f67a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352ccee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f518d30>, '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 0x10f33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f510b20>, '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.ozxh5TTvCx/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.UADzV5W6pj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:27:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ozxh5TTvCx/Render', 19:27:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:58 INFO - 'HOME': '/Users/cltbld', 19:27:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:58 INFO - 'LOGNAME': 'cltbld', 19:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:58 INFO - 'MOZ_NO_REMOTE': '1', 19:27:58 INFO - 'NO_EM_RESTART': '1', 19:27:58 INFO - 'PAGER': '/bin/cat', 19:27:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:58 INFO - 'PWD': '/builds/slave/test', 19:27:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:58 INFO - 'SHELL': '/bin/bash', 19:27:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UADzV5W6pj/Listeners', 19:27:58 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 19:27:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:58 INFO - 'USER': 'cltbld', 19:27:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:58 INFO - 'XPC_FLAGS': '0x0', 19:27:58 INFO - 'XPC_SERVICE_NAME': '0', 19:27:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:27:58 INFO - Cleaning up... 19:27:58 INFO - Return code: 0 19:27:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:58 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 0x10f704490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f67a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9352ccee70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f518d30>, '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 0x10f33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f510b20>, '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.ozxh5TTvCx/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.UADzV5W6pj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:27:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:27:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ozxh5TTvCx/Render', 19:27:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:27:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:27:58 INFO - 'HOME': '/Users/cltbld', 19:27:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:27:58 INFO - 'LOGNAME': 'cltbld', 19:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:58 INFO - 'MOZ_NO_REMOTE': '1', 19:27:58 INFO - 'NO_EM_RESTART': '1', 19:27:58 INFO - 'PAGER': '/bin/cat', 19:27:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:58 INFO - 'PWD': '/builds/slave/test', 19:27:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:27:58 INFO - 'SHELL': '/bin/bash', 19:27:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UADzV5W6pj/Listeners', 19:27:58 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 19:27:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:27:58 INFO - 'USER': 'cltbld', 19:27:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:27:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:58 INFO - 'XPC_FLAGS': '0x0', 19:27:58 INFO - 'XPC_SERVICE_NAME': '0', 19:27:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:27:58 INFO - Cleaning up... 19:27:58 INFO - Return code: 0 19:27:58 INFO - Running post-action listener: _resource_record_post_action 19:27:58 INFO - Running post-action listener: _start_resource_monitoring 19:27:58 INFO - Starting resource monitoring. 19:27:58 INFO - [mozharness: 2016-09-13 02:27:58.964817Z] Finished create-virtualenv step (success) 19:27:58 INFO - [mozharness: 2016-09-13 02:27:58.965884Z] Running install step. 19:27:58 INFO - Running pre-action listener: _resource_record_pre_action 19:27:58 INFO - Running main action method: install 19:27:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:27:59 INFO - Reading from file tmpfile_stdout 19:27:59 INFO - Detecting whether we're running mozinstall >=1.0... 19:27:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:27:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:27:59 INFO - Reading from file tmpfile_stdout 19:27:59 INFO - Output received: 19:27:59 INFO - Usage: mozinstall [options] installer 19:27:59 INFO - Options: 19:27:59 INFO - -h, --help show this help message and exit 19:27:59 INFO - -d DEST, --destination=DEST 19:27:59 INFO - Directory to install application into. [default: 19:27:59 INFO - "/builds/slave/test"] 19:27:59 INFO - --app=APP Application being installed. [default: firefox] 19:27:59 INFO - mkdir: /builds/slave/test/build/application 19:27:59 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'] 19:27:59 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 19:28:33 INFO - Reading from file tmpfile_stdout 19:28:33 INFO - Output received: 19:28:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:28:33 INFO - Running post-action listener: _resource_record_post_action 19:28:33 INFO - [mozharness: 2016-09-13 02:28:33.594332Z] Finished install step (success) 19:28:33 INFO - [mozharness: 2016-09-13 02:28:33.594506Z] Running run-tests step. 19:28:33 INFO - Running pre-action listener: _resource_record_pre_action 19:28:33 INFO - Running main action method: run_tests 19:28:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:28:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:28:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:28:33 INFO - 2016-09-12 19:28:33.608 screenresolution[1648:7665] starting screenresolution argv=screenresolution get 19:28:33 INFO - 2016-09-12 19:28:33.611 screenresolution[1648:7665] Display 0: 1600x1200x32@60 19:28:33 INFO - 2016-09-12 19:28:33.617 screenresolution[1649:7667] starting screenresolution argv=screenresolution list 19:28:33 INFO - Available Modes on Display 0 19:28:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:28:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:28:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:28:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:28:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:28:33 INFO - Intel Iris: 19:28:33 INFO - Chipset Model: Intel Iris 19:28:33 INFO - Type: GPU 19:28:33 INFO - Bus: Built-In 19:28:33 INFO - VRAM (Dynamic, Max): 1536 MB 19:28:33 INFO - Vendor: Intel (0x8086) 19:28:33 INFO - Device ID: 0x0a2e 19:28:33 INFO - Revision ID: 0x0009 19:28:33 INFO - Displays: 19:28:33 INFO - Display: 19:28:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:28:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:28:33 INFO - Display Serial Number: 1600x1200 60 19:28:33 INFO - Main Display: Yes 19:28:33 INFO - Mirror: Off 19:28:33 INFO - Online: Yes 19:28:33 INFO - Rotation: Supported 19:28:33 INFO - Return code: 0 19:28:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:28:33 INFO - Python 2.7.3 19:28:33 INFO - Return code: 0 19:28:33 INFO - grabbing minidump binary from tooltool 19:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:33 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 0x10f518d30>, '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 0x10f33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f510b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:28:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:28:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 19:28:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:28:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:28:33 INFO - Return code: 0 19:28:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:28:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:28:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:28:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:28:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:28:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0287', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0287 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:28:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ozxh5TTvCx/Render', 19:28:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:28:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:28:33 INFO - 'HOME': '/Users/cltbld', 19:28:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:28:33 INFO - 'LOGNAME': 'cltbld', 19:28:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:28:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:33 INFO - 'MOZ_NO_REMOTE': '1', 19:28:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:28:33 INFO - 'NO_EM_RESTART': '1', 19:28:33 INFO - 'PAGER': '/bin/cat', 19:28:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:33 INFO - 'PWD': '/builds/slave/test', 19:28:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:28:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:28:33 INFO - 'SHELL': '/bin/bash', 19:28:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UADzV5W6pj/Listeners', 19:28:33 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 19:28:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:28:33 INFO - 'USER': 'cltbld', 19:28:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:28:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:33 INFO - 'XPC_FLAGS': '0x0', 19:28:33 INFO - 'XPC_SERVICE_NAME': '0', 19:28:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:28:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0287', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:28:34 INFO - mozversion application_buildid: 20160912172009 19:28:34 INFO - mozversion application_changeset: b1156b0eb96fcb49966b20e5fcf6a01f634ea2ee 19:28:34 INFO - mozversion application_display_name: Nightly 19:28:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:28:34 INFO - mozversion application_name: Firefox 19:28:34 INFO - mozversion application_remotingname: firefox 19:28:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:28:34 INFO - mozversion application_vendor: Mozilla 19:28:34 INFO - mozversion application_version: 51.0a1 19:28:34 INFO - mozversion platform_buildid: 20160912172009 19:28:34 INFO - mozversion platform_changeset: b1156b0eb96fcb49966b20e5fcf6a01f634ea2ee 19:28:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:28:34 INFO - mozversion platform_version: 51.0a1 19:28:34 INFO - using testdate: 1473733714 19:28:34 INFO - actual date: 1473733714 19:28:34 INFO - starting webserver on 'localhost:49280' 19:28:34 INFO - SUITE-START | Running 2 tests 19:28:34 INFO - TEST-START | dromaeo_css 19:28:34 INFO - operating with platform_type : mac_ 19:28:34 INFO - Initialising browser for dromaeo_css test... 19:28:34 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmpbcC5wq/profile http://localhost:49280/getInfo.html) 19:28:36 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 19:28:36 INFO - PROCESS | 1659 | colorDepth:24 19:28:36 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 19:28:36 INFO - PROCESS | 1659 | __metrics 19:28:36 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:28:36 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:28:37 INFO - TEST-INFO | 1659: exit 0 19:28:37 INFO - Browser initialized. 19:28:37 INFO - Running cycle 1/1 for dromaeo_css test... 19:28:37 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmpbcC5wq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:28:49 INFO - PROCESS | 1661 | RSS: Main: 233918464 19:28:49 INFO - PROCESS | 1661 | 19:29:40 INFO - PROCESS | 1661 | 1473733780711 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:31:52 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 19:31:53 INFO - PROCESS | 1661 | RSS: Main: 355745792 19:31:53 INFO - PROCESS | 1661 | 19:34:56 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 19:34:57 INFO - PROCESS | 1661 | RSS: Main: 372723712 19:34:57 INFO - PROCESS | 1661 | 19:37:59 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 19:38:00 INFO - PROCESS | 1661 | RSS: Main: 350257152 19:38:00 INFO - PROCESS | 1661 | 19:41:02 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 19:41:03 INFO - PROCESS | 1661 | RSS: Main: 338649088 19:41:03 INFO - PROCESS | 1661 | 19:44:06 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 19:44:07 INFO - PROCESS | 1661 | RSS: Main: 325074944 19:44:07 INFO - PROCESS | 1661 | 19:47:10 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 19:47:10 INFO - PROCESS | 1661 | RSS: Main: 468697088 19:47:10 INFO - PROCESS | 1661 | 19:47:10 INFO - PROCESS | 1661 | __start_tp_report 19:47:10 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 19:47:10 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 19:47:10 INFO - PROCESS | 1661 | |i|pagename|runs| 19:47:10 INFO - PROCESS | 1661 | |0;dojo.html;2973.7472314853235;3322.9335413291733;3345.514900339452;3391.287829555793;3417.555717756691;5639.182318563806;5743.138529220619;5749.741261643226;5829.679367634783;5874.676892770896;5776;5802.187693722872;5804.361520232771;5811.82564523065;5814.534837213013;5238.659487133334;5269.6311258211945;5291.894162116774;5317.989581979431;5355.812546560871;5336.653117547347;5345.518903298703;5352.304200453936;5353.491418315273;5368.946310536903;5240.9213861792105;5254.264402983586;5296.390915044762;5307.867303317429;5348.251244825728;5356.1697936819855;5370.3287089113865;5387.568994480472;5392.299001129867;5404.081306177959;5106.183010718267;5224.529792318672;5229.764660590283;5301.814436494743;5316.4683531646915;5696.430356964312;5802.274715660543;5809.82570522885;5811.4479124483105;5815.796447124372;6232.594881332744;6283.371662833726;6284.465820405271;6298.086777417248;6300.117983482316;6195.163652906845;6197.907031394533;6235.625862448268;6247.562670613059;6273.56085074045;5788.594798364116;5794.072948328289;5860.853478663067;5995.580309378389;5996.730147143389;6335.556511044183;6341.397567231105;6352.65060421672;6365.172527571386;6374.713137908712;6114.2662880453745;6174.567780255339;6227.813165605039;6235.282942461675;6245.500359971283;6187.721552530147;6209.9379006210265;6225.844353891099;6236.314005459396;6292.622442653364;6226;6230.43926046658;6232.220972378453;6240.563160578716;6245.500359971192;6190.102435146879;6250.9062364064575;6261.342559031327;6269.059641053878;6276.089966954766;4940.851774446773;4984.252362145708;4995.050940321327;5005.124103281911;5045.596352291808;4534.319852022223;4538.659600529973;4560.749158796298;4563.817447302071;4565.908681826345;5779.653220806681;5798.449147330997;5800.477956983892;5808.361080281165;5809.767609295665;6171.321154672983;6171.660558669317;6194.0708893665405;6228.252609686776;6254.061890716429;5739.913901291484;5774.595778295479;5782.624129431573;5816.360200377955;5820.3888591698105;5497.835064948058;5503.587230957694;5505.449455054542;5507.614466987273;5507.917381239285;6181.752729890934;6252.124702541557;6380.489560835029;6384.744610215539;6387.329330420332;6186.133941248138;6208.813735587759;6228.377162283736;6237.469815065589;6262.53031022666;6328.303886572566;6351.460125889351;6361.236651601837;6370.840728981812;6379.075034120119;6119.563485741731;6249.218847644044;6258.217722784652;6262.46769024638;6278.780242691484;5167.844964651066;6174.6912654368;6185.226846644169;6195.2875419325555;6249.0626406039455;6181.289151747606;6204.317525072329;6213.099100630293;6214.844628884133;6227;5701.942980570141;6156.938430615636;6167.695781627886;6221.502279817694;6232.594881332699;5233.528982391603;5878.735456904364;5921.970390148022;5944.910826337695;5965.938721485248;6118.43644382056;6185.84535386619;6190.535709821871;6201.0388389799655;6205.689715514297;4974.253861920741;5918.822435326947;5956.8808623828145;6100.54245931548;6113.29697084841 19:47:10 INFO - PROCESS | 1661 | |1;ext.html;474.24831641847646;492.71915008445154;515.979360825567;518.6214063733476;525.5112745147014;27570.44859102817;31055;31438.528422073687;37844.62155378449;38866.02834929128;40245;40410.7979460103;40524;40593.391099133536;40600.390994135036;9589.712308630735;9749.561269742842;9766.462844543546;9774.31579789415;9790.853137202948;8585.399022068457;8751.781205469882;8761.7809554761;8901.24339431146;8907.821843563124;8788.384813063089;11788.528458861636;11957.581484648039;12104.939475302612;12299.754004919896;11932.16474846761;11998.52005919762;12012.759744805055;12014.038876889828;12015.158938874283;11849.229800063054;11947.761044779056;11951.701207469883;11971.880281197164;12012.939935300268;38529.22941541181;38777.806110969264;38824.223515529535;38862.61137388618;38881.80559097186;3677.2461645362637;3978.7214894957365;4022.1754540319166;4062.2687916175078;4132.070284186064;30637.080887573407;30641.846790765903;30653.846730766203;30712.925047623226;31024.689753102404;3167.683231676837;3283;3330.0509354833757;3346.330733853239;3346.9832650836834;504190;506266.4686676543;506294;506555;507963.99999999633;55594.16608750872;55703;55729;55960.44039559552;56026;56982.86034279291;56997.430025699214;57051;57074.714626427434;57143;15675.764863527056;15829.762553561706;15861.04833709958;15880.444184453489;15880.841191587937;12384.504619815287;12459.314737689332;12464.626061218178;12474.625761227178;12495.375231238402;12239.938800305941;13410.329483525784;13731.656708582366;13746.312684365741;14782.704345913236;5533.391326954032;6467.450266727286;6672.731271367758;6731.360520750521;6758.255482839645;838.224642205957;897.228383590112;923.5797712041006;943.9103285187896;976.5263847034183;28207.153785386472;28823;28968.80726635323;29255.122346329645;29464.852675736485;1025.620520407454;1050.8318669012922;1060.8992145746142;1082.9404382759024;1083.9024487796137;14485.058471199338;14789.186594737394;14837.480688176078;14949.02831315961;15190.772138417933;647460;653441;653564;653632;654842;47287.527124729;47483.76258118756;52826.73586632042;53358;53550.73224633852;1345.260106941198;1347.8989075819156;1355.8847497962784;1388.4862600837957;1392.8119703840055;25668.614970775827;29689.851550742107;30438.391232175676;30741.077767667004;30742.53886191664;46537.534624654676;47014.059718806115;47038.99999999863;47060.7646961763;47094.293585596926;427753;438443;438483;438668;572316;21329.573408532055;24197.032118715055;24366.147184848443;24459.75540244646;24496.265112046665;42085;42246.57753422426;42818.78590607027;42930.35604465873;43016.784916075216;29745.70254297516;35450.64549354473;35452.822735886155;35861.64138358583;36603.26793464169;35465.468017979234;35769.92690219298;36261.81869090743;36535.45196822103;36568.63431365652;34669.826650866584;35172.47241291332;35204;35559.46660800038;35664.64335356717;27432.862835685693;30725.385492290476;31787;31828.681713183498;31858.522122167724;19346.088304410274;22582;23969.400764981016;24246.51506969886;24273.75726242715 19:47:10 INFO - PROCESS | 1661 | |2;jquery.html;349.12195827493844;367.61951380321375;371.4150213413872;378.7992364047056;397.3939741893612;14701.779473307908;14781.630459238511;15774.605634859134;20331.49171270719;20832.791672083276;19385.612287754237;19852.40442786715;20457.62449195881;20595.07322170506;20709.482262943435;5125.1287281162295;5884.499817515516;6135.846603834895;6147.846303842417;6149.077638354238;6010.36891126432;6067.24159480065;6129.080637904328;6131.570790044699;6162.352952939944;5744.425557444264;5965.910511342333;6061.090836374557;6073.605215660968;6077.392260773931;5957.510622344414;6003.6397816131175;6009.369016253296;6011.428914253139;6018.6990650467305;4993.251012348141;5210.244514545369;5232.241325007891;5259.079661059338;5265.657732247391;20524.486887827774;23226.76773232263;24015.399615009588;24193.879030604734;25385.61921571178;2072.5025993761537;2507.862067586282;2518.2319392585255;2584.2634849067927;2866.5986761853355;9767.658131965347;9781.853272200922;9822.361546499526;10259.897401025968;10312.845307320396;1819.3177558415593;1840.227104616051;1857.2849452960572;1872.691005984011;1893.3846499887454;82727;109792;113270;113418;114089;11218.943905280421;11251.662450126509;11328.603498877499;11377;11522.711932201595;14360.281985900663;14373.281335933161;14414.85585144135;14415.351309191112;14422;6887.897936330163;8235.464694794819;8544.2310192083;8616.655333786704;8646.913530864611;8405.747827565183;8423.326133909273;8432.04878292605;8616.439931404439;8619.61211745473;3671.5777685565968;4454.799534020977;4460.643148548108;4490.101979604027;4515.841945531891;1848.981510184881;1893.7822150452598;1894.8199921007483;1926.5954149628735;1938.6122775444967;641.7657554992487;693.7953303775398;729.0194688144437;793.6864041319488;929.6699671616614;21258.574828503344;21812;21842;21950.780492195194;22005.449863753533;897.8653202019749;913.4747520175792;914.9176574108362;917.5320586500933;919.1451949686856;9265.72202833916;10803.891961080288;11096.389698566494;11390.772184556428;11400.372979486208;577887;581448;587251;594941;595848;81606.551803446;109330.45334773275;124132.37933810274;125665.37167314287;129385;861.8405594964952;938.4088024544493;959.3092973059386;970.257752819094;971.5676523946776;19304.938228397572;19568.90215548913;19713.70429443531;19718.309859154862;19733;43069.27722891175;52743.472565273856;53522.46477535175;53700.73149634383;54674.179887300925;67683.61581920786;69859.30140698732;83270.58364708138;83295.16704832875;85198.57400712957;6068.848278792889;7326.450516211199;7328.24122210655;7450;7532.359749421361;10578.418186999788;11665.59170429065;12269.957053650183;13158;13465.39405726725;11218.66344009681;11375.31748095117;11503.367314797766;11611.5355385787;11630.825537617111;11093.889061109609;11168.888311117109;11193;11620.128490363088;11635.825462617899;11192;11240.606578769704;11459.31244125355;11548.769024619629;11815.350155741173;7251.709931602677;7413.8146546336775;7461.626918653937;7584.658690358837;7653.158152603098;10401.219908507044;11088.390138542458;11204.271722338022;11590.478428470908;11601.883981160418 19:47:10 INFO - PROCESS | 1661 | |3;mootools.html;1344.4017412251546;1505.7590785474326;1677.1195122560655;1804.124999375302;1898.3925143953923;7860.702984007639;7971.402144839131;8240.546769927652;8797.692080777175;9032.006479287273;8107.797305067376;8530.274926631244;8779.165979231979;8784.1655042771;8899.95550022249;2364.2788949370433;2400.243923164198;2403.519296140779;2404.759524047599;2409.012304954969;2099.7585277693033;2364.9763502365013;2380.8571485710827;2409.8433601815827;2411.7588241175918;2161.200355868331;2177.978220217801;2319.2926157521947;2392.497575509145;2402.771736685012;2362.7164740231196;2375.7624237576106;2376.9762302376926;2377.8097752179956;2380.4881950380664;2334.684817549643;2368.751281115475;2374.7031621047367;2377.9881100594384;2378.6194208926663;8850.557472126367;8883;8941.284697224206;8978.057303983118;9000.964889037714;5241.816536421207;5409.594280428983;5412.675239485643;5416.241726158341;5419.5393391561765;3478.3565040467593;3579;3654.4335627977707;3728.1611637381643;3729.9440508392395;1076.9892301076968;1089.7548051688386;1092.202692034819;1105.7622611138643;1113.170687837558;9984.25118116137;11748.118891083202;11863.58477453285;11889;11894.762104757856;4547.954520454819;4556.498785133633;4754.595859351924;4755.476897541337;4796.544328288807;10002.849957250646;10021.498925053718;10026;10036.397816131055;10043.146332561668;5371.6508426952905;5373.704446255493;5379.35447746273;5379.784808607612;5382.892342153214;4436.201483732959;4912.459629440758;4921.188003979303;4927.457979622239;4927.852164435073;3776.8866933992026;3817.1411432428035;3833.923321533554;3881.941770873439;3914.256291304643;1170.6780635325354;1172.1853311948284;1182.787098322293;1183.3491579631168;1184.8045072562932;632.4845251120322;782.7260458839474;900.68499990014;918.6233644205844;944.187998321443;5917.349091599921;5928.140419639129;6024.608400453956;6076.149339092531;6080.14877917092;461.3126441601989;477.9784909679073;487.4345758919636;491.39312948508564;629.235478893147;3754.699624030071;3971.702122340836;4075.8777236682945;4106.322456794595;4106.650934670586;10539.367637941748;11021.063209627111;11024.779504409868;11038.889611103947;11049.834252486218;10972.23194376402;10981.450927453596;10990.230683852213;10997.285176463503;11029.669109926715;7095.0421693070775;7759.758438649789;8025.839483210303;8200.302974247255;8303.501789892625;5830.416958304136;5864.67744274052;6015.639061656315;6077.179580756718;6102.603330783485;10174.745631359276;10293.228007899288;10337.121344685786;10341.534630941474;10370.896291036994;9995.550200241152;10309.793804123725;10321.793564128526;10484.161267098767;10492;7506.211847756125;7689.538627682357;7695.307422332017;7698.114716807639;7708.768736937901;8191.672333106847;8201.13888041747;8230.670773169006;8335.458195217292;8355.95822020886;7397.593132377771;7422.480426370103;7443.925560744323;7443.962780186064;7548.5470871747875;6268.874622507433;7329.450291228286;7390.29792169743;7498.062742157231;7528.397728181842;6986.895196572157;7020.946857971345;7034.507584469243;7065.434765218667;7073.540219885691;4598.26427771555;4943.382077240345;4983.6760610560195;5027.095122877771;5210.713410762444;4997.300377947017;5050.84847454577;5095.92356114666;5109.565686916654;5299.973500132629 19:47:10 INFO - PROCESS | 1661 | |4;prototype.html;278.81598145224154;278.9734975177358;296.70922495953977;312.5608520029358;314.2693238221136;5020;5114.752132395927;5226.320578324817;5242.659227150232;5296.443873393296;4252.829886804532;4953.900921981558;5087.465816089313;5107.668001579895;5122.9508196721235;3301.966980330196;3634.963650363502;3665.9450108248266;4044.6450439102937;4055.695822813286;3419.606745224306;3484.4947482615007;3538.4161613333767;3921.6862650987996;3980.363141897297;3963.128111815396;3993.161436098408;4009.7794621295816;4009.819558119877;4039.757614543122;3113.6886311368908;3402.897913062612;3858.7105967052585;4000.4999375078114;4010.1779135277343;2945.3078526546246;3444.4488881778793;3508.824558772051;3514.9824250878837;3525.3254704015644;4530.569595888385;4923.458419573844;5008.24876268559;5058.266551350071;5117.769700363493;4553.043860789238;4565.2467342888385;4578.51925547816;4581.541845815425;4594.701344412636;4520.3219517072375;5459.754311055973;5461.344638643349;5464.371597266286;5470.699111548864;3368.781029233092;3371.8198630479383;3854.479645247912;3857.0164608024775;3857.4792403025513;5076.857707015929;5673.375928647845;5683.403242659502;5693.971530142323;5729.770809167629;3641.362761516724;3884.1649045455365;3885.1646895916947;3894.5910679378826;3902.941455878164;3793.905152371158;3972.993638212684;3998.6401223889407;4001.8399264029113;4008.6592639625374;3747.4940882980995;4190.497140343178;4468.620167285817;4495.64034877209;4501.9870529130685;4566.429196350457;5519.779208831602;5527.53015993645;5544.7227638618715;5551.25058117149;1230.4217018001525;1246.7568824079217;1284.4862055178003;1308.574713218208;1311.4295281552554;874.2830878679422;886.3795343259744;890.2388457868559;899.8875140607424;905.6558507767138;4335.82656693735;4593.805610541283;5092.10888094582;5098.311727916684;5132.307138536325;4638.930416043762;4679.789409476513;5341.958784366979;5636.746346414421;5681;3886.5530463997;4539.863804085882;4999.575036121898;5054.949450505448;5055.34280543527;2849.3731379096566;2951.4834903891733;2952.763778897683;2973.4647763402795;2974.3753811699353;4848.8302909398;5331.08081090807;5674.801381951612;5731.226284451545;5753.568482363839;5652.802151924663;5653.689047102449;5680.801171958961;5691.373948865621;5742.569307301969;5669.801556945487;5675.631083979528;5697.373288938214;5715.057015592381;5715.8571035724435;4667;5118.468256902725;5234.173546284964;5549;5616.6068375213345;5467.589930755289;5482.23248745168;5487;5493.917591236214;5521.040030789172;4625.912910466105;4727.739974301309;5164.1409092725835;5690.089585666274;5711.628744131618;3523.8723608445052;3764.153065560227;3848.499695039627;3849.4610754493833;3887.3002859485564;4759.23852183649;5484.875600501808;5739.139129130664;5750.367459579359;5764.884702306014;5344.465553444625;5574.386817450159;5576.91634625489;5594.888102238014;5615.034737841723;5431.456854314537;5486.753096110764;5517.337919449692;5536.667799932017;5543.417941116286;5136.357955255593;5317.1492561190025;5330.147176451749;5407.513323800877;5423.7830486780085;4671.976640116778;4881.926771098365;4957.82647607332;5239.318888544465;5368.550491367387;4676.602488788355;5395.3525576931015;5396.165303796728;5397.109476936262;5417.160340147283 19:47:10 INFO - PROCESS | 1661 | |5;yui.html;696.5437638346884;707.5047466773258;712.5617745086773;757.5946868425393;817.1664901800164;15349.46276880308;15652.686946261083;16074.919625401886;16089.83910160898;16110.677786444265;14738.115713057225;14870.47953321634;14894.702105957875;14898;14935.17856517891;665.7603262825379;678.4606238040744;683.0130461483159;685.3078390825277;815.8123631564758;645.6965226343611;645.8094862015716;812.8130529978108;834.678648720244;839.6515446089866;860.2859626509982;870.1124852650292;870.3081050564816;874.54960695242;876.837785009772;864.930805535562;866.7876370289256;866.969656062041;867.6269204242236;870.5603670146598;640.5548144039894;640.9294977552465;641.1216633212482;642.633698791689;643.2024289880561;11977.101717371144;12429.37853107341;14953.40186392543;15068.630097271778;15119.244037798177;13461.057725959186;13700.3834827432;14229.64425889361;14716.632084197981;15020.624484387869;11607.535698572046;11773.293602383885;11832.822507662391;11891.643250702493;12300.75398492034;3807.1433927366397;3811.7712937223855;3833.8274777635074;3866.497355343787;3894.2600905827803;119100;119756.40121799422;120765;123879.3806030973;124001.37999309946;10994.560217591206;11170.27393219438;11183.552657893593;11258.986691197668;11716.88283117175;23563.882180588986;23581.820908954483;23613.881930590236;23634;23649.645255321186;7830.686772529149;7963.8407231855035;8030.317423018992;8056.073551541531;8217.506949583045;3525.2024105139035;4296.2481565725875;4309.353596960418;4368.366586844953;4368.825246990148;3344.4816053511745;3456.861725531001;3457.844397002141;3463.7229021678204;3468.8092154931214;598.1536126381209;604.2235727090667;607.9057746049369;611.7767015039478;627.1815281058263;598.8892054969845;599.598269159664;630.9053641953743;666.3136968922018;677.2516369411827;8570.828583428422;9041.954790226138;9328.673496427593;9437.480938548308;9494.715158545254;467.2990514228657;589.8790747896671;642.6529673976094;669.2805234373069;678.4063944048958;3957.960420395817;4538.704984176018;4628.236341003764;4649.5216797117655;4690.366800481959;108051.45974270078;110890;128887.35556322159;151726.48273517346;155091.89816203612;37449.81275093662;37876.43185352222;113554;114225.42887285676;118171;75139.62430187814;82977.17022829695;85573.57213213894;85846;110825;9058.682946096855;9511.191548718436;9641.325107242426;10030.348027378197;10034.749131271778;58791.70604147123;59909.70045149746;61393;62996;63291.050634241445;78789;96079.03920960701;96761;98038.50980745051;98753;12802.807957880825;13041.478340866259;13152.802707959198;13285.468581256642;13466.461341546228;14397;14576.781348279572;14798.48205312809;14868.33092510818;15282.770758438855;13598.456061757419;13791.793123103362;13812.792808108088;13813.654658633615;14070.381906080931;12379.62861114168;13311.134776239513;13376.531821386205;13643.863561364657;13798.241096739775;13244.53644122451;13256.53602123921;13488.325583720578;13750.174989500661;13855.792163117763;10770.08454281395;11156.553737850396;11268.887311126784;11413.885861141282;11480.368579727861;10796;10876.293040952312;11205.159613028893;11461.140414469115;11474.254173478697 19:47:10 INFO - PROCESS | 1661 | __end_tp_report 19:47:10 INFO - PROCESS | 1661 | __start_cc_report 19:47:10 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1172 19:47:10 INFO - PROCESS | 1661 | __end_cc_report 19:47:10 INFO - PROCESS | 1661 | __startTimestamp1473734830695__endTimestamp 19:47:10 INFO - PROCESS | 1661 | 19:47:10 INFO - PROCESS | 1661 | ------- Summary: start ------- 19:47:10 INFO - PROCESS | 1661 | Number of tests: 6 19:47:10 INFO - PROCESS | 1661 | 19:47:10 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5785.49 Median:5965.94 stddev:638.10 (10.7%) stddev-sans-first:600.72 19:47:10 INFO - PROCESS | 1661 | Values: 2973.7 3322.9 3345.5 3391.3 3417.6 5639.2 5743.1 5749.7 5829.7 5874.7 5776.0 5802.2 5804.4 5811.8 5814.5 5238.7 5269.6 5291.9 5318.0 5355.8 5336.7 5345.5 5352.3 5353.5 5368.9 5240.9 5254.3 5296.4 5307.9 5348.3 5356.2 5370.3 5387.6 5392.3 5404.1 5106.2 5224.5 5229.8 5301.8 5316.5 5696.4 5802.3 5809.8 5811.4 5815.8 6232.6 6283.4 6284.5 6298.1 6300.1 6195.2 6197.9 6235.6 6247.6 6273.6 5788.6 5794.1 5860.9 5995.6 5996.7 6335.6 6341.4 6352.7 6365.2 6374.7 6114.3 6174.6 6227.8 6235.3 6245.5 6187.7 6209.9 6225.8 6236.3 6292.6 6226.0 6230.4 6232.2 6240.6 6245.5 6190.1 6250.9 6261.3 6269.1 6276.1 4940.9 4984.3 4995.1 5005.1 5045.6 4534.3 4538.7 4560.7 4563.8 4565.9 5779.7 5798.4 5800.5 5808.4 5809.8 6171.3 6171.7 6194.1 6228.3 6254.1 5739.9 5774.6 5782.6 5816.4 5820.4 5497.8 5503.6 5505.4 5507.6 5507.9 6181.8 6252.1 6380.5 6384.7 6387.3 6186.1 6208.8 6228.4 6237.5 6262.5 6328.3 6351.5 6361.2 6370.8 6379.1 6119.6 6249.2 6258.2 6262.5 6278.8 5167.8 6174.7 6185.2 6195.3 6249.1 6181.3 6204.3 6213.1 6214.8 6227.0 5701.9 6156.9 6167.7 6221.5 6232.6 5233.5 5878.7 5922.0 5944.9 5965.9 6118.4 6185.8 6190.5 6201.0 6205.7 4974.3 5918.8 5956.9 6100.5 6113.3 19:47:10 INFO - PROCESS | 1661 | 19:47:10 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:66347.81 Median:35717.29 stddev:146502.14 (410.2%) stddev-sans-first:146829.63 19:47:10 INFO - PROCESS | 1661 | Values: 474.2 492.7 516.0 518.6 525.5 27570.4 31055.0 31438.5 37844.6 38866.0 40245.0 40410.8 40524.0 40593.4 40600.4 9589.7 9749.6 9766.5 9774.3 9790.9 8585.4 8751.8 8761.8 8901.2 8907.8 8788.4 11788.5 11957.6 12104.9 12299.8 11932.2 11998.5 12012.8 12014.0 12015.2 11849.2 11947.8 11951.7 11971.9 12012.9 38529.2 38777.8 38824.2 38862.6 38881.8 3677.2 3978.7 4022.2 4062.3 4132.1 30637.1 30641.8 30653.8 30712.9 31024.7 3167.7 3283.0 3330.1 3346.3 3347.0 504190.0 506266.5 506294.0 506555.0 507964.0 55594.2 55703.0 55729.0 55960.4 56026.0 56982.9 56997.4 57051.0 57074.7 57143.0 15675.8 15829.8 15861.0 15880.4 15880.8 12384.5 12459.3 12464.6 12474.6 12495.4 12239.9 13410.3 13731.7 13746.3 14782.7 5533.4 6467.5 6672.7 6731.4 6758.3 838.2 897.2 923.6 943.9 976.5 28207.2 28823.0 28968.8 29255.1 29464.9 1025.6 1050.8 1060.9 1082.9 1083.9 14485.1 14789.2 14837.5 14949.0 15190.8 647460.0 653441.0 653564.0 653632.0 654842.0 47287.5 47483.8 52826.7 53358.0 53550.7 1345.3 1347.9 1355.9 1388.5 1392.8 25668.6 29689.9 30438.4 30741.1 30742.5 46537.5 47014.1 47039.0 47060.8 47094.3 427753.0 438443.0 438483.0 438668.0 572316.0 21329.6 24197.0 24366.1 24459.8 24496.3 42085.0 42246.6 42818.8 42930.4 43016.8 29745.7 35450.6 35452.8 35861.6 36603.3 35465.5 35769.9 36261.8 36535.5 36568.6 34669.8 35172.5 35204.0 35559.5 35664.6 27432.9 30725.4 31787.0 31828.7 31858.5 19346.1 22582.0 23969.4 24246.5 24273.8 19:47:10 INFO - PROCESS | 1661 | 19:47:10 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:33836.51 Median:2019.60 stddev:97651.98 (4835.2%) stddev-sans-first:97893.55 19:47:10 INFO - PROCESS | 1661 | Values: 349.1 367.6 371.4 378.8 397.4 14701.8 14781.6 15774.6 20331.5 20832.8 19385.6 19852.4 20457.6 20595.1 20709.5 5125.1 5884.5 6135.8 6147.8 6149.1 6010.4 6067.2 6129.1 6131.6 6162.4 5744.4 5965.9 6061.1 6073.6 6077.4 5957.5 6003.6 6009.4 6011.4 6018.7 4993.3 5210.2 5232.2 5259.1 5265.7 20524.5 23226.8 24015.4 24193.9 25385.6 2072.5 2507.9 2518.2 2584.3 2866.6 9767.7 9781.9 9822.4 10259.9 10312.8 1819.3 1840.2 1857.3 1872.7 1893.4 82727.0 109792.0 113270.0 113418.0 114089.0 11218.9 11251.7 11328.6 11377.0 11522.7 14360.3 14373.3 14414.9 14415.4 14422.0 6887.9 8235.5 8544.2 8616.7 8646.9 8405.7 8423.3 8432.0 8616.4 8619.6 3671.6 4454.8 4460.6 4490.1 4515.8 1849.0 1893.8 1894.8 1926.6 1938.6 641.8 693.8 729.0 793.7 929.7 21258.6 21812.0 21842.0 21950.8 22005.4 897.9 913.5 914.9 917.5 919.1 9265.7 10803.9 11096.4 11390.8 11400.4 577887.0 581448.0 587251.0 594941.0 595848.0 81606.6 109330.5 124132.4 125665.4 129385.0 861.8 938.4 959.3 970.3 971.6 19304.9 19568.9 19713.7 19718.3 19733.0 43069.3 52743.5 53522.5 53700.7 54674.2 67683.6 69859.3 83270.6 83295.2 85198.6 6068.8 7326.5 7328.2 7450.0 7532.4 10578.4 11665.6 12270.0 13158.0 13465.4 11218.7 11375.3 11503.4 11611.5 11630.8 11093.9 11168.9 11193.0 11620.1 11635.8 11192.0 11240.6 11459.3 11548.8 11815.4 7251.7 7413.8 7461.6 7584.7 7653.2 10401.2 11088.4 11204.3 11590.5 11601.9 19:47:10 INFO - PROCESS | 1661 | 19:47:10 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5730.49 Median:2637.26 stddev:3251.15 (123.3%) stddev-sans-first:3243.56 19:47:10 INFO - PROCESS | 1661 | Values: 1344.4 1505.8 1677.1 1804.1 1898.4 7860.7 7971.4 8240.5 8797.7 9032.0 8107.8 8530.3 8779.2 8784.2 8900.0 2364.3 2400.2 2403.5 2404.8 2409.0 2099.8 2365.0 2380.9 2409.8 2411.8 2161.2 2178.0 2319.3 2392.5 2402.8 2362.7 2375.8 2377.0 2377.8 2380.5 2334.7 2368.8 2374.7 2378.0 2378.6 8850.6 8883.0 8941.3 8978.1 9001.0 5241.8 5409.6 5412.7 5416.2 5419.5 3478.4 3579.0 3654.4 3728.2 3729.9 1077.0 1089.8 1092.2 1105.8 1113.2 9984.3 11748.1 11863.6 11889.0 11894.8 4548.0 4556.5 4754.6 4755.5 4796.5 10002.8 10021.5 10026.0 10036.4 10043.1 5371.7 5373.7 5379.4 5379.8 5382.9 4436.2 4912.5 4921.2 4927.5 4927.9 3776.9 3817.1 3833.9 3881.9 3914.3 1170.7 1172.2 1182.8 1183.3 1184.8 632.5 782.7 900.7 918.6 944.2 5917.3 5928.1 6024.6 6076.1 6080.1 461.3 478.0 487.4 491.4 629.2 3754.7 3971.7 4075.9 4106.3 4106.7 10539.4 11021.1 11024.8 11038.9 11049.8 10972.2 10981.5 10990.2 10997.3 11029.7 7095.0 7759.8 8025.8 8200.3 8303.5 5830.4 5864.7 6015.6 6077.2 6102.6 10174.7 10293.2 10337.1 10341.5 10370.9 9995.6 10309.8 10321.8 10484.2 10492.0 7506.2 7689.5 7695.3 7698.1 7708.8 8191.7 8201.1 8230.7 8335.5 8356.0 7397.6 7422.5 7443.9 7444.0 7548.5 6268.9 7329.5 7390.3 7498.1 7528.4 6986.9 7020.9 7034.5 7065.4 7073.5 4598.3 4943.4 4983.7 5027.1 5210.7 4997.3 5050.8 5095.9 5109.6 5300.0 19:47:10 INFO - PROCESS | 1661 | 19:47:10 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4411.97 Median:4978.70 stddev:1350.17 (27.1%) stddev-sans-first:1317.84 19:47:10 INFO - PROCESS | 1661 | Values: 278.8 279.0 296.7 312.6 314.3 5020.0 5114.8 5226.3 5242.7 5296.4 4252.8 4953.9 5087.5 5107.7 5123.0 3302.0 3635.0 3665.9 4044.6 4055.7 3419.6 3484.5 3538.4 3921.7 3980.4 3963.1 3993.2 4009.8 4009.8 4039.8 3113.7 3402.9 3858.7 4000.5 4010.2 2945.3 3444.4 3508.8 3515.0 3525.3 4530.6 4923.5 5008.2 5058.3 5117.8 4553.0 4565.2 4578.5 4581.5 4594.7 4520.3 5459.8 5461.3 5464.4 5470.7 3368.8 3371.8 3854.5 3857.0 3857.5 5076.9 5673.4 5683.4 5694.0 5729.8 3641.4 3884.2 3885.2 3894.6 3902.9 3793.9 3973.0 3998.6 4001.8 4008.7 3747.5 4190.5 4468.6 4495.6 4502.0 4566.4 5519.8 5527.5 5544.7 5551.3 1230.4 1246.8 1284.5 1308.6 1311.4 874.3 886.4 890.2 899.9 905.7 4335.8 4593.8 5092.1 5098.3 5132.3 4638.9 4679.8 5342.0 5636.7 5681.0 3886.6 4539.9 4999.6 5054.9 5055.3 2849.4 2951.5 2952.8 2973.5 2974.4 4848.8 5331.1 5674.8 5731.2 5753.6 5652.8 5653.7 5680.8 5691.4 5742.6 5669.8 5675.6 5697.4 5715.1 5715.9 4667.0 5118.5 5234.2 5549.0 5616.6 5467.6 5482.2 5487.0 5493.9 5521.0 4625.9 4727.7 5164.1 5690.1 5711.6 3523.9 3764.2 3848.5 3849.5 3887.3 4759.2 5484.9 5739.1 5750.4 5764.9 5344.5 5574.4 5576.9 5594.9 5615.0 5431.5 5486.8 5517.3 5536.7 5543.4 5136.4 5317.1 5330.1 5407.5 5423.8 4672.0 4881.9 4957.8 5239.3 5368.6 4676.6 5395.4 5396.2 5397.1 5417.2 19:47:10 INFO - PROCESS | 1661 | 19:47:10 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:22930.95 Median:3497.01 stddev:35693.28 (1020.7%) stddev-sans-first:35754.36 19:47:10 INFO - PROCESS | 1661 | Values: 696.5 707.5 712.6 757.6 817.2 15349.5 15652.7 16074.9 16089.8 16110.7 14738.1 14870.5 14894.7 14898.0 14935.2 665.8 678.5 683.0 685.3 815.8 645.7 645.8 812.8 834.7 839.7 860.3 870.1 870.3 874.5 876.8 864.9 866.8 867.0 867.6 870.6 640.6 640.9 641.1 642.6 643.2 11977.1 12429.4 14953.4 15068.6 15119.2 13461.1 13700.4 14229.6 14716.6 15020.6 11607.5 11773.3 11832.8 11891.6 12300.8 3807.1 3811.8 3833.8 3866.5 3894.3 119100.0 119756.4 120765.0 123879.4 124001.4 10994.6 11170.3 11183.6 11259.0 11716.9 23563.9 23581.8 23613.9 23634.0 23649.6 7830.7 7963.8 8030.3 8056.1 8217.5 3525.2 4296.2 4309.4 4368.4 4368.8 3344.5 3456.9 3457.8 3463.7 3468.8 598.2 604.2 607.9 611.8 627.2 598.9 599.6 630.9 666.3 677.3 8570.8 9042.0 9328.7 9437.5 9494.7 467.3 589.9 642.7 669.3 678.4 3958.0 4538.7 4628.2 4649.5 4690.4 108051.5 110890.0 128887.4 151726.5 155091.9 37449.8 37876.4 113554.0 114225.4 118171.0 75139.6 82977.2 85573.6 85846.0 110825.0 9058.7 9511.2 9641.3 10030.3 10034.7 58791.7 59909.7 61393.0 62996.0 63291.1 78789.0 96079.0 96761.0 98038.5 98753.0 12802.8 13041.5 13152.8 13285.5 13466.5 14397.0 14576.8 14798.5 14868.3 15282.8 13598.5 13791.8 13812.8 13813.7 14070.4 12379.6 13311.1 13376.5 13643.9 13798.2 13244.5 13256.5 13488.3 13750.2 13855.8 10770.1 11156.6 11268.9 11413.9 11480.4 10796.0 10876.3 11205.2 11461.1 11474.3 19:47:10 INFO - PROCESS | 1661 | -------- Summary: end -------- 19:47:10 INFO - PROCESS | 1661 | 19:47:11 INFO - TEST-INFO | 1661: exit 0 19:47:11 INFO - TEST-OK | dromaeo_css | took 1117095ms 19:47:11 INFO - TEST-START | kraken 19:47:11 INFO - operating with platform_type : mac_ 19:47:11 INFO - Initialising browser for kraken test... 19:47:11 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmpysdnVs/profile http://localhost:49280/getInfo.html) 19:47:13 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 19:47:13 INFO - PROCESS | 1668 | colorDepth:24 19:47:13 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 19:47:13 INFO - PROCESS | 1668 | __metrics 19:47:13 INFO - PROCESS | 1668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:47:13 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:47:14 INFO - TEST-INFO | 1668: exit 0 19:47:14 INFO - Browser initialized. 19:47:14 INFO - Running cycle 1/1 for kraken test... 19:47:14 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmpysdnVs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:47:26 INFO - PROCESS | 1669 | RSS: Main: 233938944 19:47:26 INFO - PROCESS | 1669 | 19:47:28 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 19:47:29 INFO - PROCESS | 1669 | RSS: Main: 294375424 19:47:29 INFO - PROCESS | 1669 | 19:47:32 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 19:47:32 INFO - PROCESS | 1669 | RSS: Main: 289792000 19:47:32 INFO - PROCESS | 1669 | 19:47:36 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 19:47:36 INFO - PROCESS | 1669 | RSS: Main: 377831424 19:47:36 INFO - PROCESS | 1669 | 19:47:38 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 19:47:39 INFO - PROCESS | 1669 | RSS: Main: 280170496 19:47:39 INFO - PROCESS | 1669 | 19:47:41 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:47:42 INFO - PROCESS | 1669 | RSS: Main: 285593600 19:47:42 INFO - PROCESS | 1669 | 19:47:44 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 19:47:45 INFO - PROCESS | 1669 | RSS: Main: 322760704 19:47:45 INFO - PROCESS | 1669 | 19:47:48 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 19:47:48 INFO - PROCESS | 1669 | RSS: Main: 321953792 19:47:48 INFO - PROCESS | 1669 | 19:47:51 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 19:47:52 INFO - PROCESS | 1669 | RSS: Main: 323444736 19:47:52 INFO - PROCESS | 1669 | 19:47:53 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:47:54 INFO - PROCESS | 1669 | RSS: Main: 298389504 19:47:54 INFO - PROCESS | 1669 | 19:47:56 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:47:56 INFO - PROCESS | 1669 | RSS: Main: 303955968 19:47:56 INFO - PROCESS | 1669 | 19:47:59 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:47:59 INFO - PROCESS | 1669 | RSS: Main: 307503104 19:47:59 INFO - PROCESS | 1669 | 19:48:02 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:48:03 INFO - PROCESS | 1669 | RSS: Main: 319393792 19:48:03 INFO - PROCESS | 1669 | 19:48:06 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:48:06 INFO - PROCESS | 1669 | RSS: Main: 315625472 19:48:06 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 19:48:08 INFO - PROCESS | 1669 | RSS: Main: 359518208 19:48:08 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | __start_tp_report 19:48:08 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 19:48:08 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 19:48:08 INFO - PROCESS | 1669 | |i|pagename|runs| 19:48:08 INFO - PROCESS | 1669 | |0;ai-astar;114;111;113;113;114;112;114;113;113;124 19:48:08 INFO - PROCESS | 1669 | |1;audio-beat-detection;149;111;128;160;107;128;128;102;154;108 19:48:08 INFO - PROCESS | 1669 | |2;audio-dft;185;184;183;182;184;184;181;182;180;184 19:48:08 INFO - PROCESS | 1669 | |3;audio-fft;75;75;76;151;58;57;57;65;142;57 19:48:08 INFO - PROCESS | 1669 | |4;audio-oscillator;82;83;132;70;78;76;114;68;69;118 19:48:08 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;89;86;89;86;89;86;89;86;89;86 19:48:08 INFO - PROCESS | 1669 | |6;imaging-darkroom;96;95;95;96;95;94;95;95;101;95 19:48:08 INFO - PROCESS | 1669 | |7;imaging-desaturate;85;86;83;86;85;84;87;84;81;86 19:48:08 INFO - PROCESS | 1669 | |8;json-parse-financial;56;55;56;55;55;52;53;54;54;56 19:48:08 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;63;65;71;71;72;74;69;68;69;69 19:48:08 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;85;84;88;83;88;85;84;89;86;85 19:48:08 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;137;136;134;138;136;139;139;136;181;157 19:48:08 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;168;169;169;167;168;168;166;168;169;166 19:48:08 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;66;66;68;69;67;66;66;66;66;67 19:48:08 INFO - PROCESS | 1669 | __end_tp_report 19:48:08 INFO - PROCESS | 1669 | __start_cc_report 19:48:08 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,2058 19:48:08 INFO - PROCESS | 1669 | __end_cc_report 19:48:08 INFO - PROCESS | 1669 | __startTimestamp1473734888763__endTimestamp 19:48:08 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | ------- Summary: start ------- 19:48:08 INFO - PROCESS | 1669 | Number of tests: 14 19:48:08 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:114.10 Median:113.50 stddev:3.60 (3.2%) stddev-sans-first:3.82 19:48:08 INFO - PROCESS | 1669 | Values: 114.0 111.0 113.0 113.0 114.0 112.0 114.0 113.0 113.0 124.0 19:48:08 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:128.00 stddev:20.94 (16.4%) stddev-sans-first:20.71 19:48:08 INFO - PROCESS | 1669 | Values: 149.0 111.0 128.0 160.0 107.0 128.0 128.0 102.0 154.0 108.0 19:48:08 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:182.90 Median:184.00 stddev:1.60 (0.9%) stddev-sans-first:1.50 19:48:08 INFO - PROCESS | 1669 | Values: 185.0 184.0 183.0 182.0 184.0 184.0 181.0 182.0 180.0 184.0 19:48:08 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:81.30 Median:61.50 stddev:35.32 (57.4%) stddev-sans-first:37.39 19:48:08 INFO - PROCESS | 1669 | Values: 75.0 75.0 76.0 151.0 58.0 57.0 57.0 65.0 142.0 57.0 19:48:08 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:73.00 stddev:23.31 (31.9%) stddev-sans-first:24.59 19:48:08 INFO - PROCESS | 1669 | Values: 82.0 83.0 132.0 70.0 78.0 76.0 114.0 68.0 69.0 118.0 19:48:08 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:89.00 stddev:1.58 (1.8%) stddev-sans-first:1.58 19:48:08 INFO - PROCESS | 1669 | Values: 89.0 86.0 89.0 86.0 89.0 86.0 89.0 86.0 89.0 86.0 19:48:08 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:95.00 stddev:1.95 (2.0%) stddev-sans-first:2.06 19:48:08 INFO - PROCESS | 1669 | Values: 96.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 101.0 95.0 19:48:08 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.50 stddev:1.77 (2.1%) stddev-sans-first:1.87 19:48:08 INFO - PROCESS | 1669 | Values: 85.0 86.0 83.0 86.0 85.0 84.0 87.0 84.0 81.0 86.0 19:48:08 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.35 (2.5%) stddev-sans-first:1.33 19:48:08 INFO - PROCESS | 1669 | Values: 56.0 55.0 56.0 55.0 55.0 52.0 53.0 54.0 54.0 56.0 19:48:08 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:70.00 stddev:3.25 (4.6%) stddev-sans-first:2.59 19:48:08 INFO - PROCESS | 1669 | Values: 63.0 65.0 71.0 71.0 72.0 74.0 69.0 68.0 69.0 69.0 19:48:08 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:2.00 (2.3%) stddev-sans-first:2.11 19:48:08 INFO - PROCESS | 1669 | Values: 85.0 84.0 88.0 83.0 88.0 85.0 84.0 89.0 86.0 85.0 19:48:08 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:138.50 stddev:14.76 (10.7%) stddev-sans-first:15.48 19:48:08 INFO - PROCESS | 1669 | Values: 137.0 136.0 134.0 138.0 136.0 139.0 139.0 136.0 181.0 157.0 19:48:08 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:168.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 19:48:08 INFO - PROCESS | 1669 | Values: 168.0 169.0 169.0 167.0 168.0 168.0 166.0 168.0 169.0 166.0 19:48:08 INFO - PROCESS | 1669 | 19:48:08 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:1.06 (1.6%) stddev-sans-first:1.09 19:48:08 INFO - PROCESS | 1669 | Values: 66.0 66.0 68.0 69.0 67.0 66.0 66.0 66.0 66.0 67.0 19:48:08 INFO - PROCESS | 1669 | -------- Summary: end -------- 19:48:08 INFO - PROCESS | 1669 | 19:48:09 INFO - TEST-INFO | 1669: exit 0 19:48:09 INFO - TEST-OK | kraken | took 58401ms 19:48:09 INFO - SUITE-END | took 1175s 19:48:09 INFO - Completed test suite (00:19:35) 19:48:09 INFO - javascript benchmark 19:48:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2973.7472314853235, 3322.9335413291733, 3345.514900339452, 3391.287829555793, 3417.555717756691, 5639.182318563806, 5743.138529220619, 5749.741261643226, 5829.679367634783, 5874.676892770896, 5776.0, 5802.187693722872, 5804.361520232771, 5811.82564523065, 5814.534837213013, 5238.659487133334, 5269.6311258211945, 5291.894162116774, 5317.989581979431, 5355.812546560871, 5336.653117547347, 5345.518903298703, 5352.304200453936, 5353.491418315273, 5368.946310536903, 5240.9213861792105, 5254.264402983586, 5296.390915044762, 5307.867303317429, 5348.251244825728, 5356.1697936819855, 5370.3287089113865, 5387.568994480472, 5392.299001129867, 5404.081306177959, 5106.183010718267, 5224.529792318672, 5229.764660590283, 5301.814436494743, 5316.4683531646915, 5696.430356964312, 5802.274715660543, 5809.82570522885, 5811.4479124483105, 5815.796447124372, 6232.594881332744, 6283.371662833726, 6284.465820405271, 6298.086777417248, 6300.117983482316, 6195.163652906845, 6197.907031394533, 6235.625862448268, 6247.562670613059, 6273.56085074045, 5788.594798364116, 5794.072948328289, 5860.853478663067, 5995.580309378389, 5996.730147143389, 6335.556511044183, 6341.397567231105, 6352.65060421672, 6365.172527571386, 6374.713137908712, 6114.2662880453745, 6174.567780255339, 6227.813165605039, 6235.282942461675, 6245.500359971283, 6187.721552530147, 6209.9379006210265, 6225.844353891099, 6236.314005459396, 6292.622442653364, 6226.0, 6230.43926046658, 6232.220972378453, 6240.563160578716, 6245.500359971192, 6190.102435146879, 6250.9062364064575, 6261.342559031327, 6269.059641053878, 6276.089966954766, 4940.851774446773, 4984.252362145708, 4995.050940321327, 5005.124103281911, 5045.596352291808, 4534.319852022223, 4538.659600529973, 4560.749158796298, 4563.817447302071, 4565.908681826345, 5779.653220806681, 5798.449147330997, 5800.477956983892, 5808.361080281165, 5809.767609295665, 6171.321154672983, 6171.660558669317, 6194.0708893665405, 6228.252609686776, 6254.061890716429, 5739.913901291484, 5774.595778295479, 5782.624129431573, 5816.360200377955, 5820.3888591698105, 5497.835064948058, 5503.587230957694, 5505.449455054542, 5507.614466987273, 5507.917381239285, 6181.752729890934, 6252.124702541557, 6380.489560835029, 6384.744610215539, 6387.329330420332, 6186.133941248138, 6208.813735587759, 6228.377162283736, 6237.469815065589, 6262.53031022666, 6328.303886572566, 6351.460125889351, 6361.236651601837, 6370.840728981812, 6379.075034120119, 6119.563485741731, 6249.218847644044, 6258.217722784652, 6262.46769024638, 6278.780242691484, 5167.844964651066, 6174.6912654368, 6185.226846644169, 6195.2875419325555, 6249.0626406039455, 6181.289151747606, 6204.317525072329, 6213.099100630293, 6214.844628884133, 6227.0, 5701.942980570141, 6156.938430615636, 6167.695781627886, 6221.502279817694, 6232.594881332699, 5233.528982391603, 5878.735456904364, 5921.970390148022, 5944.910826337695, 5965.938721485248, 6118.43644382056, 6185.84535386619, 6190.535709821871, 6201.0388389799655, 6205.689715514297, 4974.253861920741, 5918.822435326947, 5956.8808623828145, 6100.54245931548, 6113.29697084841], "value": 5744.467563239746, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.24831641847646, 492.71915008445154, 515.979360825567, 518.6214063733476, 525.5112745147014, 27570.44859102817, 31055.0, 31438.528422073687, 37844.62155378449, 38866.02834929128, 40245.0, 40410.7979460103, 40524.0, 40593.391099133536, 40600.390994135036, 9589.712308630735, 9749.561269742842, 9766.462844543546, 9774.31579789415, 9790.853137202948, 8585.399022068457, 8751.781205469882, 8761.7809554761, 8901.24339431146, 8907.821843563124, 8788.384813063089, 11788.528458861636, 11957.581484648039, 12104.939475302612, 12299.754004919896, 11932.16474846761, 11998.52005919762, 12012.759744805055, 12014.038876889828, 12015.158938874283, 11849.229800063054, 11947.761044779056, 11951.701207469883, 11971.880281197164, 12012.939935300268, 38529.22941541181, 38777.806110969264, 38824.223515529535, 38862.61137388618, 38881.80559097186, 3677.2461645362637, 3978.7214894957365, 4022.1754540319166, 4062.2687916175078, 4132.070284186064, 30637.080887573407, 30641.846790765903, 30653.846730766203, 30712.925047623226, 31024.689753102404, 3167.683231676837, 3283.0, 3330.0509354833757, 3346.330733853239, 3346.9832650836834, 504190.0, 506266.4686676543, 506294.0, 506555.0, 507963.99999999633, 55594.16608750872, 55703.0, 55729.0, 55960.44039559552, 56026.0, 56982.86034279291, 56997.430025699214, 57051.0, 57074.714626427434, 57143.0, 15675.764863527056, 15829.762553561706, 15861.04833709958, 15880.444184453489, 15880.841191587937, 12384.504619815287, 12459.314737689332, 12464.626061218178, 12474.625761227178, 12495.375231238402, 12239.938800305941, 13410.329483525784, 13731.656708582366, 13746.312684365741, 14782.704345913236, 5533.391326954032, 6467.450266727286, 6672.731271367758, 6731.360520750521, 6758.255482839645, 838.224642205957, 897.228383590112, 923.5797712041006, 943.9103285187896, 976.5263847034183, 28207.153785386472, 28823.0, 28968.80726635323, 29255.122346329645, 29464.852675736485, 1025.620520407454, 1050.8318669012922, 1060.8992145746142, 1082.9404382759024, 1083.9024487796137, 14485.058471199338, 14789.186594737394, 14837.480688176078, 14949.02831315961, 15190.772138417933, 647460.0, 653441.0, 653564.0, 653632.0, 654842.0, 47287.527124729, 47483.76258118756, 52826.73586632042, 53358.0, 53550.73224633852, 1345.260106941198, 1347.8989075819156, 1355.8847497962784, 1388.4862600837957, 1392.8119703840055, 25668.614970775827, 29689.851550742107, 30438.391232175676, 30741.077767667004, 30742.53886191664, 46537.534624654676, 47014.059718806115, 47038.99999999863, 47060.7646961763, 47094.293585596926, 427753.0, 438443.0, 438483.0, 438668.0, 572316.0, 21329.573408532055, 24197.032118715055, 24366.147184848443, 24459.75540244646, 24496.265112046665, 42085.0, 42246.57753422426, 42818.78590607027, 42930.35604465873, 43016.784916075216, 29745.70254297516, 35450.64549354473, 35452.822735886155, 35861.64138358583, 36603.26793464169, 35465.468017979234, 35769.92690219298, 36261.81869090743, 36535.45196822103, 36568.63431365652, 34669.826650866584, 35172.47241291332, 35204.0, 35559.46660800038, 35664.64335356717, 27432.862835685693, 30725.385492290476, 31787.0, 31828.681713183498, 31858.522122167724, 19346.088304410274, 22582.0, 23969.400764981016, 24246.51506969886, 24273.75726242715], "value": 19199.464145929658, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.12195827493844, 367.61951380321375, 371.4150213413872, 378.7992364047056, 397.3939741893612, 14701.779473307908, 14781.630459238511, 15774.605634859134, 20331.49171270719, 20832.791672083276, 19385.612287754237, 19852.40442786715, 20457.62449195881, 20595.07322170506, 20709.482262943435, 5125.1287281162295, 5884.499817515516, 6135.846603834895, 6147.846303842417, 6149.077638354238, 6010.36891126432, 6067.24159480065, 6129.080637904328, 6131.570790044699, 6162.352952939944, 5744.425557444264, 5965.910511342333, 6061.090836374557, 6073.605215660968, 6077.392260773931, 5957.510622344414, 6003.6397816131175, 6009.369016253296, 6011.428914253139, 6018.6990650467305, 4993.251012348141, 5210.244514545369, 5232.241325007891, 5259.079661059338, 5265.657732247391, 20524.486887827774, 23226.76773232263, 24015.399615009588, 24193.879030604734, 25385.61921571178, 2072.5025993761537, 2507.862067586282, 2518.2319392585255, 2584.2634849067927, 2866.5986761853355, 9767.658131965347, 9781.853272200922, 9822.361546499526, 10259.897401025968, 10312.845307320396, 1819.3177558415593, 1840.227104616051, 1857.2849452960572, 1872.691005984011, 1893.3846499887454, 82727.0, 109792.0, 113270.0, 113418.0, 114089.0, 11218.943905280421, 11251.662450126509, 11328.603498877499, 11377.0, 11522.711932201595, 14360.281985900663, 14373.281335933161, 14414.85585144135, 14415.351309191112, 14422.0, 6887.897936330163, 8235.464694794819, 8544.2310192083, 8616.655333786704, 8646.913530864611, 8405.747827565183, 8423.326133909273, 8432.04878292605, 8616.439931404439, 8619.61211745473, 3671.5777685565968, 4454.799534020977, 4460.643148548108, 4490.101979604027, 4515.841945531891, 1848.981510184881, 1893.7822150452598, 1894.8199921007483, 1926.5954149628735, 1938.6122775444967, 641.7657554992487, 693.7953303775398, 729.0194688144437, 793.6864041319488, 929.6699671616614, 21258.574828503344, 21812.0, 21842.0, 21950.780492195194, 22005.449863753533, 897.8653202019749, 913.4747520175792, 914.9176574108362, 917.5320586500933, 919.1451949686856, 9265.72202833916, 10803.891961080288, 11096.389698566494, 11390.772184556428, 11400.372979486208, 577887.0, 581448.0, 587251.0, 594941.0, 595848.0, 81606.551803446, 109330.45334773275, 124132.37933810274, 125665.37167314287, 129385.0, 861.8405594964952, 938.4088024544493, 959.3092973059386, 970.257752819094, 971.5676523946776, 19304.938228397572, 19568.90215548913, 19713.70429443531, 19718.309859154862, 19733.0, 43069.27722891175, 52743.472565273856, 53522.46477535175, 53700.73149634383, 54674.179887300925, 67683.61581920786, 69859.30140698732, 83270.58364708138, 83295.16704832875, 85198.57400712957, 6068.848278792889, 7326.450516211199, 7328.24122210655, 7450.0, 7532.359749421361, 10578.418186999788, 11665.59170429065, 12269.957053650183, 13158.0, 13465.39405726725, 11218.66344009681, 11375.31748095117, 11503.367314797766, 11611.5355385787, 11630.825537617111, 11093.889061109609, 11168.888311117109, 11193.0, 11620.128490363088, 11635.825462617899, 11192.0, 11240.606578769704, 11459.31244125355, 11548.769024619629, 11815.350155741173, 7251.709931602677, 7413.8146546336775, 7461.626918653937, 7584.658690358837, 7653.158152603098, 10401.219908507044, 11088.390138542458, 11204.271722338022, 11590.478428470908, 11601.883981160418], "value": 9333.170299832198, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.4017412251546, 1505.7590785474326, 1677.1195122560655, 1804.124999375302, 1898.3925143953923, 7860.702984007639, 7971.402144839131, 8240.546769927652, 8797.692080777175, 9032.006479287273, 8107.797305067376, 8530.274926631244, 8779.165979231979, 8784.1655042771, 8899.95550022249, 2364.2788949370433, 2400.243923164198, 2403.519296140779, 2404.759524047599, 2409.012304954969, 2099.7585277693033, 2364.9763502365013, 2380.8571485710827, 2409.8433601815827, 2411.7588241175918, 2161.200355868331, 2177.978220217801, 2319.2926157521947, 2392.497575509145, 2402.771736685012, 2362.7164740231196, 2375.7624237576106, 2376.9762302376926, 2377.8097752179956, 2380.4881950380664, 2334.684817549643, 2368.751281115475, 2374.7031621047367, 2377.9881100594384, 2378.6194208926663, 8850.557472126367, 8883.0, 8941.284697224206, 8978.057303983118, 9000.964889037714, 5241.816536421207, 5409.594280428983, 5412.675239485643, 5416.241726158341, 5419.5393391561765, 3478.3565040467593, 3579.0, 3654.4335627977707, 3728.1611637381643, 3729.9440508392395, 1076.9892301076968, 1089.7548051688386, 1092.202692034819, 1105.7622611138643, 1113.170687837558, 9984.25118116137, 11748.118891083202, 11863.58477453285, 11889.0, 11894.762104757856, 4547.954520454819, 4556.498785133633, 4754.595859351924, 4755.476897541337, 4796.544328288807, 10002.849957250646, 10021.498925053718, 10026.0, 10036.397816131055, 10043.146332561668, 5371.6508426952905, 5373.704446255493, 5379.35447746273, 5379.784808607612, 5382.892342153214, 4436.201483732959, 4912.459629440758, 4921.188003979303, 4927.457979622239, 4927.852164435073, 3776.8866933992026, 3817.1411432428035, 3833.923321533554, 3881.941770873439, 3914.256291304643, 1170.6780635325354, 1172.1853311948284, 1182.787098322293, 1183.3491579631168, 1184.8045072562932, 632.4845251120322, 782.7260458839474, 900.68499990014, 918.6233644205844, 944.187998321443, 5917.349091599921, 5928.140419639129, 6024.608400453956, 6076.149339092531, 6080.14877917092, 461.3126441601989, 477.9784909679073, 487.4345758919636, 491.39312948508564, 629.235478893147, 3754.699624030071, 3971.702122340836, 4075.8777236682945, 4106.322456794595, 4106.650934670586, 10539.367637941748, 11021.063209627111, 11024.779504409868, 11038.889611103947, 11049.834252486218, 10972.23194376402, 10981.450927453596, 10990.230683852213, 10997.285176463503, 11029.669109926715, 7095.0421693070775, 7759.758438649789, 8025.839483210303, 8200.302974247255, 8303.501789892625, 5830.416958304136, 5864.67744274052, 6015.639061656315, 6077.179580756718, 6102.603330783485, 10174.745631359276, 10293.228007899288, 10337.121344685786, 10341.534630941474, 10370.896291036994, 9995.550200241152, 10309.793804123725, 10321.793564128526, 10484.161267098767, 10492.0, 7506.211847756125, 7689.538627682357, 7695.307422332017, 7698.114716807639, 7708.768736937901, 8191.672333106847, 8201.13888041747, 8230.670773169006, 8335.458195217292, 8355.95822020886, 7397.593132377771, 7422.480426370103, 7443.925560744323, 7443.962780186064, 7548.5470871747875, 6268.874622507433, 7329.450291228286, 7390.29792169743, 7498.062742157231, 7528.397728181842, 6986.895196572157, 7020.946857971345, 7034.507584469243, 7065.434765218667, 7073.540219885691, 4598.26427771555, 4943.382077240345, 4983.6760610560195, 5027.095122877771, 5210.713410762444, 4997.300377947017, 5050.84847454577, 5095.92356114666, 5109.565686916654, 5299.973500132629], "value": 4521.172595329427, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.81598145224154, 278.9734975177358, 296.70922495953977, 312.5608520029358, 314.2693238221136, 5020.0, 5114.752132395927, 5226.320578324817, 5242.659227150232, 5296.443873393296, 4252.829886804532, 4953.900921981558, 5087.465816089313, 5107.668001579895, 5122.9508196721235, 3301.966980330196, 3634.963650363502, 3665.9450108248266, 4044.6450439102937, 4055.695822813286, 3419.606745224306, 3484.4947482615007, 3538.4161613333767, 3921.6862650987996, 3980.363141897297, 3963.128111815396, 3993.161436098408, 4009.7794621295816, 4009.819558119877, 4039.757614543122, 3113.6886311368908, 3402.897913062612, 3858.7105967052585, 4000.4999375078114, 4010.1779135277343, 2945.3078526546246, 3444.4488881778793, 3508.824558772051, 3514.9824250878837, 3525.3254704015644, 4530.569595888385, 4923.458419573844, 5008.24876268559, 5058.266551350071, 5117.769700363493, 4553.043860789238, 4565.2467342888385, 4578.51925547816, 4581.541845815425, 4594.701344412636, 4520.3219517072375, 5459.754311055973, 5461.344638643349, 5464.371597266286, 5470.699111548864, 3368.781029233092, 3371.8198630479383, 3854.479645247912, 3857.0164608024775, 3857.4792403025513, 5076.857707015929, 5673.375928647845, 5683.403242659502, 5693.971530142323, 5729.770809167629, 3641.362761516724, 3884.1649045455365, 3885.1646895916947, 3894.5910679378826, 3902.941455878164, 3793.905152371158, 3972.993638212684, 3998.6401223889407, 4001.8399264029113, 4008.6592639625374, 3747.4940882980995, 4190.497140343178, 4468.620167285817, 4495.64034877209, 4501.9870529130685, 4566.429196350457, 5519.779208831602, 5527.53015993645, 5544.7227638618715, 5551.25058117149, 1230.4217018001525, 1246.7568824079217, 1284.4862055178003, 1308.574713218208, 1311.4295281552554, 874.2830878679422, 886.3795343259744, 890.2388457868559, 899.8875140607424, 905.6558507767138, 4335.82656693735, 4593.805610541283, 5092.10888094582, 5098.311727916684, 5132.307138536325, 4638.930416043762, 4679.789409476513, 5341.958784366979, 5636.746346414421, 5681.0, 3886.5530463997, 4539.863804085882, 4999.575036121898, 5054.949450505448, 5055.34280543527, 2849.3731379096566, 2951.4834903891733, 2952.763778897683, 2973.4647763402795, 2974.3753811699353, 4848.8302909398, 5331.08081090807, 5674.801381951612, 5731.226284451545, 5753.568482363839, 5652.802151924663, 5653.689047102449, 5680.801171958961, 5691.373948865621, 5742.569307301969, 5669.801556945487, 5675.631083979528, 5697.373288938214, 5715.057015592381, 5715.8571035724435, 4667.0, 5118.468256902725, 5234.173546284964, 5549.0, 5616.6068375213345, 5467.589930755289, 5482.23248745168, 5487.0, 5493.917591236214, 5521.040030789172, 4625.912910466105, 4727.739974301309, 5164.1409092725835, 5690.089585666274, 5711.628744131618, 3523.8723608445052, 3764.153065560227, 3848.499695039627, 3849.4610754493833, 3887.3002859485564, 4759.23852183649, 5484.875600501808, 5739.139129130664, 5750.367459579359, 5764.884702306014, 5344.465553444625, 5574.386817450159, 5576.91634625489, 5594.888102238014, 5615.034737841723, 5431.456854314537, 5486.753096110764, 5517.337919449692, 5536.667799932017, 5543.417941116286, 5136.357955255593, 5317.1492561190025, 5330.147176451749, 5407.513323800877, 5423.7830486780085, 4671.976640116778, 4881.926771098365, 4957.82647607332, 5239.318888544465, 5368.550491367387, 4676.602488788355, 5395.3525576931015, 5396.165303796728, 5397.109476936262, 5417.160340147283], "value": 3983.2333468437296, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.5437638346884, 707.5047466773258, 712.5617745086773, 757.5946868425393, 817.1664901800164, 15349.46276880308, 15652.686946261083, 16074.919625401886, 16089.83910160898, 16110.677786444265, 14738.115713057225, 14870.47953321634, 14894.702105957875, 14898.0, 14935.17856517891, 665.7603262825379, 678.4606238040744, 683.0130461483159, 685.3078390825277, 815.8123631564758, 645.6965226343611, 645.8094862015716, 812.8130529978108, 834.678648720244, 839.6515446089866, 860.2859626509982, 870.1124852650292, 870.3081050564816, 874.54960695242, 876.837785009772, 864.930805535562, 866.7876370289256, 866.969656062041, 867.6269204242236, 870.5603670146598, 640.5548144039894, 640.9294977552465, 641.1216633212482, 642.633698791689, 643.2024289880561, 11977.101717371144, 12429.37853107341, 14953.40186392543, 15068.630097271778, 15119.244037798177, 13461.057725959186, 13700.3834827432, 14229.64425889361, 14716.632084197981, 15020.624484387869, 11607.535698572046, 11773.293602383885, 11832.822507662391, 11891.643250702493, 12300.75398492034, 3807.1433927366397, 3811.7712937223855, 3833.8274777635074, 3866.497355343787, 3894.2600905827803, 119100.0, 119756.40121799422, 120765.0, 123879.3806030973, 124001.37999309946, 10994.560217591206, 11170.27393219438, 11183.552657893593, 11258.986691197668, 11716.88283117175, 23563.882180588986, 23581.820908954483, 23613.881930590236, 23634.0, 23649.645255321186, 7830.686772529149, 7963.8407231855035, 8030.317423018992, 8056.073551541531, 8217.506949583045, 3525.2024105139035, 4296.2481565725875, 4309.353596960418, 4368.366586844953, 4368.825246990148, 3344.4816053511745, 3456.861725531001, 3457.844397002141, 3463.7229021678204, 3468.8092154931214, 598.1536126381209, 604.2235727090667, 607.9057746049369, 611.7767015039478, 627.1815281058263, 598.8892054969845, 599.598269159664, 630.9053641953743, 666.3136968922018, 677.2516369411827, 8570.828583428422, 9041.954790226138, 9328.673496427593, 9437.480938548308, 9494.715158545254, 467.2990514228657, 589.8790747896671, 642.6529673976094, 669.2805234373069, 678.4063944048958, 3957.960420395817, 4538.704984176018, 4628.236341003764, 4649.5216797117655, 4690.366800481959, 108051.45974270078, 110890.0, 128887.35556322159, 151726.48273517346, 155091.89816203612, 37449.81275093662, 37876.43185352222, 113554.0, 114225.42887285676, 118171.0, 75139.62430187814, 82977.17022829695, 85573.57213213894, 85846.0, 110825.0, 9058.682946096855, 9511.191548718436, 9641.325107242426, 10030.348027378197, 10034.749131271778, 58791.70604147123, 59909.70045149746, 61393.0, 62996.0, 63291.050634241445, 78789.0, 96079.03920960701, 96761.0, 98038.50980745051, 98753.0, 12802.807957880825, 13041.478340866259, 13152.802707959198, 13285.468581256642, 13466.461341546228, 14397.0, 14576.781348279572, 14798.48205312809, 14868.33092510818, 15282.770758438855, 13598.456061757419, 13791.793123103362, 13812.792808108088, 13813.654658633615, 14070.381906080931, 12379.62861114168, 13311.134776239513, 13376.531821386205, 13643.863561364657, 13798.241096739775, 13244.53644122451, 13256.53602123921, 13488.325583720578, 13750.174989500661, 13855.792163117763, 10770.08454281395, 11156.553737850396, 11268.887311126784, 11413.885861141282, 11480.368579727861, 10796.0, 10876.293040952312, 11205.159613028893, 11461.140414469115, 11474.254173478697], "value": 7587.913653952798, "unit": "score"}], "name": "dromaeo_css", "value": 7211.692036803284, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 113.0, 113.0, 114.0, 112.0, 114.0, 113.0, 113.0, 124.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 111.0, 128.0, 160.0, 107.0, 128.0, 128.0, 102.0, 154.0, 108.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 183.0, 182.0, 184.0, 184.0, 181.0, 182.0, 180.0, 184.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 151.0, 58.0, 57.0, 57.0, 65.0, 142.0, 57.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 132.0, 70.0, 78.0, 76.0, 114.0, 68.0, 69.0, 118.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 86.0, 89.0, 86.0, 89.0, 86.0, 89.0, 86.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 101.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 83.0, 86.0, 85.0, 84.0, 87.0, 84.0, 81.0, 86.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 55.0, 55.0, 52.0, 53.0, 54.0, 54.0, 56.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 71.0, 71.0, 72.0, 74.0, 69.0, 68.0, 69.0, 69.0], "value": 69.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 88.0, 83.0, 88.0, 85.0, 84.0, 89.0, 86.0, 85.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 134.0, 138.0, 136.0, 139.0, 139.0, 136.0, 181.0, 157.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 169.0, 167.0, 168.0, 168.0, 166.0, 168.0, 169.0, 166.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 69.0, 67.0, 66.0, 66.0, 66.0, 66.0, 67.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1449.9, "alertThreshold": 2.0}]} 19:48:09 INFO - Return code: 0 19:48:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:48:10 INFO - # TBPL SUCCESS # 19:48:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:48:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:48:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:48:10 INFO - 2016-09-12 19:48:10.079 screenresolution[1673:9904] starting screenresolution argv=screenresolution get 19:48:10 INFO - 2016-09-12 19:48:10.081 screenresolution[1673:9904] Display 0: 1600x1200x32@60 19:48:10 INFO - 2016-09-12 19:48:10.087 screenresolution[1674:9907] starting screenresolution argv=screenresolution list 19:48:10 INFO - Available Modes on Display 0 19:48:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:48:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:48:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:48:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:48:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:48:10 INFO - Intel Iris: 19:48:10 INFO - Chipset Model: Intel Iris 19:48:10 INFO - Type: GPU 19:48:10 INFO - Bus: Built-In 19:48:10 INFO - VRAM (Dynamic, Max): 1536 MB 19:48:10 INFO - Vendor: Intel (0x8086) 19:48:10 INFO - Device ID: 0x0a2e 19:48:10 INFO - Revision ID: 0x0009 19:48:10 INFO - Displays: 19:48:10 INFO - Display: 19:48:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:48:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:48:10 INFO - Display Serial Number: 1600x1200 60 19:48:10 INFO - Main Display: Yes 19:48:10 INFO - Mirror: Off 19:48:10 INFO - Online: Yes 19:48:10 INFO - Rotation: Supported 19:48:10 INFO - Return code: 0 19:48:10 INFO - Running post-action listener: _resource_record_post_action 19:48:10 INFO - [mozharness: 2016-09-13 02:48:10.329751Z] Finished run-tests step (success) 19:48:10 INFO - Running post-run listener: _resource_record_post_run 19:48:10 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 31964160; Write bytes: 703414272; Read time: 203; Write time: 2041 19:48:10 INFO - TinderboxPrint: CPU usage
53.4% 19:48:10 INFO - TinderboxPrint: I/O read bytes / time
31,964,160 / 203 19:48:10 INFO - TinderboxPrint: I/O write bytes / time
703,414,272 / 2,041 19:48:10 INFO - TinderboxPrint: CPU idle
2,257.4 (46.6%) 19:48:10 INFO - TinderboxPrint: CPU system
965.4 (19.9%) 19:48:10 INFO - TinderboxPrint: CPU user
1,618.9 (33.4%) 19:48:10 INFO - TinderboxPrint: Swap in / out
432,566,272 / 0 19:48:10 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 393361920; Write bytes: 389334528; Read time: 29299; Write time: 840 19:48:10 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 30170112; Write bytes: 293235200; Read time: 186; Write time: 1146 19:48:10 INFO - Running post-run listener: _upload_blobber_files 19:48:10 INFO - Blob upload gear active. 19:48:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:48:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:48:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:48:11 INFO - (blobuploader) - INFO - Open directory for files ... 19:48:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:48:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:48:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:12 INFO - (blobuploader) - INFO - Done attempting. 19:48:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:48:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:48:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:13 INFO - (blobuploader) - INFO - Done attempting. 19:48:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:48:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:48:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:16 INFO - (blobuploader) - INFO - Done attempting. 19:48:16 INFO - (blobuploader) - INFO - Iteration through files over. 19:48:16 INFO - Return code: 0 19:48:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:48:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:48:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58e214ffc7a982914f0f3411698c226a5849939a4ecbade8cfdf3c9b837e51ed5812246dd8b8af92752655a2c29072bc8c836c897e8e806e8f91df7940f1ed74", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c794d8f63a56d98e7bab5791d085d1be6e97cbea0f806265b506dbab1d3afd4589e77a6a72894480c6919e63e4ddccbe1687a1e5bf6838a7d85aa82dbba6e4b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f4d183d6ab57b2ca4cf7468411d30e677504a0eaf7b0011ec695b64810a6f269cb36345d15ea874fa9f26459919decd96dee6a39ecc96a236b8a6df4dc7f46"} 19:48:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:48:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:48:16 INFO - Contents: 19:48:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58e214ffc7a982914f0f3411698c226a5849939a4ecbade8cfdf3c9b837e51ed5812246dd8b8af92752655a2c29072bc8c836c897e8e806e8f91df7940f1ed74", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c794d8f63a56d98e7bab5791d085d1be6e97cbea0f806265b506dbab1d3afd4589e77a6a72894480c6919e63e4ddccbe1687a1e5bf6838a7d85aa82dbba6e4b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f4d183d6ab57b2ca4cf7468411d30e677504a0eaf7b0011ec695b64810a6f269cb36345d15ea874fa9f26459919decd96dee6a39ecc96a236b8a6df4dc7f46"} 19:48:16 INFO - Running post-run listener: copy_logs_to_upload_dir 19:48:16 INFO - Copying logs to upload dir... 19:48:16 INFO - mkdir: /builds/slave/test/build/upload/logs 19:48:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1334.951061 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2016-09-12 19:48:16.179107) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-12 19:48:16.182778) ========= 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.ozxh5TTvCx/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.UADzV5W6pj/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58e214ffc7a982914f0f3411698c226a5849939a4ecbade8cfdf3c9b837e51ed5812246dd8b8af92752655a2c29072bc8c836c897e8e806e8f91df7940f1ed74", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c794d8f63a56d98e7bab5791d085d1be6e97cbea0f806265b506dbab1d3afd4589e77a6a72894480c6919e63e4ddccbe1687a1e5bf6838a7d85aa82dbba6e4b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f4d183d6ab57b2ca4cf7468411d30e677504a0eaf7b0011ec695b64810a6f269cb36345d15ea874fa9f26459919decd96dee6a39ecc96a236b8a6df4dc7f46"} build_url:https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010473 build_url: 'https://queue.taskcluster.net/v1/task/c-xUpIT7Qg2_IrnIHzFOqQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58e214ffc7a982914f0f3411698c226a5849939a4ecbade8cfdf3c9b837e51ed5812246dd8b8af92752655a2c29072bc8c836c897e8e806e8f91df7940f1ed74", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c794d8f63a56d98e7bab5791d085d1be6e97cbea0f806265b506dbab1d3afd4589e77a6a72894480c6919e63e4ddccbe1687a1e5bf6838a7d85aa82dbba6e4b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08f4d183d6ab57b2ca4cf7468411d30e677504a0eaf7b0011ec695b64810a6f269cb36345d15ea874fa9f26459919decd96dee6a39ecc96a236b8a6df4dc7f46"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-12 19:48:16.219089) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 19:48:16.219462) ========= 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.ozxh5TTvCx/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.UADzV5W6pj/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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.005057 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 19:48:16.268300) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-12 19:48:16.268630) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-12 19:48:16.268940) ========= ========= Total master_lag: 0.76 =========