builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0263 starttime: 1485520475.79 results: success (0) buildid: 20170127030206 builduid: 921ac3e293de42ecb53103bae469b5b3 revision: 8dbe8993536645eceeeaf8cb6fc53c03602d7c84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 04:34:35.790900) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 04:34:35.791315) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 04:34:35.791606) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 04:34:35.815685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 04:34:35.815967) ========= 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.SgHYSBQLX0/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.ay6OGrePVs/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 --2017-01-27 04:34:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2017-01-27 04:34:35 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093183 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 04:34:35.933550) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 04:34:35.933867) ========= 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.SgHYSBQLX0/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.ay6OGrePVs/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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.020230 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 04:34:35.982440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 04:34:35.982799) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8dbe8993536645eceeeaf8cb6fc53c03602d7c84 --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 8dbe8993536645eceeeaf8cb6fc53c03602d7c84 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SgHYSBQLX0/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.ay6OGrePVs/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 2017-01-27 04:34:36,079 truncating revision to first 12 chars 2017-01-27 04:34:36,079 Setting DEBUG logging. 2017-01-27 04:34:36,079 attempt 1/10 2017-01-27 04:34:36,080 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8dbe89935366?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-27 04:34:36,738 unpacking tar archive at: mozilla-central-8dbe89935366/testing/mozharness/ program finished with exit code 0 elapsedTime=0.922504 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 04:34:36.928603) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 04:34:36.928929) ========= script_repo_revision: 8dbe8993536645eceeeaf8cb6fc53c03602d7c84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 04:34:36.929315) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 04:34:36.929597) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 04:34:36.949023) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-27 04:34:36.949440) ========= /tools/buildbot/bin/python -u 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', '-u', '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.SgHYSBQLX0/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.ay6OGrePVs/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:34:37 INFO - MultiFileLogger online at 20170127 04:34:37 in /builds/slave/test 04:34:37 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 04:34:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:34:37 INFO - {'append_to_log': False, 04:34:37 INFO - 'base_work_dir': '/builds/slave/test', 04:34:37 INFO - 'blob_upload_branch': 'Firefox', 04:34:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:34:37 INFO - 'branch': 'Firefox', 04:34:37 INFO - 'buildbot_json_path': 'buildprops.json', 04:34:37 INFO - 'config_files': ('talos/mac_config.py',), 04:34:37 INFO - 'default_actions': ('clobber', 04:34:37 INFO - 'read-buildbot-config', 04:34:37 INFO - 'download-and-extract', 04:34:37 INFO - 'populate-webroot', 04:34:37 INFO - 'create-virtualenv', 04:34:37 INFO - 'install', 04:34:37 INFO - 'run-tests'), 04:34:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:34:37 INFO - 'download_minidump_stackwalk': True, 04:34:37 INFO - 'download_symbols': 'ondemand', 04:34:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:34:37 INFO - 'tooltool.py': '/tools/tooltool.py', 04:34:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:34:37 INFO - '/tools/misc-python/virtualenv.py')}, 04:34:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:34:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:34:37 INFO - 'installer_path': 'installer.exe', 04:34:37 INFO - 'log_level': 'info', 04:34:37 INFO - 'log_name': 'talos', 04:34:37 INFO - 'log_to_console': True, 04:34:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:34:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:34:37 INFO - 'opt_config_files': (), 04:34:37 INFO - 'pip_index': False, 04:34:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:34:37 INFO - 'cmd': ('bash', 04:34:37 INFO - '-c', 04:34:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:34:37 INFO - 'enabled': True, 04:34:37 INFO - 'halt_on_failure': False, 04:34:37 INFO - 'name': 'check_screen_resolution'},), 04:34:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:34:37 INFO - 'cmd': ('bash', 04:34:37 INFO - '-c', 04:34:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:34:37 INFO - 'enabled': True, 04:34:37 INFO - 'halt_on_failure': False, 04:34:37 INFO - 'name': 'check_screen_resolution'},), 04:34:37 INFO - 'run_cmd_checks_enabled': True, 04:34:37 INFO - 'sps_profile': False, 04:34:37 INFO - 'sps_profile_interval': 0, 04:34:37 INFO - 'suite': 'dromaeojs', 04:34:37 INFO - 'system_bits': '32', 04:34:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:34:37 INFO - 'title': 't-yosemite-r7-0263', 04:34:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:34:37 INFO - 'use_talos_json': True, 04:34:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:34:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:34:37 INFO - 'work_dir': 'build'} 04:34:37 INFO - [mozharness: 2017-01-27 12:34:37.163971Z] Running clobber step. 04:34:37 INFO - Running pre-action listener: _resource_record_pre_action 04:34:37 INFO - Running main action method: clobber 04:34:37 INFO - rmtree: /builds/slave/test/build 04:34:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:34:38 INFO - Running post-action listener: _resource_record_post_action 04:34:38 INFO - [mozharness: 2017-01-27 12:34:38.062440Z] Finished clobber step (success) 04:34:38 INFO - [mozharness: 2017-01-27 12:34:38.062562Z] Running read-buildbot-config step. 04:34:38 INFO - Running pre-action listener: _resource_record_pre_action 04:34:38 INFO - Running main action method: read_buildbot_config 04:34:38 INFO - Using buildbot properties: 04:34:38 INFO - { 04:34:38 INFO - "project": "", 04:34:38 INFO - "product": "firefox", 04:34:38 INFO - "script_repo_revision": "production", 04:34:38 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:34:38 INFO - "repository": "", 04:34:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:34:38 INFO - "buildid": "20170127030206", 04:34:38 INFO - "stage_platform": "macosx64", 04:34:38 INFO - "basedir": "/builds/slave/test", 04:34:38 INFO - "nightly_build": "True", 04:34:38 INFO - "buildnumber": 38, 04:34:38 INFO - "slavename": "t-yosemite-r7-0263", 04:34:38 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:34:38 INFO - "platform": "yosemite_r7", 04:34:38 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:34:38 INFO - "branch": "mozilla-central", 04:34:38 INFO - "repo_path": "mozilla-central", 04:34:38 INFO - "revision": "8dbe8993536645eceeeaf8cb6fc53c03602d7c84", 04:34:38 INFO - "pgo_build": "False", 04:34:38 INFO - "builduid": "921ac3e293de42ecb53103bae469b5b3", 04:34:38 INFO - "slavebuilddir": "test" 04:34:38 INFO - } 04:34:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:34:38 INFO - Running post-action listener: _resource_record_post_action 04:34:38 INFO - [mozharness: 2017-01-27 12:34:38.065980Z] Finished read-buildbot-config step (success) 04:34:38 INFO - [mozharness: 2017-01-27 12:34:38.066069Z] Running download-and-extract step. 04:34:38 INFO - Running pre-action listener: _resource_record_pre_action 04:34:38 INFO - Running main action method: download_and_extract 04:34:38 INFO - mkdir: /builds/slave/test/build/tests 04:34:38 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')]} 04:34:38 INFO - trying https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:34:38 INFO - Downloading https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:34:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:34:39 INFO - Downloaded 1199 bytes. 04:34:39 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:34:39 INFO - Using the following test package requirements: 04:34:39 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:34:39 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:34:39 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:34:39 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:34:39 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:34:39 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:34:39 INFO - u'jsshell-mac.zip'], 04:34:39 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:34:39 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:34:39 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:34:39 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:34:39 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:34:39 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:34:39 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:34:39 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:34:39 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:34:39 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:34:39 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:34:39 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:34:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:34:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:34:39 INFO - Fetch https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:34:40 INFO - Expected file size: 16363418 04:34:40 INFO - Obtained file size: 16363418 04:34:46 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:34:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:34:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:34:46 INFO - Fetch https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:34:47 INFO - Expected file size: 16363418 04:34:47 INFO - Obtained file size: 16363418 04:34:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:34:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:34:53 INFO - Fetch https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:34:54 INFO - Expected file size: 14403466 04:34:54 INFO - Obtained file size: 14403466 04:34:55 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')]} 04:34:55 INFO - trying https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:34:55 INFO - Downloading https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:34:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:34:57 INFO - Downloaded 70192110 bytes. 04:34:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:34:57 INFO - mkdir: /builds/slave/test/properties 04:34:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:34:57 INFO - Writing to file /builds/slave/test/properties/build_url 04:34:57 INFO - Contents: 04:34:57 INFO - build_url:https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:34:57 INFO - Running post-action listener: _resource_record_post_action 04:34:57 INFO - Running post-action listener: set_extra_try_arguments 04:34:57 INFO - [mozharness: 2017-01-27 12:34:57.874204Z] Finished download-and-extract step (success) 04:34:57 INFO - [mozharness: 2017-01-27 12:34:57.874356Z] Running populate-webroot step. 04:34:57 INFO - Running pre-action listener: _resource_record_pre_action 04:34:57 INFO - Running main action method: populate_webroot 04:34:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:34:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:34:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:34:57 INFO - '--tppagecycles', 04:34:57 INFO - '7'], 04:34:57 INFO - 'tests': ['tsvgm']}}, 04:34:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:34:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:34:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:34:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:34:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:34:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:34:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:34:57 INFO - 'talos_options': ['--disable-e10s'], 04:34:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:34:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:34:57 INFO - 'talos_options': ['--disable-e10s'], 04:34:57 INFO - 'tests': ['damp', 'tps']}, 04:34:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:34:57 INFO - 'tests': ['damp', 'tps']}, 04:34:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:34:57 INFO - 'tests': ['dromaeo_dom']}, 04:34:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:34:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:34:57 INFO - 'tests': ['basic_compositor_video']}, 04:34:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:34:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:34:57 INFO - 'tests': ['a11yr', 04:34:57 INFO - 'ts_paint', 04:34:57 INFO - 'tpaint', 04:34:57 INFO - 'sessionrestore', 04:34:57 INFO - 'sessionrestore_no_auto_restore', 04:34:57 INFO - 'tabpaint']}, 04:34:57 INFO - 'other-e10s': {'tests': ['a11yr', 04:34:57 INFO - 'ts_paint', 04:34:57 INFO - 'tpaint', 04:34:57 INFO - 'sessionrestore', 04:34:57 INFO - 'sessionrestore_no_auto_restore', 04:34:57 INFO - 'tabpaint']}, 04:34:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:34:57 INFO - 'ts_paint', 04:34:57 INFO - 'tpaint', 04:34:57 INFO - 'sessionrestore', 04:34:57 INFO - 'sessionrestore_no_auto_restore', 04:34:57 INFO - 'tabpaint']}, 04:34:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:34:57 INFO - 'ts_paint', 04:34:57 INFO - 'tpaint', 04:34:57 INFO - 'sessionrestore', 04:34:57 INFO - 'sessionrestore_no_auto_restore', 04:34:57 INFO - 'tabpaint']}, 04:34:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:34:57 INFO - 'tests': ['a11yr', 04:34:57 INFO - 'ts_paint', 04:34:57 INFO - 'tpaint', 04:34:57 INFO - 'sessionrestore', 04:34:57 INFO - 'sessionrestore_no_auto_restore', 04:34:57 INFO - 'tabpaint']}, 04:34:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:34:57 INFO - 'tests': ['a11yr', 04:34:57 INFO - 'ts_paint', 04:34:57 INFO - 'tpaint', 04:34:57 INFO - 'sessionrestore', 04:34:57 INFO - 'sessionrestore_no_auto_restore', 04:34:57 INFO - 'tabpaint']}, 04:34:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:34:57 INFO - 'tests': ['tsvgx', 04:34:57 INFO - 'tsvgr_opacity', 04:34:57 INFO - 'tart', 04:34:57 INFO - 'tscrollx', 04:34:57 INFO - 'cart', 04:34:57 INFO - 'tsvg_static']}, 04:34:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:34:57 INFO - 'tsvgr_opacity', 04:34:57 INFO - 'tart', 04:34:57 INFO - 'tscrollx', 04:34:57 INFO - 'cart', 04:34:57 INFO - 'tsvg_static']}, 04:34:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:34:57 INFO - 'talos_options': ['--disable-e10s'], 04:34:57 INFO - 'tests': ['tp5o']}, 04:34:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:34:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:34:57 INFO - 'talos_options': ['--disable-e10s', 04:34:57 INFO - '--xperf_path', 04:34:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:57 INFO - 'tests': ['tp5n']}, 04:34:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:34:57 INFO - 'talos_options': ['--xperf_path', 04:34:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:57 INFO - 'tests': ['tp5n']}}, 04:34:57 INFO - 'talos.zip': {'path': '', 04:34:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:34:57 INFO - Running post-action listener: _resource_record_post_action 04:34:57 INFO - [mozharness: 2017-01-27 12:34:57.892954Z] Finished populate-webroot step (success) 04:34:57 INFO - [mozharness: 2017-01-27 12:34:57.893089Z] Running create-virtualenv step. 04:34:57 INFO - Running pre-action listener: _resource_record_pre_action 04:34:57 INFO - Running main action method: create_virtualenv 04:34:57 INFO - Creating virtualenv /builds/slave/test/build/venv 04:34:57 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 04:34:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:34:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:34:58 INFO - Using real prefix '/tools/python27' 04:34:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:34:58 INFO - Installing distribute.............................................................................................................................................................................................done. 04:35:01 INFO - Installing pip.................done. 04:35:01 INFO - Return code: 0 04:35:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:35:01 INFO - Reading from file tmpfile_stdout 04:35:01 INFO - Output received: 04:35:01 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:35:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:01 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 0x1017fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828bc9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9d30>, '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 0x101500db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015cebe8>, '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.SgHYSBQLX0/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.ay6OGrePVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:35:01 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 04:35:01 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 04:35:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgHYSBQLX0/Render', 04:35:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:01 INFO - 'HOME': '/Users/cltbld', 04:35:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:01 INFO - 'LOGNAME': 'cltbld', 04:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:01 INFO - 'MOZ_NO_REMOTE': '1', 04:35:01 INFO - 'NO_EM_RESTART': '1', 04:35:01 INFO - 'PAGER': '/bin/cat', 04:35:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:01 INFO - 'PWD': '/builds/slave/test', 04:35:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:01 INFO - 'SHELL': '/bin/bash', 04:35:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ay6OGrePVs/Listeners', 04:35:01 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:35:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:01 INFO - 'USER': 'cltbld', 04:35:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:01 INFO - 'XPC_FLAGS': '0x0', 04:35:01 INFO - 'XPC_SERVICE_NAME': '0', 04:35:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:02 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 04:35:02 INFO - Cleaning up... 04:35:02 INFO - Return code: 0 04:35:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1017fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828bc9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9d30>, '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 0x101500db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015cebe8>, '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.SgHYSBQLX0/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.ay6OGrePVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:35:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgHYSBQLX0/Render', 04:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:02 INFO - 'HOME': '/Users/cltbld', 04:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:02 INFO - 'LOGNAME': 'cltbld', 04:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:02 INFO - 'MOZ_NO_REMOTE': '1', 04:35:02 INFO - 'NO_EM_RESTART': '1', 04:35:02 INFO - 'PAGER': '/bin/cat', 04:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:02 INFO - 'PWD': '/builds/slave/test', 04:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:02 INFO - 'SHELL': '/bin/bash', 04:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ay6OGrePVs/Listeners', 04:35:02 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:02 INFO - 'USER': 'cltbld', 04:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:02 INFO - 'XPC_FLAGS': '0x0', 04:35:02 INFO - 'XPC_SERVICE_NAME': '0', 04:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:02 INFO - Downloading/unpacking psutil>=3.1.1 04:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:35:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:05 INFO - Installing collected packages: psutil 04:35:05 INFO - Running setup.py install for psutil 04:35:06 INFO - building 'psutil._psutil_osx' extension 04:35:06 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 04:35:06 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 04:35:06 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 04:35:06 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 04:35:06 INFO - building 'psutil._psutil_posix' extension 04:35:06 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 04:35:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:35:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:35:06 INFO - ^ 04:35:06 INFO - 1 warning generated. 04:35:06 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 04:35:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:06 INFO - Successfully installed psutil 04:35:06 INFO - Cleaning up... 04:35:06 INFO - Return code: 0 04:35:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828bc9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9d30>, '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 0x101500db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015cebe8>, '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.SgHYSBQLX0/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.ay6OGrePVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:35:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:35:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgHYSBQLX0/Render', 04:35:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:06 INFO - 'HOME': '/Users/cltbld', 04:35:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:06 INFO - 'LOGNAME': 'cltbld', 04:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:06 INFO - 'MOZ_NO_REMOTE': '1', 04:35:06 INFO - 'NO_EM_RESTART': '1', 04:35:06 INFO - 'PAGER': '/bin/cat', 04:35:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:06 INFO - 'PWD': '/builds/slave/test', 04:35:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:06 INFO - 'SHELL': '/bin/bash', 04:35:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ay6OGrePVs/Listeners', 04:35:06 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:35:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:06 INFO - 'USER': 'cltbld', 04:35:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:06 INFO - 'XPC_FLAGS': '0x0', 04:35:06 INFO - 'XPC_SERVICE_NAME': '0', 04:35:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:35:07 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 04:35:07 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 04:35:07 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 04:35:07 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 04:35:07 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 04:35:07 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 04:35:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:35:09 INFO - Installing collected packages: mozsystemmonitor 04:35:09 INFO - Running setup.py install for mozsystemmonitor 04:35:09 INFO - Successfully installed mozsystemmonitor 04:35:09 INFO - Cleaning up... 04:35:10 INFO - Return code: 0 04:35:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:10 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 0x1017fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828bc9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9d30>, '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 0x101500db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015cebe8>, '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.SgHYSBQLX0/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.ay6OGrePVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:35:10 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 04:35:10 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 04:35:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgHYSBQLX0/Render', 04:35:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:10 INFO - 'HOME': '/Users/cltbld', 04:35:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:10 INFO - 'LOGNAME': 'cltbld', 04:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:10 INFO - 'MOZ_NO_REMOTE': '1', 04:35:10 INFO - 'NO_EM_RESTART': '1', 04:35:10 INFO - 'PAGER': '/bin/cat', 04:35:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:10 INFO - 'PWD': '/builds/slave/test', 04:35:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:10 INFO - 'SHELL': '/bin/bash', 04:35:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ay6OGrePVs/Listeners', 04:35:10 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:35:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:10 INFO - 'USER': 'cltbld', 04:35:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:10 INFO - 'XPC_FLAGS': '0x0', 04:35:10 INFO - 'XPC_SERVICE_NAME': '0', 04:35:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:10 INFO - Downloading/unpacking jsonschema==2.5.1 04:35:10 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 04:35:10 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 04:35:10 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 04:35:10 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 04:35:10 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 04:35:10 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 04:35:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:35:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:35:12 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 04:35:12 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 04:35:12 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 04:35:12 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 04:35:12 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 04:35:12 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 04:35:13 INFO - Downloading functools32-3.2.3-2.tar.gz 04:35:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:35:13 INFO - warning: no files found matching '*.txt' 04:35:13 INFO - no previously-included directories found matching 'build' 04:35:13 INFO - no previously-included directories found matching 'dist' 04:35:13 INFO - no previously-included directories found matching '.git*' 04:35:13 INFO - Installing collected packages: jsonschema, functools32 04:35:13 INFO - Running setup.py install for functools32 04:35:13 INFO - warning: no files found matching '*.txt' 04:35:13 INFO - no previously-included directories found matching 'build' 04:35:13 INFO - no previously-included directories found matching 'dist' 04:35:13 INFO - no previously-included directories found matching '.git*' 04:35:13 INFO - Successfully installed jsonschema functools32 04:35:13 INFO - Cleaning up... 04:35:13 INFO - Return code: 0 04:35:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:35:13 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')]} 04:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:13 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')]} 04:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:13 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 0x1017fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828bc9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9d30>, '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 0x101500db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015cebe8>, '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.SgHYSBQLX0/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.ay6OGrePVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:35:13 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 04:35:13 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 04:35:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgHYSBQLX0/Render', 04:35:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:13 INFO - 'HOME': '/Users/cltbld', 04:35:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:13 INFO - 'LOGNAME': 'cltbld', 04:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:13 INFO - 'MOZ_NO_REMOTE': '1', 04:35:13 INFO - 'NO_EM_RESTART': '1', 04:35:13 INFO - 'PAGER': '/bin/cat', 04:35:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:13 INFO - 'PWD': '/builds/slave/test', 04:35:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:13 INFO - 'SHELL': '/bin/bash', 04:35:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ay6OGrePVs/Listeners', 04:35:13 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:35:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:13 INFO - 'USER': 'cltbld', 04:35:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:13 INFO - 'XPC_FLAGS': '0x0', 04:35:13 INFO - 'XPC_SERVICE_NAME': '0', 04:35:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:35:13 INFO - Cleaning up... 04:35:13 INFO - Return code: 0 04:35:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:35:13 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')]} 04:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:13 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')]} 04:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:13 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 0x1017fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828bc9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9d30>, '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 0x101500db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015cebe8>, '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.SgHYSBQLX0/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.ay6OGrePVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:35:13 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 04:35:13 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 04:35:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgHYSBQLX0/Render', 04:35:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:13 INFO - 'HOME': '/Users/cltbld', 04:35:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:13 INFO - 'LOGNAME': 'cltbld', 04:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:13 INFO - 'MOZ_NO_REMOTE': '1', 04:35:13 INFO - 'NO_EM_RESTART': '1', 04:35:13 INFO - 'PAGER': '/bin/cat', 04:35:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:13 INFO - 'PWD': '/builds/slave/test', 04:35:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:13 INFO - 'SHELL': '/bin/bash', 04:35:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ay6OGrePVs/Listeners', 04:35:13 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:35:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:13 INFO - 'USER': 'cltbld', 04:35:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:13 INFO - 'XPC_FLAGS': '0x0', 04:35:13 INFO - 'XPC_SERVICE_NAME': '0', 04:35:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:14 INFO - Downloading/unpacking blobuploader==1.2.4 04:35:14 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 04:35:14 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 04:35:14 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 04:35:14 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 04:35:14 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 04:35:14 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 04:35:16 INFO - Downloading blobuploader-1.2.4.tar.gz 04:35:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:35:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:35:16 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 04:35:16 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 04:35:16 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 04:35:16 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 04:35:16 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 04:35:16 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 04:35:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:35:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:18 INFO - Downloading docopt-0.6.1.tar.gz 04:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:35:18 INFO - Installing collected packages: blobuploader, requests, docopt 04:35:18 INFO - Running setup.py install for blobuploader 04:35:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:35:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:35:18 INFO - Running setup.py install for requests 04:35:18 INFO - Running setup.py install for docopt 04:35:18 INFO - Successfully installed blobuploader requests docopt 04:35:18 INFO - Cleaning up... 04:35:19 INFO - Return code: 0 04:35:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:19 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')]} 04:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:19 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')]} 04:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:19 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 0x1017fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828bc9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9d30>, '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 0x101500db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015cebe8>, '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.SgHYSBQLX0/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.ay6OGrePVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:35:19 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 04:35:19 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 04:35:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgHYSBQLX0/Render', 04:35:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:19 INFO - 'HOME': '/Users/cltbld', 04:35:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:19 INFO - 'LOGNAME': 'cltbld', 04:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:19 INFO - 'MOZ_NO_REMOTE': '1', 04:35:19 INFO - 'NO_EM_RESTART': '1', 04:35:19 INFO - 'PAGER': '/bin/cat', 04:35:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:19 INFO - 'PWD': '/builds/slave/test', 04:35:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:19 INFO - 'SHELL': '/bin/bash', 04:35:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ay6OGrePVs/Listeners', 04:35:19 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:35:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:19 INFO - 'USER': 'cltbld', 04:35:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:19 INFO - 'XPC_FLAGS': '0x0', 04:35:19 INFO - 'XPC_SERVICE_NAME': '0', 04:35:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:19 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-YVGteH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:19 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-XNIkMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:19 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-dQuEmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:19 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-CEQAMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:19 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-iDoZ0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:19 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-pI8a79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:19 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-TS1MZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:20 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-hdtqxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:20 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-krazvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:20 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-CA2EDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:20 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-TYZo1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:20 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-X1oAJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:20 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-JT0kGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:20 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-ogO1_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:20 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-ibTL3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:20 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-66A4X4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:20 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-PQBHkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:35:21 INFO - Running setup.py install for manifestparser 04:35:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:35:21 INFO - Running setup.py install for mozcrash 04:35:21 INFO - Running setup.py install for mozdebug 04:35:21 INFO - Running setup.py install for mozdevice 04:35:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:35:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:35:21 INFO - Running setup.py install for mozfile 04:35:21 INFO - Running setup.py install for mozhttpd 04:35:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:35:21 INFO - Running setup.py install for mozinfo 04:35:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:35:22 INFO - Running setup.py install for mozInstall 04:35:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:35:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:35:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:35:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:35:22 INFO - Running setup.py install for mozleak 04:35:22 INFO - Running setup.py install for mozlog 04:35:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:35:22 INFO - Running setup.py install for moznetwork 04:35:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:35:22 INFO - Running setup.py install for mozprocess 04:35:22 INFO - Running setup.py install for mozprofile 04:35:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:35:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:35:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:35:23 INFO - Running setup.py install for mozrunner 04:35:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:35:23 INFO - Running setup.py install for mozscreenshot 04:35:23 INFO - Running setup.py install for moztest 04:35:23 INFO - Running setup.py install for mozversion 04:35:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:35:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:35:23 INFO - Cleaning up... 04:35:23 INFO - Return code: 0 04:35:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:23 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')]} 04:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:23 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')]} 04:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:23 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 0x1017fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828bc9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9d30>, '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 0x101500db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015cebe8>, '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.SgHYSBQLX0/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.ay6OGrePVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:35:23 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 04:35:23 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 04:35:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgHYSBQLX0/Render', 04:35:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:23 INFO - 'HOME': '/Users/cltbld', 04:35:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:23 INFO - 'LOGNAME': 'cltbld', 04:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:23 INFO - 'MOZ_NO_REMOTE': '1', 04:35:23 INFO - 'NO_EM_RESTART': '1', 04:35:23 INFO - 'PAGER': '/bin/cat', 04:35:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:23 INFO - 'PWD': '/builds/slave/test', 04:35:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:23 INFO - 'SHELL': '/bin/bash', 04:35:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ay6OGrePVs/Listeners', 04:35:23 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:35:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:23 INFO - 'USER': 'cltbld', 04:35:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:23 INFO - 'XPC_FLAGS': '0x0', 04:35:23 INFO - 'XPC_SERVICE_NAME': '0', 04:35:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:23 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-pmSpEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:24 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)) 04:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:24 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-gKqOZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 04:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:24 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-3xbJUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:24 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)) 04:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:24 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-zm77b_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 04:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:24 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-pQn_vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:24 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)) 04:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:24 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-tia0cS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:24 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)) 04:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:24 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-KxxToS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:24 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)) 04:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:24 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-fYdxl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:24 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)) 04:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:24 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-IQGsIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:24 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)) 04:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:24 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-uZzHAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:25 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-e2Vfgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:25 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)) 04:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:25 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-MXCBXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 04:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:25 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-1u392u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:25 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)) 04:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:25 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-CXBssJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 04:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:25 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-1R84Mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:25 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)) 04:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:25 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-vjQl5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 04:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:25 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-xbfnxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:25 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)) 04:35:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:35:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:35:25 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)) 04:35:25 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:35:25 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:35:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:35:25 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 04:35:25 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 04:35:25 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 04:35:25 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 04:35:25 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 04:35:25 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 04:35:28 INFO - Downloading blessings-1.6.tar.gz 04:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:35:28 INFO - Installing collected packages: blessings 04:35:28 INFO - Running setup.py install for blessings 04:35:28 INFO - Successfully installed blessings 04:35:28 INFO - Cleaning up... 04:35:28 INFO - Return code: 0 04:35:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:35:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:35:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:35:29 INFO - Reading from file tmpfile_stdout 04:35:29 INFO - Current package versions: 04:35:29 INFO - blessings == 1.6 04:35:29 INFO - blobuploader == 1.2.4 04:35:29 INFO - docopt == 0.6.1 04:35:29 INFO - functools32 == 3.2.3-2 04:35:29 INFO - jsonschema == 2.5.1 04:35:29 INFO - manifestparser == 1.1 04:35:29 INFO - mozInstall == 1.12 04:35:29 INFO - mozcrash == 1.0 04:35:29 INFO - mozdebug == 0.1 04:35:29 INFO - mozdevice == 0.49 04:35:29 INFO - mozfile == 1.2 04:35:29 INFO - mozhttpd == 0.7 04:35:29 INFO - mozinfo == 0.9 04:35:29 INFO - mozleak == 0.1 04:35:29 INFO - mozlog == 3.4 04:35:29 INFO - moznetwork == 0.27 04:35:29 INFO - mozprocess == 0.24 04:35:29 INFO - mozprofile == 0.28 04:35:29 INFO - mozrunner == 6.13 04:35:29 INFO - mozscreenshot == 0.1 04:35:29 INFO - mozsystemmonitor == 0.3 04:35:29 INFO - moztest == 0.8 04:35:29 INFO - mozversion == 1.4 04:35:29 INFO - psutil == 3.1.1 04:35:29 INFO - requests == 1.2.3 04:35:29 INFO - wsgiref == 0.1.2 04:35:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:29 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 0x1017fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828bc9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9d30>, '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 0x101500db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015cebe8>, '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.SgHYSBQLX0/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.ay6OGrePVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:35:29 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 04:35:29 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 04:35:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgHYSBQLX0/Render', 04:35:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:29 INFO - 'HOME': '/Users/cltbld', 04:35:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:29 INFO - 'LOGNAME': 'cltbld', 04:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:29 INFO - 'MOZ_NO_REMOTE': '1', 04:35:29 INFO - 'NO_EM_RESTART': '1', 04:35:29 INFO - 'PAGER': '/bin/cat', 04:35:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:29 INFO - 'PWD': '/builds/slave/test', 04:35:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:29 INFO - 'SHELL': '/bin/bash', 04:35:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ay6OGrePVs/Listeners', 04:35:29 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:35:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:29 INFO - 'USER': 'cltbld', 04:35:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:29 INFO - 'XPC_FLAGS': '0x0', 04:35:29 INFO - 'XPC_SERVICE_NAME': '0', 04:35:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:29 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)) 04:35:29 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)) 04:35:29 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)) 04:35:29 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)) 04:35:29 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)) 04:35:29 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)) 04:35:29 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)) 04:35:29 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)) 04:35:29 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)) 04:35:29 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)) 04:35:29 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)) 04:35:29 INFO - Cleaning up... 04:35:29 INFO - Return code: 0 04:35:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017fbb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017fe768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828bc9e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1015d9d30>, '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 0x101500db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015cebe8>, '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.SgHYSBQLX0/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.ay6OGrePVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:35:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgHYSBQLX0/Render', 04:35:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:29 INFO - 'HOME': '/Users/cltbld', 04:35:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:29 INFO - 'LOGNAME': 'cltbld', 04:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:29 INFO - 'MOZ_NO_REMOTE': '1', 04:35:29 INFO - 'NO_EM_RESTART': '1', 04:35:29 INFO - 'PAGER': '/bin/cat', 04:35:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:29 INFO - 'PWD': '/builds/slave/test', 04:35:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:29 INFO - 'SHELL': '/bin/bash', 04:35:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ay6OGrePVs/Listeners', 04:35:29 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:35:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:29 INFO - 'USER': 'cltbld', 04:35:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:29 INFO - 'XPC_FLAGS': '0x0', 04:35:29 INFO - 'XPC_SERVICE_NAME': '0', 04:35:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:35:29 INFO - Cleaning up... 04:35:29 INFO - Return code: 0 04:35:29 INFO - Running post-action listener: _resource_record_post_action 04:35:29 INFO - Running post-action listener: _start_resource_monitoring 04:35:29 INFO - Starting resource monitoring. 04:35:29 INFO - [mozharness: 2017-01-27 12:35:29.592923Z] Finished create-virtualenv step (success) 04:35:29 INFO - [mozharness: 2017-01-27 12:35:29.593887Z] Running install step. 04:35:29 INFO - Running pre-action listener: _resource_record_pre_action 04:35:29 INFO - Running main action method: install 04:35:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:35:29 INFO - Reading from file tmpfile_stdout 04:35:29 INFO - Detecting whether we're running mozinstall >=1.0... 04:35:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:35:29 INFO - Reading from file tmpfile_stdout 04:35:29 INFO - Output received: 04:35:29 INFO - Usage: mozinstall [options] installer 04:35:29 INFO - Options: 04:35:29 INFO - -h, --help show this help message and exit 04:35:29 INFO - -d DEST, --destination=DEST 04:35:29 INFO - Directory to install application into. [default: 04:35:29 INFO - "/builds/slave/test"] 04:35:29 INFO - --app=APP Application being installed. [default: firefox] 04:35:29 INFO - mkdir: /builds/slave/test/build/application 04:35:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:35:52 INFO - Reading from file tmpfile_stdout 04:35:52 INFO - Output received: 04:35:52 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:35:52 INFO - Running post-action listener: _resource_record_post_action 04:35:52 INFO - [mozharness: 2017-01-27 12:35:52.438166Z] Finished install step (success) 04:35:52 INFO - [mozharness: 2017-01-27 12:35:52.438306Z] Running run-tests step. 04:35:52 INFO - Running pre-action listener: _resource_record_pre_action 04:35:52 INFO - Running main action method: run_tests 04:35:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:35:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:35:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:35:52 INFO - 2017-01-27 04:35:52.452 screenresolution[1936:13390] starting screenresolution argv=screenresolution get 04:35:52 INFO - 2017-01-27 04:35:52.455 screenresolution[1936:13390] Display 0: 1600x1200x32@60 04:35:52 INFO - 2017-01-27 04:35:52.461 screenresolution[1937:13392] starting screenresolution argv=screenresolution list 04:35:52 INFO - Available Modes on Display 0 04:35:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:35:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:35:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:35:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:35:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:35:52 INFO - Intel Iris: 04:35:52 INFO - Chipset Model: Intel Iris 04:35:52 INFO - Type: GPU 04:35:52 INFO - Bus: Built-In 04:35:52 INFO - VRAM (Dynamic, Max): 1536 MB 04:35:52 INFO - Vendor: Intel (0x8086) 04:35:52 INFO - Device ID: 0x0a2e 04:35:52 INFO - Revision ID: 0x0009 04:35:52 INFO - Displays: 04:35:52 INFO - Display: 04:35:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:35:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:35:52 INFO - Display Serial Number: 1600x1200 60 04:35:52 INFO - Main Display: Yes 04:35:52 INFO - Mirror: Off 04:35:52 INFO - Online: Yes 04:35:52 INFO - Rotation: Supported 04:35:52 INFO - Return code: 0 04:35:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:35:52 INFO - Python 2.7.3 04:35:52 INFO - Return code: 0 04:35:52 INFO - grabbing minidump binary from tooltool 04:35:52 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')]} 04:35:52 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 0x1015d9d30>, '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 0x101500db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015cebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:35:52 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 04:35:52 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 04:35:52 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 04:35:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:35:52 INFO - Return code: 0 04:35:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:35:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:35:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:35:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:35:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:35:52 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0263', '--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 04:35:52 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0263 --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 04:35:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SgHYSBQLX0/Render', 04:35:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:52 INFO - 'HOME': '/Users/cltbld', 04:35:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:52 INFO - 'LOGNAME': 'cltbld', 04:35:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:35:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:52 INFO - 'MOZ_NO_REMOTE': '1', 04:35:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:35:52 INFO - 'NO_EM_RESTART': '1', 04:35:52 INFO - 'PAGER': '/bin/cat', 04:35:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:52 INFO - 'PWD': '/builds/slave/test', 04:35:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:35:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:52 INFO - 'SHELL': '/bin/bash', 04:35:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ay6OGrePVs/Listeners', 04:35:52 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:35:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:52 INFO - 'USER': 'cltbld', 04:35:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:52 INFO - 'XPC_FLAGS': '0x0', 04:35:52 INFO - 'XPC_SERVICE_NAME': '0', 04:35:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:52 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0263', '--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 04:35:53 INFO - mozversion application_buildid: 20170127030206 04:35:53 INFO - mozversion application_changeset: 8dbe8993536645eceeeaf8cb6fc53c03602d7c84 04:35:53 INFO - mozversion application_display_name: Nightly 04:35:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:35:53 INFO - mozversion application_name: Firefox 04:35:53 INFO - mozversion application_remotingname: firefox 04:35:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:35:53 INFO - mozversion application_vendor: Mozilla 04:35:53 INFO - mozversion application_version: 54.0a1 04:35:53 INFO - mozversion platform_buildid: 20170127030206 04:35:53 INFO - mozversion platform_changeset: 8dbe8993536645eceeeaf8cb6fc53c03602d7c84 04:35:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:35:53 INFO - mozversion platform_version: 54.0a1 04:35:53 INFO - using testdate: 1485520553 04:35:53 INFO - actual date: 1485520553 04:35:53 INFO - starting webserver on 'localhost:51282' 04:35:53 INFO - SUITE-START | Running 2 tests 04:35:53 INFO - TEST-START | dromaeo_css 04:35:53 INFO - operating with platform_type : mac_ 04:35:53 INFO - Initialising browser for dromaeo_css test... 04:35:53 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpM6G4DD/profile http://localhost:51282/getInfo.html) 04:35:55 INFO - PROCESS | 1947 | __metrics Screen width/height:1600/1200 04:35:55 INFO - PROCESS | 1947 | colorDepth:24 04:35:55 INFO - PROCESS | 1947 | Browser inner width/height: 1024/689 04:35:55 INFO - PROCESS | 1947 | __metrics 04:35:55 INFO - PROCESS | 1947 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:35:55 INFO - PROCESS | 1947 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:35:56 INFO - TEST-INFO | 1947: exit 0 04:35:56 INFO - Browser initialized. 04:35:56 INFO - Running cycle 1/1 for dromaeo_css test... 04:35:56 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpM6G4DD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:08 INFO - PROCESS | 1950 | RSS: Main: 235823104 04:36:08 INFO - PROCESS | 1950 | 04:39:11 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51282/tests/dromaeo/cssquery-ext.html) 04:39:15 INFO - PROCESS | 1950 | RSS: Main: 481570816 04:39:15 INFO - PROCESS | 1950 | 04:40:58 INFO - PROCESS | 1950 | ************************* 04:40:58 INFO - PROCESS | 1950 | A coding exception was thrown and uncaught in a Task. 04:40:58 INFO - PROCESS | 1950 | 04:40:58 ERROR - PROCESS | 1950 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:40:58 INFO - PROCESS | 1950 | Full stack: 04:40:58 INFO - PROCESS | 1950 | ************************* 04:42:17 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51282/tests/dromaeo/cssquery-ext.html (next: http://localhost:51282/tests/dromaeo/cssquery-jquery.html) 04:42:18 INFO - PROCESS | 1950 | RSS: Main: 382681088 04:42:18 INFO - PROCESS | 1950 | 04:45:20 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51282/tests/dromaeo/cssquery-mootools.html) 04:45:21 INFO - PROCESS | 1950 | RSS: Main: 335450112 04:45:21 INFO - PROCESS | 1950 | 04:48:23 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51282/tests/dromaeo/cssquery-prototype.html) 04:48:24 INFO - PROCESS | 1950 | RSS: Main: 336822272 04:48:24 INFO - PROCESS | 1950 | 04:51:28 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51282/tests/dromaeo/cssquery-yui.html) 04:51:28 INFO - PROCESS | 1950 | RSS: Main: 330690560 04:51:28 INFO - PROCESS | 1950 | 04:54:32 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:51282/tests/dromaeo/cssquery-yui.html (next: http://localhost:51282/tests/dromaeo/cssquery-dojo.html) 04:54:32 INFO - PROCESS | 1950 | RSS: Main: 474374144 04:54:32 INFO - PROCESS | 1950 | 04:54:32 INFO - PROCESS | 1950 | __start_tp_report 04:54:32 INFO - PROCESS | 1950 | _x_x_mozilla_page_load 04:54:32 INFO - PROCESS | 1950 | _x_x_mozilla_page_load_details 04:54:32 INFO - PROCESS | 1950 | |i|pagename|runs| 04:54:32 INFO - PROCESS | 1950 | |0;dojo.html;3274.9999999999995;3281.392942305673;3289.8519566619516;3299.884504042359;3354;5471.316085489314;5586.10622300432;5590.86022849429;5615.073512870382;5627.803026894059;5563.165525171216;5596.58025648077;5612;5612.66324020559;5616.241807356006;5028.84913452597;5052.242163675442;5067.113255180328;5140.820071297505;5145.202493613478;5100.923486147711;5171.301874246985;5173.844784656466;5174.068667639842;5181.378234611851;5111.948880511203;5175.094358487268;5181.274621552986;5183.118869792125;5184.559312458446;5167.638265321429;5170.379554453452;5171.663841850268;5175.767090480937;5187.040397526451;4944.678595891256;5032.6477146599755;5127.051495473349;5132.923006154911;5142.74286285688;5557.666540007613;5620.971895140539;5622.3253209614695;5666.433356664342;5680.460356266148;5952.315483719384;6117.174181485487;6126.877462450726;6142.662153581551;6155.353687862799;6114.052321890114;6126.540509461764;6129.295131059896;6186.536009799238;6233.844153896189;5741.397153298927;5743.052396354638;5743.1385292206505;5750.827475175752;5775.249217601769;6330.0821380899515;6333.841653958688;6344.714487848058;6347.333529979378;6347.809565713036;5835.095560188178;5936.22829032223;5940.168376427304;5957.434043765836;6050.031994880798;6169.2288463942;6184.041473571604;6188.659623720739;6192;6211.254649442006;6054.152418661391;6099.512039036867;6104.603200791934;6117.082437634302;6117.082437634391;5933.376995415506;6156.076588511759;6159.876802464015;6170.259568851677;6183.84540386485;4852.102361063144;4868.391451068616;4882.292067650171;4910.950890491121;4921.926171107436;4342.717723348035;4343.478782546114;4359.04101097758;4371.519132895379;4400.757958312323;5601.971990140023;5616.326040875121;5624.803131890364;5629;5631.802886898939;6092.847678808065;6113.32428171423;6124.167343420691;6166.506679465721;6219.689015549205;5586.13414920688;5595.13275442299;5619.044762390404;5624.634398764068;5651.576131790132;5012.799488020439;5324.961632481629;5349.3580770307035;5408.13469844823;5413.350397952192;6350.079238510298;6350.809475715736;6351.55539112267;6351.587146835441;6381.138546296191;6255.343188965275;6273.1844860167885;6279.591826531261;6280.309165991646;6293;6212.285587157354;6250.312465628868;6274.372562743689;6319.05214217871;6348.77779277723;5989.101634754822;6000.969995150171;6004.639721616717;6021.879562408815;6023.909641355295;4978.178600530872;6039.154518367344;6040.063790112539;6047.9395206047375;6058.666773327509;5745.626534275259;5881.4118588142555;5899.233099697012;5901.0558310670085;5909.970450147722;5735.197072409783;5857.4435428634215;5860.853478663067;5878.559108066997;5879.176915231957;5725;5758.971205143947;5792.739326730223;5795.39148389413;5805.593608447368;5940.138679891478;5987;5991.221141251609;5993.880122397441;5998.370171131968;5843.357230704534;5844.181814546052;5854.502367298827;5857.179994800646;5859.326177489644 04:54:32 INFO - PROCESS | 1950 | |1;ext.html;463.77275135183754;480.58669544191997;512.2776884592722;513.460866090605;522.0576858769919;39241.80379098104;41773;41820.58179418205;41889.58110418895;41907.95230119248;33787.32425351492;34116.1470963226;34176.829115854445;43053.138937221236;43152.352714709305;9176.541172941359;9472.763180920463;9476.14714675679;9491.715248542554;9497.382670126453;9335;9344.06559344067;9442.291828112884;9466.053394660514;9476.857847132298;8349.833003339929;8529.786755331104;9460.337776355658;9494.240460763156;11035;11175.21773475857;11443.713907152305;11460.025897798698;11468.13988950832;11469.197156199069;11119.332840029625;11196.664100076929;11284.153688473316;11287.040601548879;11300.208985371028;40401.595984040374;40434.39348409776;41477.79261103705;41692;41829.581704183176;4040.898977525556;4052.754567694556;4075.612816782401;4086.366613174963;4203.747775133471;30565.847170764227;31341.8432907834;31381.686183138103;31403.05790826279;31745.04764857058;3148.3231105312466;3193.265618477806;3221.710046095839;3234.2399536108996;3325.866965321384;452714;455266;455478;455641.72179139225;455712;59690.403095969355;59838;60027;60159.09761353583;60212.39787602068;60793.39206607877;62795.6860215696;63062.68468657627;63130;63214.41963950938;15359;15489.612759681098;15493.535193944199;15610.609734756721;15828.28772705231;12551.058670599741;12605.180663256859;12634.873651263553;12642.367881605884;12646.430910609044;13572.35339108884;16161.59596010109;16172.191390430431;16177.19114044293;16224.918875405547;5449.972750136303;6535.281119076898;6651.933480665228;6656.267810540837;6685.431738302299;866.764860074404;871.8299931513421;872.6858331000834;879.2570278114982;903.20969151992;30464.69535304663;30466.84766576153;30520.847395762878;30533.694663053084;31053.8447307762;901.7880798012462;1004.5579944824254;1028.7376718936623;1074.5003573338436;1188.8216767484946;14910.254487275593;15622.921885390728;15857.652099571435;15873.04761714301;15999.040057596581;578984.4710870199;584498;584891.0755446281;585211;585382;61370.69314653398;61565;61606.383936160964;61711.691441542505;61747.691261543405;1371.4445649511963;1412.413848252984;1434.7274017936559;1436.6767477317728;1437.0802686280579;29769.702302976693;29792.10623681293;30121.849390752905;30199;30697;50182.749086254335;50695.2395714072;50734.49265507446;50778.238326425875;50893;521289.7871021393;523536;523851.38074309385;523957;524282;37854.24291514099;39299.410508842964;39744.20511589694;39751.80124099477;39781.20984555644;46164.53835461737;46819.76590117028;46935.53064469448;47105.2934205994;47358.76320618375;38238.85283441501;38362.0409489765;38544.807275964566;39533.070039494305;39725.60274397219;38511.22977540489;38731;38969.610303896596;39895.2020959585;40313.59686403216;38132.04669883275;38221.61778382181;38232.500474919885;38673.41989870211;38733;31476.842615786776;32722.34555308833;33523.99428017066;33624.82313119029;33788.83105584457;23976.442099283635;24840.25479235626;25017.499650006535;25382;25543.489130217662 04:54:32 INFO - PROCESS | 1950 | |2;jquery.html;371.682211708989;393.1272574883759;394.16043826649235;401.66661670813227;422.0693371116688;14793.597803380855;15368.846311536881;18346.724799128006;20672.793272067276;21174.364769056916;20801.16795328189;21173.75378244941;21454.463638409048;21643.783562164375;22052.88973555134;5633.915491267624;5748.2527271454865;5972.492338151263;6037.064255040454;6037.305709843358;6086.300075491331;6146.17026701394;6156.56904016719;6164.660943648098;6165.136880836686;3369.9157521062048;3681.079730067483;6168.938310616903;6328.841778955517;7886.250806173404;7685.923140768577;7916.48542844719;7942.483738556975;7968.8804667929735;7975;7142.857142857166;7265.636718164071;7745.690172393098;7767;7794.3764498839955;23820.496543588713;29466.263343416373;29798.851005745048;30614.84692576545;30647.846760766275;2848.1597928610904;2881.5821705852536;2892.5950366948646;2898.4637841999297;2966.0656893078826;16430.342786288533;17228;17365.652686946316;17467.825321746874;18036.819631803777;1631.380075571287;1795.2549691877855;1920.9039548022542;1982.0783335748945;1993.1031036033698;157458;164081;165067.17466412712;165595;169707;23186.768132318797;23260.41848953756;23363.62636593593;23602.7639723604;24328.012757384695;41329;41386.72373019453;41635.1672966545;41708.165836683096;41857.58142418598;7481.877718342293;7698.884516732253;8288.50268983863;8752.956235218782;11075.224734268684;8322.20939010793;8341.04078031022;8364.414490985573;8499.61751721174;8502.192291732275;4684.086603112429;4733.526647335308;4755.215389460769;4758;4844.757762111951;1694.4408345246038;1699.9660006799795;1824.324999750101;1860.9299652699751;2026.6757318828916;941.6751220828803;951.2912879904516;956.086936975201;997.1125698128672;1004.7036124343336;19377.4186774397;20882.37352879416;20883.895580522;20885.68671469929;21166.365009049754;963.3016063354012;975.4439969217619;1006.6627679727374;1021.5862575656871;1032.8605638238741;7814.726484573012;10554.841677374845;10772.730681732863;10802.729931751612;10821.621243256606;709664;711400;725359;730658;734882;104860;107692;118399.8160018406;142587;153714;964.8118616869783;984.2618036472645;1027.0961553832578;1064.9627263045757;1069.2889228662852;17936.91031544834;18022.459326220236;18142.54643633867;18394.356197533023;18456.446306610822;58007;58272;58936.70531647314;60038.399616003284;60307.396926030175;83464;85877.57061214653;88115.66380706834;88215.1178488207;89060;7913.881291780513;8221.54781487024;8460.323174146177;8474.872876906975;8608.311335093304;9445;12937.805932911202;13429;13461.528846490326;13498.730025399633;10869.402182880018;11163.330200188015;11164.162687798285;11238.606648767254;11376.829347559958;10865.728356791144;10866.456677166268;11140.721481963015;11433.1996760226;11456.083513318748;11142.27575207609;11271;11325.263857849213;11455.198136130724;11556.826647600124;7158.391536719437;7316.341529262392;7557.886631700639;7831.804204894923;8656.523891185794;9954.900450995397;10101.242406819665;10656.667916510436;11531.308121512737;11533.192676512563 04:54:32 INFO - PROCESS | 1950 | |3;mootools.html;1224.3082658298063;1424.209563692151;1430.9856901430983;1442.4158215922548;1445.8626430489103;7863.095743989443;8121.553314567696;8232.711855085074;8254.66981320748;8261.13258107899;7309.305615966488;7545.547267163974;7553.282438168365;7857.960710196456;8156.95921520393;2212.281008672184;2258.717660292455;2264.4338915271182;2267.251806903718;2269.205777977711;2240.73111226653;2270.489139943516;2278.5215104828007;2279.4985103277254;2283.2008796921027;1982.9603407931834;2046.9692954605694;2156.4393257753018;2202.878841663708;2215.977840221601;2224.8665080095166;2236.6756820261135;2239.708837851069;2239.944001399962;2243.05791567542;2167.6423390140767;2221.7444993825757;2225.332400279926;2225.5660146271484;2262.3552287597954;8146.26683598473;8198.42611017229;8207.343412526983;8210.178982101801;8261.463004904723;4926.2118061110405;5082.390113186441;5094.337736094284;5117.8720531987;5121.975604879002;3231.224506118538;3406.659334066598;3407.9318413631836;3469.080693616194;3480.2343484433386;1175.4357908204024;1212.7392610588765;1242.1801610936739;1255.7614053329837;1262.5328628407456;10490.737731556696;10508.842367364496;10514.158867290598;10517.684469465928;10535.315204511682;4469.463664360298;4563.520830312769;4574.4968053514085;4623.93064104032;4630.3748993886065;9269.073092690676;9270.582823772811;9272.30457715674;9272.72181834546;9277.58250878712;5163.819266325736;5169.689818610896;5177.301064356339;5178.689278643294;5181.740912954413;3943.802809859553;4095.5494895561465;4344.761038142869;4667.9766601166775;4755.358026666356;3242.935141297161;3711.3319602471815;3731.552213734315;3779.168582911755;3828.942565861514;1069.7325668582855;1072.2494254022215;1252.2987127208792;1261.4890969157507;1263.8420197475316;807.5316316536395;836.2097817562467;837.0792128658427;869.3827382558454;924.7746735575389;5297.576193904479;5316.840494785162;5490.3411590609385;5534.7786088556;5600.915986260209;916.7478943290648;949.924006079512;964.4454438697777;985.6451677396132;1022.2844009193445;3487.5466189395725;3717.4052151655605;3728.7203459740626;3732.2588045202;3765.8870233893026;9177.632894684139;9538.713838584854;9631.759206019766;9716.562754676057;9726.756831079138;9682.031796820262;9693.854592181124;9701.805963880683;9705.175060119827;9705.563249653782;7485.588292643848;7532.322091011835;7586.393088552903;7630.008098947102;7676.078870535572;4486.833423309898;4925.704457732548;5342.652727572696;5345.278387417648;5346.759395827119;8556.229939305493;8602.440841345293;8913.732588022369;9055;9058.909410905806;8915.197632213132;9056.818863622822;9107.180353768194;9185.035571265189;9185.862212066691;6471.838204044749;6644.10304608891;6842.657867106525;6896.620685862325;7028.121484814398;7696.8460630788195;7791.454598178299;7806.804829879298;7809.960950195213;7836.216378362118;6784.830379240361;6911.5853048817235;6918.51570390088;6972.442204623517;7011.404030657452;6788.66056697173;6814.8637027260165;6827.112475378368;6880.518363714692;6884.896726549206;6143.416375444325;6223.128761973237;6273.404026617464;6287.371262873676;6302.054691796084;4857.149998750134;4880.804767809248;4882.340883980617;4936.506349365035;4981.252812078217;4798.95201047999;4860.8298709545;4913.115639184981;4993.675411098412;4999.175136102503 04:54:32 INFO - PROCESS | 1950 | |4;prototype.html;315.7379375118652;354.12354422803554;356.1612402791426;365.73118757713087;376.1442717816968;4500.617447516956;5351.545118664913;5428.647137936031;5435.972820135894;5487.42382049885;4974.676646018015;5040.42035165956;5215.947840521593;5218.921716174261;5363.919541206876;3324.833758312087;4087.5912408759036;4132.793360331986;4147.398627199054;4187.33002719565;4108.424820525129;4128.938065929014;4136.834526618932;4139.627433530982;4139.94431419989;3080.0431585677775;3904.1650424300674;4020.396940458925;4104.363823607346;4110.301248787713;3537.2748586539697;3542.4059173371957;4117.629413352783;4122.0214297137245;4140.1098763765785;2962.9333439961597;3435.914102147441;3506.912327191815;3601.3877640800865;3616.2044350242904;5114.619052855745;5116.974415127937;5141;5143.7685304161405;5164.690118592859;3762.849486020556;4173.5409104998425;4565.13262480131;4580.725156490621;4585.463869603686;5447.727613619343;5456.536194423479;5544.695041772701;5577.247071645316;5584.636998595079;3562.358775420423;3730.869419570302;3753.868614598476;3774.0942173878348;3799.9430008549894;4463.977680111611;4898.363212782316;5737.713114344266;5814.5057670098095;5913.172155898178;3848.499695039627;3853.5953724859046;3864.632859878307;3888.902777430587;3897.3569361055106;3385.5598772159956;3807.629253468749;3892.9416058759143;3894.2600905827803;3920.7647541147053;4268.317069268902;4540.88647783808;4556.908861822745;4564.908701826012;4577.939927032849;5464.726763661801;5635.21107045014;5654.321481422256;5656.123300888369;5679.659220446786;1175.8530183727034;1235.234154824015;1269.5780725587401;1271.4914034386134;1277.881853378294;723.4357201382825;811.2293321344746;819.2381085590458;820.5609998650693;839.4669384940606;4475.932861007088;4841.540053694894;4869.829555965524;4876.366072410635;4929.598576981871;5244.744759753266;5321.5476684482255;5324.494173053554;5445.37378201504;5450.31871016123;4123.443335149776;4391.956080439219;4439.822407103744;4881.755912204376;5202.0116177926075;2398.9640155397683;2682.061278552491;2723.414465889843;2770.667519897625;2849.843258620796;4758.452777930513;5127.769250383742;5494;5583.469570390806;5758.510526605201;4537.593346062731;4668.323093151474;5825.271841019872;5903;5903.26209223847;4663.300504924288;5221.6083793715625;5929.110633404937;6028.914795336794;6038.456538911519;5001.474845141208;5284.044903385772;5291.989044163193;5702.51528620072;5801.680907550125;4510.932336015028;4690.249560070372;5636;5711.571632127524;5725.513331366714;5137.2037334213255;5233.293505376725;5834.453869724442;5998.430149135826;5999.400059993965;3362.7309815215212;3691.3640064535875;3878.8060596970604;4112.547619761764;4174.645155161846;4866.8365562383315;5545.944540554543;5610.831675049755;5664.518515926193;5793.217915581343;5483.479069488392;5514.145307477347;5526.944730552643;5581.888362232814;5635.380108188014;5337.306150200604;5477.589180811535;5495.807646732345;5505.972470137784;5595.9295060826125;4732.965469026881;5010.799568017239;5205.791768329376;5319.803044314998;5524.8342549723575;4554.499005109369;4767.642426818072;4957.157283261782;5439.401665816836;5447.859626683669;4721.787519561559;5118.539331460186;5247.475252474722;5425.755840987086;5428.457154284698 04:54:32 INFO - PROCESS | 1950 | |5;yui.html;696.4324075878155;719.4244604316546;720.578461599964;766.3524321947956;810.4124509730447;14735.410583576657;15657.355977622357;15738.134402607851;15769.053856768587;15771.842281577196;14477.348519316629;14633.122012679247;14634.926825365885;14636.780448293284;14696.265186740673;660.326467003656;680.8400025993888;683.1324218242829;841.4782834642515;853.9615717292737;841.877927700483;850.9659613615479;861.4314552395421;864.4769914201912;865.3164000439646;904.0326850270213;905.3210092430677;905.8097799462121;905.9988712472689;907.6097278170384;902.3818684201277;902.9322800789935;903.0923921458957;903.9593218305192;904.1094521895927;523.8061917090663;539.9865003374907;653.8888388973838;669.9095622091004;676.1480534526532;15460.768088478682;15488.838337124647;15491.457798976982;15504.992175508669;15508.069515828973;13850.930745346208;13870.306484675726;13899.652508687263;13930.58208253754;13948.721025579533;12427.192232504858;12711.110222284444;12726.936365318206;12737.745245095046;13069.281189534571;4032.153765034748;4068.3897415387632;4135;4184.853530126461;4194.874153775361;101854;104073;104785.95214047839;105452;106885;9195.724128276162;10801.513931873085;11101.278416902875;11259.831102533468;11505;21372.572548548942;21573.892130539247;22572;22572.66141007886;22599.983000764678;7799.649015794303;7849.058113026359;7854.136045035041;7915.287624113857;7935.960320198362;4084.509858816961;4147.502299724052;4407.801648925806;4444.73331600105;4445.155420470101;3412.9317413652084;3434.8969530914114;3508.245727168671;3512.7365447591533;3523.8590456381457;563.7632194478329;565.2651552981108;568.0712035821462;569.6354333226739;578.3811321885543;532.5446743034727;609.6524980761012;618.780332981794;621.8445388652837;654.9934500655028;8890.507380488038;9537.952310238543;9616.615335386647;9645.37305075168;9706.077922597342;546.4999525434183;554.6090006545376;594.402625361509;631.3844002097918;633.8478765096344;4609.1473077480105;4632.2356811126465;4645.907081858411;4649.767511624405;4689.976550117228;80461;94194;104516;106925.46537267264;107340;73465;74000;93988.53005734927;95027.52486237524;97015;81744;83081.16918830856;83108;83120.58439707763;84284.57857710918;9202.447853128833;9297.628094876129;9320.928093269089;9324.487153206639;9382;40365.990850228976;42580.78709606432;43185.92035199145;53526.73236633948;54940.03369511318;53267.46732532625;64753;65193.34806651873;69047.3095269061;69420.30579694138;12522.186057906207;12579.685507862378;12802.871971280541;12818.359082045674;13510.459581616626;14523.927380363031;14593.270336482921;14625.195614241318;15170.620734481727;15529.84470155284;10137.543810528692;10800.783984320113;13443.46226150943;13484.528041518892;13773.38019789132;12910.354482275661;12988.090833641554;13098.469707365062;13507.459701611826;13513.189208647513;13421.328933553088;13583.86416135826;13588.184708917497;13650.822140456556;13958.45070071444;7829.103777564989;10837.349759014485;10969.341839489656;11266.66200013968;11437.599684011353;10002.849957250794;10894.50974706156;10910.890891090987;10912;10930.070943969851 04:54:32 INFO - PROCESS | 1950 | __end_tp_report 04:54:32 INFO - PROCESS | 1950 | __start_cc_report 04:54:32 INFO - PROCESS | 1950 | _x_x_mozilla_cycle_collect,3524 04:54:32 INFO - PROCESS | 1950 | __end_cc_report 04:54:32 INFO - PROCESS | 1950 | __startTimestamp1485521672415__endTimestamp 04:54:32 INFO - PROCESS | 1950 | 04:54:32 INFO - PROCESS | 1950 | ------- Summary: start ------- 04:54:32 INFO - PROCESS | 1950 | Number of tests: 6 04:54:32 INFO - PROCESS | 1950 | 04:54:32 INFO - PROCESS | 1950 | [#0] dojo.html Cycles:165 Average:5650.89 Median:5805.59 stddev:634.06 (10.9%) stddev-sans-first:607.99 04:54:32 INFO - PROCESS | 1950 | Values: 3275.0 3281.4 3289.9 3299.9 3354.0 5471.3 5586.1 5590.9 5615.1 5627.8 5563.2 5596.6 5612.0 5612.7 5616.2 5028.8 5052.2 5067.1 5140.8 5145.2 5100.9 5171.3 5173.8 5174.1 5181.4 5111.9 5175.1 5181.3 5183.1 5184.6 5167.6 5170.4 5171.7 5175.8 5187.0 4944.7 5032.6 5127.1 5132.9 5142.7 5557.7 5621.0 5622.3 5666.4 5680.5 5952.3 6117.2 6126.9 6142.7 6155.4 6114.1 6126.5 6129.3 6186.5 6233.8 5741.4 5743.1 5743.1 5750.8 5775.2 6330.1 6333.8 6344.7 6347.3 6347.8 5835.1 5936.2 5940.2 5957.4 6050.0 6169.2 6184.0 6188.7 6192.0 6211.3 6054.2 6099.5 6104.6 6117.1 6117.1 5933.4 6156.1 6159.9 6170.3 6183.8 4852.1 4868.4 4882.3 4911.0 4921.9 4342.7 4343.5 4359.0 4371.5 4400.8 5602.0 5616.3 5624.8 5629.0 5631.8 6092.8 6113.3 6124.2 6166.5 6219.7 5586.1 5595.1 5619.0 5624.6 5651.6 5012.8 5325.0 5349.4 5408.1 5413.4 6350.1 6350.8 6351.6 6351.6 6381.1 6255.3 6273.2 6279.6 6280.3 6293.0 6212.3 6250.3 6274.4 6319.1 6348.8 5989.1 6001.0 6004.6 6021.9 6023.9 4978.2 6039.2 6040.1 6047.9 6058.7 5745.6 5881.4 5899.2 5901.1 5910.0 5735.2 5857.4 5860.9 5878.6 5879.2 5725.0 5759.0 5792.7 5795.4 5805.6 5940.1 5987.0 5991.2 5993.9 5998.4 5843.4 5844.2 5854.5 5857.2 5859.3 04:54:32 INFO - PROCESS | 1950 | 04:54:32 INFO - PROCESS | 1950 | [#1] ext.html Cycles:180 Average:66603.69 Median:39766.51 stddev:139338.35 (350.4%) stddev-sans-first:139640.75 04:54:32 INFO - PROCESS | 1950 | Values: 463.8 480.6 512.3 513.5 522.1 39241.8 41773.0 41820.6 41889.6 41908.0 33787.3 34116.1 34176.8 43053.1 43152.4 9176.5 9472.8 9476.1 9491.7 9497.4 9335.0 9344.1 9442.3 9466.1 9476.9 8349.8 8529.8 9460.3 9494.2 11035.0 11175.2 11443.7 11460.0 11468.1 11469.2 11119.3 11196.7 11284.2 11287.0 11300.2 40401.6 40434.4 41477.8 41692.0 41829.6 4040.9 4052.8 4075.6 4086.4 4203.7 30565.8 31341.8 31381.7 31403.1 31745.0 3148.3 3193.3 3221.7 3234.2 3325.9 452714.0 455266.0 455478.0 455641.7 455712.0 59690.4 59838.0 60027.0 60159.1 60212.4 60793.4 62795.7 63062.7 63130.0 63214.4 15359.0 15489.6 15493.5 15610.6 15828.3 12551.1 12605.2 12634.9 12642.4 12646.4 13572.4 16161.6 16172.2 16177.2 16224.9 5450.0 6535.3 6651.9 6656.3 6685.4 866.8 871.8 872.7 879.3 903.2 30464.7 30466.8 30520.8 30533.7 31053.8 901.8 1004.6 1028.7 1074.5 1188.8 14910.3 15622.9 15857.7 15873.0 15999.0 578984.5 584498.0 584891.1 585211.0 585382.0 61370.7 61565.0 61606.4 61711.7 61747.7 1371.4 1412.4 1434.7 1436.7 1437.1 29769.7 29792.1 30121.8 30199.0 30697.0 50182.7 50695.2 50734.5 50778.2 50893.0 521289.8 523536.0 523851.4 523957.0 524282.0 37854.2 39299.4 39744.2 39751.8 39781.2 46164.5 46819.8 46935.5 47105.3 47358.8 38238.9 38362.0 38544.8 39533.1 39725.6 38511.2 38731.0 38969.6 39895.2 40313.6 38132.0 38221.6 38232.5 38673.4 38733.0 31476.8 32722.3 33524.0 33624.8 33788.8 23976.4 24840.3 25017.5 25382.0 25543.5 04:54:32 INFO - PROCESS | 1950 | 04:54:32 INFO - PROCESS | 1950 | [#2] jquery.html Cycles:180 Average:41550.97 Median:16216.16 stddev:120553.38 (743.4%) stddev-sans-first:120851.91 04:54:32 INFO - PROCESS | 1950 | Values: 371.7 393.1 394.2 401.7 422.1 14793.6 15368.8 18346.7 20672.8 21174.4 20801.2 21173.8 21454.5 21643.8 22052.9 5633.9 5748.3 5972.5 6037.1 6037.3 6086.3 6146.2 6156.6 6164.7 6165.1 3369.9 3681.1 6168.9 6328.8 7886.3 7685.9 7916.5 7942.5 7968.9 7975.0 7142.9 7265.6 7745.7 7767.0 7794.4 23820.5 29466.3 29798.9 30614.8 30647.8 2848.2 2881.6 2892.6 2898.5 2966.1 16430.3 17228.0 17365.7 17467.8 18036.8 1631.4 1795.3 1920.9 1982.1 1993.1 157458.0 164081.0 165067.2 165595.0 169707.0 23186.8 23260.4 23363.6 23602.8 24328.0 41329.0 41386.7 41635.2 41708.2 41857.6 7481.9 7698.9 8288.5 8753.0 11075.2 8322.2 8341.0 8364.4 8499.6 8502.2 4684.1 4733.5 4755.2 4758.0 4844.8 1694.4 1700.0 1824.3 1860.9 2026.7 941.7 951.3 956.1 997.1 1004.7 19377.4 20882.4 20883.9 20885.7 21166.4 963.3 975.4 1006.7 1021.6 1032.9 7814.7 10554.8 10772.7 10802.7 10821.6 709664.0 711400.0 725359.0 730658.0 734882.0 104860.0 107692.0 118399.8 142587.0 153714.0 964.8 984.3 1027.1 1065.0 1069.3 17936.9 18022.5 18142.5 18394.4 18456.4 58007.0 58272.0 58936.7 60038.4 60307.4 83464.0 85877.6 88115.7 88215.1 89060.0 7913.9 8221.5 8460.3 8474.9 8608.3 9445.0 12937.8 13429.0 13461.5 13498.7 10869.4 11163.3 11164.2 11238.6 11376.8 10865.7 10866.5 11140.7 11433.2 11456.1 11142.3 11271.0 11325.3 11455.2 11556.8 7158.4 7316.3 7557.9 7831.8 8656.5 9954.9 10101.2 10656.7 11531.3 11533.2 04:54:32 INFO - PROCESS | 1950 | 04:54:32 INFO - PROCESS | 1950 | [#3] mootools.html Cycles:180 Average:5282.48 Median:5178.00 stddev:2870.96 (55.4%) stddev-sans-first:2862.81 04:54:32 INFO - PROCESS | 1950 | Values: 1224.3 1424.2 1431.0 1442.4 1445.9 7863.1 8121.6 8232.7 8254.7 8261.1 7309.3 7545.5 7553.3 7858.0 8157.0 2212.3 2258.7 2264.4 2267.3 2269.2 2240.7 2270.5 2278.5 2279.5 2283.2 1983.0 2047.0 2156.4 2202.9 2216.0 2224.9 2236.7 2239.7 2239.9 2243.1 2167.6 2221.7 2225.3 2225.6 2262.4 8146.3 8198.4 8207.3 8210.2 8261.5 4926.2 5082.4 5094.3 5117.9 5122.0 3231.2 3406.7 3407.9 3469.1 3480.2 1175.4 1212.7 1242.2 1255.8 1262.5 10490.7 10508.8 10514.2 10517.7 10535.3 4469.5 4563.5 4574.5 4623.9 4630.4 9269.1 9270.6 9272.3 9272.7 9277.6 5163.8 5169.7 5177.3 5178.7 5181.7 3943.8 4095.5 4344.8 4668.0 4755.4 3242.9 3711.3 3731.6 3779.2 3828.9 1069.7 1072.2 1252.3 1261.5 1263.8 807.5 836.2 837.1 869.4 924.8 5297.6 5316.8 5490.3 5534.8 5600.9 916.7 949.9 964.4 985.6 1022.3 3487.5 3717.4 3728.7 3732.3 3765.9 9177.6 9538.7 9631.8 9716.6 9726.8 9682.0 9693.9 9701.8 9705.2 9705.6 7485.6 7532.3 7586.4 7630.0 7676.1 4486.8 4925.7 5342.7 5345.3 5346.8 8556.2 8602.4 8913.7 9055.0 9058.9 8915.2 9056.8 9107.2 9185.0 9185.9 6471.8 6644.1 6842.7 6896.6 7028.1 7696.8 7791.5 7806.8 7810.0 7836.2 6784.8 6911.6 6918.5 6972.4 7011.4 6788.7 6814.9 6827.1 6880.5 6884.9 6143.4 6223.1 6273.4 6287.4 6302.1 4857.1 4880.8 4882.3 4936.5 4981.3 4799.0 4860.8 4913.1 4993.7 4999.2 04:54:32 INFO - PROCESS | 1950 | 04:54:32 INFO - PROCESS | 1950 | [#4] prototype.html Cycles:180 Average:4436.83 Median:4890.06 stddev:1366.89 (28.0%) stddev-sans-first:1335.27 04:54:32 INFO - PROCESS | 1950 | Values: 315.7 354.1 356.2 365.7 376.1 4500.6 5351.5 5428.6 5436.0 5487.4 4974.7 5040.4 5215.9 5218.9 5363.9 3324.8 4087.6 4132.8 4147.4 4187.3 4108.4 4128.9 4136.8 4139.6 4139.9 3080.0 3904.2 4020.4 4104.4 4110.3 3537.3 3542.4 4117.6 4122.0 4140.1 2962.9 3435.9 3506.9 3601.4 3616.2 5114.6 5117.0 5141.0 5143.8 5164.7 3762.8 4173.5 4565.1 4580.7 4585.5 5447.7 5456.5 5544.7 5577.2 5584.6 3562.4 3730.9 3753.9 3774.1 3799.9 4464.0 4898.4 5737.7 5814.5 5913.2 3848.5 3853.6 3864.6 3888.9 3897.4 3385.6 3807.6 3892.9 3894.3 3920.8 4268.3 4540.9 4556.9 4564.9 4577.9 5464.7 5635.2 5654.3 5656.1 5679.7 1175.9 1235.2 1269.6 1271.5 1277.9 723.4 811.2 819.2 820.6 839.5 4475.9 4841.5 4869.8 4876.4 4929.6 5244.7 5321.5 5324.5 5445.4 5450.3 4123.4 4392.0 4439.8 4881.8 5202.0 2399.0 2682.1 2723.4 2770.7 2849.8 4758.5 5127.8 5494.0 5583.5 5758.5 4537.6 4668.3 5825.3 5903.0 5903.3 4663.3 5221.6 5929.1 6028.9 6038.5 5001.5 5284.0 5292.0 5702.5 5801.7 4510.9 4690.2 5636.0 5711.6 5725.5 5137.2 5233.3 5834.5 5998.4 5999.4 3362.7 3691.4 3878.8 4112.5 4174.6 4866.8 5545.9 5610.8 5664.5 5793.2 5483.5 5514.1 5526.9 5581.9 5635.4 5337.3 5477.6 5495.8 5506.0 5595.9 4733.0 5010.8 5205.8 5319.8 5524.8 4554.5 4767.6 4957.2 5439.4 5447.9 4721.8 5118.5 5247.5 5425.8 5428.5 04:54:32 INFO - PROCESS | 1950 | 04:54:32 INFO - PROCESS | 1950 | [#5] yui.html Cycles:180 Average:20204.29 Median:23796.86 stddev:29013.78 (121.9%) stddev-sans-first:29058.20 04:54:32 INFO - PROCESS | 1950 | Values: 696.4 719.4 720.6 766.4 810.4 14735.4 15657.4 15738.1 15769.1 15771.8 14477.3 14633.1 14634.9 14636.8 14696.3 660.3 680.8 683.1 841.5 854.0 841.9 851.0 861.4 864.5 865.3 904.0 905.3 905.8 906.0 907.6 902.4 902.9 903.1 904.0 904.1 523.8 540.0 653.9 669.9 676.1 15460.8 15488.8 15491.5 15505.0 15508.1 13850.9 13870.3 13899.7 13930.6 13948.7 12427.2 12711.1 12726.9 12737.7 13069.3 4032.2 4068.4 4135.0 4184.9 4194.9 101854.0 104073.0 104786.0 105452.0 106885.0 9195.7 10801.5 11101.3 11259.8 11505.0 21372.6 21573.9 22572.0 22572.7 22600.0 7799.6 7849.1 7854.1 7915.3 7936.0 4084.5 4147.5 4407.8 4444.7 4445.2 3412.9 3434.9 3508.2 3512.7 3523.9 563.8 565.3 568.1 569.6 578.4 532.5 609.7 618.8 621.8 655.0 8890.5 9538.0 9616.6 9645.4 9706.1 546.5 554.6 594.4 631.4 633.8 4609.1 4632.2 4645.9 4649.8 4690.0 80461.0 94194.0 104516.0 106925.5 107340.0 73465.0 74000.0 93988.5 95027.5 97015.0 81744.0 83081.2 83108.0 83120.6 84284.6 9202.4 9297.6 9320.9 9324.5 9382.0 40366.0 42580.8 43185.9 53526.7 54940.0 53267.5 64753.0 65193.3 69047.3 69420.3 12522.2 12579.7 12802.9 12818.4 13510.5 14523.9 14593.3 14625.2 15170.6 15529.8 10137.5 10800.8 13443.5 13484.5 13773.4 12910.4 12988.1 13098.5 13507.5 13513.2 13421.3 13583.9 13588.2 13650.8 13958.5 7829.1 10837.3 10969.3 11266.7 11437.6 10002.8 10894.5 10910.9 10912.0 10930.1 04:54:32 INFO - PROCESS | 1950 | -------- Summary: end -------- 04:54:32 INFO - PROCESS | 1950 | 04:54:33 INFO - TEST-INFO | 1950: exit 0 04:54:33 INFO - TEST-OK | dromaeo_css | took 1120000ms 04:54:33 INFO - TEST-START | kraken 04:54:33 INFO - operating with platform_type : mac_ 04:54:33 INFO - Initialising browser for kraken test... 04:54:33 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpzoyk5o/profile http://localhost:51282/getInfo.html) 04:54:35 INFO - PROCESS | 1954 | __metrics Screen width/height:1600/1200 04:54:35 INFO - PROCESS | 1954 | colorDepth:24 04:54:35 INFO - PROCESS | 1954 | Browser inner width/height: 1024/689 04:54:35 INFO - PROCESS | 1954 | __metrics 04:54:35 INFO - PROCESS | 1954 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:54:35 INFO - PROCESS | 1954 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:54:36 INFO - TEST-INFO | 1954: exit 0 04:54:36 INFO - Browser initialized. 04:54:36 INFO - Running cycle 1/1 for kraken test... 04:54:36 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpzoyk5o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:48 INFO - PROCESS | 1956 | RSS: Main: 235503616 04:54:48 INFO - PROCESS | 1956 | 04:54:51 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51282/tests/kraken/driver.html?testName=audio-beat-detection) 04:54:52 INFO - PROCESS | 1956 | RSS: Main: 289378304 04:54:52 INFO - PROCESS | 1956 | 04:54:54 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51282/tests/kraken/driver.html?testName=audio-dft) 04:54:55 INFO - PROCESS | 1956 | RSS: Main: 288935936 04:54:55 INFO - PROCESS | 1956 | 04:54:58 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51282/tests/kraken/driver.html?testName=audio-fft) 04:54:59 INFO - PROCESS | 1956 | RSS: Main: 380104704 04:54:59 INFO - PROCESS | 1956 | 04:55:01 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51282/tests/kraken/driver.html?testName=audio-oscillator) 04:55:02 INFO - PROCESS | 1956 | RSS: Main: 282894336 04:55:02 INFO - PROCESS | 1956 | 04:55:04 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:55:04 INFO - PROCESS | 1956 | RSS: Main: 286363648 04:55:04 INFO - PROCESS | 1956 | 04:55:07 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51282/tests/kraken/driver.html?testName=imaging-darkroom) 04:55:08 INFO - PROCESS | 1956 | RSS: Main: 329957376 04:55:08 INFO - PROCESS | 1956 | 04:55:11 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51282/tests/kraken/driver.html?testName=imaging-desaturate) 04:55:11 INFO - PROCESS | 1956 | RSS: Main: 330727424 04:55:11 INFO - PROCESS | 1956 | 04:55:14 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51282/tests/kraken/driver.html?testName=json-parse-financial) 04:55:15 INFO - PROCESS | 1956 | RSS: Main: 327503872 04:55:15 INFO - PROCESS | 1956 | 04:55:16 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:55:17 INFO - PROCESS | 1956 | RSS: Main: 303427584 04:55:17 INFO - PROCESS | 1956 | 04:55:19 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51282/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:55:20 INFO - PROCESS | 1956 | RSS: Main: 308920320 04:55:20 INFO - PROCESS | 1956 | 04:55:22 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:55:22 INFO - PROCESS | 1956 | RSS: Main: 308842496 04:55:22 INFO - PROCESS | 1956 | 04:55:25 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:55:26 INFO - PROCESS | 1956 | RSS: Main: 328720384 04:55:26 INFO - PROCESS | 1956 | 04:55:29 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:55:30 INFO - PROCESS | 1956 | RSS: Main: 322797568 04:55:30 INFO - PROCESS | 1956 | 04:55:31 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:51282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51282/tests/kraken/driver.html?testName=ai-astar) 04:55:32 INFO - PROCESS | 1956 | RSS: Main: 368029696 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - PROCESS | 1956 | __start_tp_report 04:55:32 INFO - PROCESS | 1956 | _x_x_mozilla_page_load 04:55:32 INFO - PROCESS | 1956 | _x_x_mozilla_page_load_details 04:55:32 INFO - PROCESS | 1956 | |i|pagename|runs| 04:55:32 INFO - PROCESS | 1956 | |0;ai-astar;114;113;113;114;114;114;114;114;113;115 04:55:32 INFO - PROCESS | 1956 | |1;audio-beat-detection;141;111;109;147;113;109;109;112;130;108 04:55:32 INFO - PROCESS | 1956 | |2;audio-dft;186;181;184;186;185;188;181;187;196;183 04:55:32 INFO - PROCESS | 1956 | |3;audio-fft;80;58;59;88;61;58;59;58;74;58 04:55:32 INFO - PROCESS | 1956 | |4;audio-oscillator;90;70;84;69;68;94;120;97;68;83 04:55:32 INFO - PROCESS | 1956 | |5;imaging-gaussian-blur;92;88;91;89;91;88;92;89;91;88 04:55:32 INFO - PROCESS | 1956 | |6;imaging-darkroom;97;97;96;97;97;96;110;145;149;97 04:55:32 INFO - PROCESS | 1956 | |7;imaging-desaturate;88;87;86;86;86;88;86;85;88;86 04:55:32 INFO - PROCESS | 1956 | |8;json-parse-financial;57;56;55;54;54;55;56;55;55;55 04:55:32 INFO - PROCESS | 1956 | |9;json-stringify-tinderbox;67;76;82;76;74;71;73;73;72;73 04:55:32 INFO - PROCESS | 1956 | |10;stanford-crypto-aes;87;86;88;86;86;86;87;88;85;86 04:55:32 INFO - PROCESS | 1956 | |11;stanford-crypto-ccm;140;140;142;140;139;141;140;141;182;155 04:55:32 INFO - PROCESS | 1956 | |12;stanford-crypto-pbkdf2;201;175;172;174;172;173;175;174;173;187 04:55:32 INFO - PROCESS | 1956 | |13;stanford-crypto-sha256-iterative;68;68;68;68;66;66;67;67;66;65 04:55:32 INFO - PROCESS | 1956 | __end_tp_report 04:55:32 INFO - PROCESS | 1956 | __start_cc_report 04:55:32 INFO - PROCESS | 1956 | _x_x_mozilla_cycle_collect,1984 04:55:32 INFO - PROCESS | 1956 | __end_cc_report 04:55:32 INFO - PROCESS | 1956 | __startTimestamp1485521732065__endTimestamp 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - PROCESS | 1956 | ------- Summary: start ------- 04:55:32 INFO - PROCESS | 1956 | Number of tests: 14 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - PROCESS | 1956 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 04:55:32 INFO - PROCESS | 1956 | Values: 114.0 113.0 113.0 114.0 114.0 114.0 114.0 114.0 113.0 115.0 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - PROCESS | 1956 | [#1] audio-beat-detection Cycles:10 Average:118.90 Median:112.50 stddev:14.75 (13.1%) stddev-sans-first:13.31 04:55:32 INFO - PROCESS | 1956 | Values: 141.0 111.0 109.0 147.0 113.0 109.0 109.0 112.0 130.0 108.0 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - PROCESS | 1956 | [#2] audio-dft Cycles:10 Average:185.70 Median:186.00 stddev:4.32 (2.3%) stddev-sans-first:4.58 04:55:32 INFO - PROCESS | 1956 | Values: 186.0 181.0 184.0 186.0 185.0 188.0 181.0 187.0 196.0 183.0 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - PROCESS | 1956 | [#3] audio-fft Cycles:10 Average:65.30 Median:60.00 stddev:11.15 (18.6%) stddev-sans-first:10.48 04:55:32 INFO - PROCESS | 1956 | Values: 80.0 58.0 59.0 88.0 61.0 58.0 59.0 58.0 74.0 58.0 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - PROCESS | 1956 | [#4] audio-oscillator Cycles:10 Average:84.30 Median:83.50 stddev:16.78 (20.1%) stddev-sans-first:17.67 04:55:32 INFO - PROCESS | 1956 | Values: 90.0 70.0 84.0 69.0 68.0 94.0 120.0 97.0 68.0 83.0 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - PROCESS | 1956 | [#5] imaging-gaussian-blur Cycles:10 Average:89.90 Median:91.00 stddev:1.66 (1.8%) stddev-sans-first:1.58 04:55:32 INFO - PROCESS | 1956 | Values: 92.0 88.0 91.0 89.0 91.0 88.0 92.0 89.0 91.0 88.0 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - PROCESS | 1956 | [#6] imaging-darkroom Cycles:10 Average:108.10 Median:97.00 stddev:20.94 (21.6%) stddev-sans-first:21.82 04:55:32 INFO - PROCESS | 1956 | Values: 97.0 97.0 96.0 97.0 97.0 96.0 110.0 145.0 149.0 97.0 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - PROCESS | 1956 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:86.50 stddev:1.07 (1.2%) stddev-sans-first:1.01 04:55:32 INFO - PROCESS | 1956 | Values: 88.0 87.0 86.0 86.0 86.0 88.0 86.0 85.0 88.0 86.0 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - PROCESS | 1956 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.71 04:55:32 INFO - PROCESS | 1956 | Values: 57.0 56.0 55.0 54.0 54.0 55.0 56.0 55.0 55.0 55.0 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - PROCESS | 1956 | [#9] json-stringify-tinderbox Cycles:10 Average:73.70 Median:73.50 stddev:3.89 (5.3%) stddev-sans-first:3.28 04:55:32 INFO - PROCESS | 1956 | Values: 67.0 76.0 82.0 76.0 74.0 71.0 73.0 73.0 72.0 73.0 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - PROCESS | 1956 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.50 stddev:0.97 (1.1%) stddev-sans-first:1.01 04:55:32 INFO - PROCESS | 1956 | Values: 87.0 86.0 88.0 86.0 86.0 86.0 87.0 88.0 85.0 86.0 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - PROCESS | 1956 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:141.00 stddev:13.48 (9.6%) stddev-sans-first:14.12 04:55:32 INFO - PROCESS | 1956 | Values: 140.0 140.0 142.0 140.0 139.0 141.0 140.0 141.0 182.0 155.0 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - PROCESS | 1956 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.60 Median:174.50 stddev:9.31 (5.3%) stddev-sans-first:4.64 04:55:32 INFO - PROCESS | 1956 | Values: 201.0 175.0 172.0 174.0 172.0 173.0 175.0 174.0 173.0 187.0 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - PROCESS | 1956 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.50 stddev:1.10 (1.6%) stddev-sans-first:1.09 04:55:32 INFO - PROCESS | 1956 | Values: 68.0 68.0 68.0 68.0 66.0 66.0 67.0 67.0 66.0 65.0 04:55:32 INFO - PROCESS | 1956 | -------- Summary: end -------- 04:55:32 INFO - PROCESS | 1956 | 04:55:32 INFO - TEST-INFO | 1956: exit 0 04:55:32 INFO - TEST-OK | kraken | took 59945ms 04:55:32 INFO - SUITE-END | took 1179s 04:55:33 INFO - Completed test suite (00:19:40) 04:55:33 INFO - javascript benchmark 04:55:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7308.5135563740305, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3274.9999999999995, 3281.392942305673, 3289.8519566619516, 3299.884504042359, 3354.0, 5471.316085489314, 5586.10622300432, 5590.86022849429, 5615.073512870382, 5627.803026894059, 5563.165525171216, 5596.58025648077, 5612.0, 5612.66324020559, 5616.241807356006, 5028.84913452597, 5052.242163675442, 5067.113255180328, 5140.820071297505, 5145.202493613478, 5100.923486147711, 5171.301874246985, 5173.844784656466, 5174.068667639842, 5181.378234611851, 5111.948880511203, 5175.094358487268, 5181.274621552986, 5183.118869792125, 5184.559312458446, 5167.638265321429, 5170.379554453452, 5171.663841850268, 5175.767090480937, 5187.040397526451, 4944.678595891256, 5032.6477146599755, 5127.051495473349, 5132.923006154911, 5142.74286285688, 5557.666540007613, 5620.971895140539, 5622.3253209614695, 5666.433356664342, 5680.460356266148, 5952.315483719384, 6117.174181485487, 6126.877462450726, 6142.662153581551, 6155.353687862799, 6114.052321890114, 6126.540509461764, 6129.295131059896, 6186.536009799238, 6233.844153896189, 5741.397153298927, 5743.052396354638, 5743.1385292206505, 5750.827475175752, 5775.249217601769, 6330.0821380899515, 6333.841653958688, 6344.714487848058, 6347.333529979378, 6347.809565713036, 5835.095560188178, 5936.22829032223, 5940.168376427304, 5957.434043765836, 6050.031994880798, 6169.2288463942, 6184.041473571604, 6188.659623720739, 6192.0, 6211.254649442006, 6054.152418661391, 6099.512039036867, 6104.603200791934, 6117.082437634302, 6117.082437634391, 5933.376995415506, 6156.076588511759, 6159.876802464015, 6170.259568851677, 6183.84540386485, 4852.102361063144, 4868.391451068616, 4882.292067650171, 4910.950890491121, 4921.926171107436, 4342.717723348035, 4343.478782546114, 4359.04101097758, 4371.519132895379, 4400.757958312323, 5601.971990140023, 5616.326040875121, 5624.803131890364, 5629.0, 5631.802886898939, 6092.847678808065, 6113.32428171423, 6124.167343420691, 6166.506679465721, 6219.689015549205, 5586.13414920688, 5595.13275442299, 5619.044762390404, 5624.634398764068, 5651.576131790132, 5012.799488020439, 5324.961632481629, 5349.3580770307035, 5408.13469844823, 5413.350397952192, 6350.079238510298, 6350.809475715736, 6351.55539112267, 6351.587146835441, 6381.138546296191, 6255.343188965275, 6273.1844860167885, 6279.591826531261, 6280.309165991646, 6293.0, 6212.285587157354, 6250.312465628868, 6274.372562743689, 6319.05214217871, 6348.77779277723, 5989.101634754822, 6000.969995150171, 6004.639721616717, 6021.879562408815, 6023.909641355295, 4978.178600530872, 6039.154518367344, 6040.063790112539, 6047.9395206047375, 6058.666773327509, 5745.626534275259, 5881.4118588142555, 5899.233099697012, 5901.0558310670085, 5909.970450147722, 5735.197072409783, 5857.4435428634215, 5860.853478663067, 5878.559108066997, 5879.176915231957, 5725.0, 5758.971205143947, 5792.739326730223, 5795.39148389413, 5805.593608447368, 5940.138679891478, 5987.0, 5991.221141251609, 5993.880122397441, 5998.370171131968, 5843.357230704534, 5844.181814546052, 5854.502367298827, 5857.179994800646, 5859.326177489644], "value": 5609.690142562132, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.77275135183754, 480.58669544191997, 512.2776884592722, 513.460866090605, 522.0576858769919, 39241.80379098104, 41773.0, 41820.58179418205, 41889.58110418895, 41907.95230119248, 33787.32425351492, 34116.1470963226, 34176.829115854445, 43053.138937221236, 43152.352714709305, 9176.541172941359, 9472.763180920463, 9476.14714675679, 9491.715248542554, 9497.382670126453, 9335.0, 9344.06559344067, 9442.291828112884, 9466.053394660514, 9476.857847132298, 8349.833003339929, 8529.786755331104, 9460.337776355658, 9494.240460763156, 11035.0, 11175.21773475857, 11443.713907152305, 11460.025897798698, 11468.13988950832, 11469.197156199069, 11119.332840029625, 11196.664100076929, 11284.153688473316, 11287.040601548879, 11300.208985371028, 40401.595984040374, 40434.39348409776, 41477.79261103705, 41692.0, 41829.581704183176, 4040.898977525556, 4052.754567694556, 4075.612816782401, 4086.366613174963, 4203.747775133471, 30565.847170764227, 31341.8432907834, 31381.686183138103, 31403.05790826279, 31745.04764857058, 3148.3231105312466, 3193.265618477806, 3221.710046095839, 3234.2399536108996, 3325.866965321384, 452714.0, 455266.0, 455478.0, 455641.72179139225, 455712.0, 59690.403095969355, 59838.0, 60027.0, 60159.09761353583, 60212.39787602068, 60793.39206607877, 62795.6860215696, 63062.68468657627, 63130.0, 63214.41963950938, 15359.0, 15489.612759681098, 15493.535193944199, 15610.609734756721, 15828.28772705231, 12551.058670599741, 12605.180663256859, 12634.873651263553, 12642.367881605884, 12646.430910609044, 13572.35339108884, 16161.59596010109, 16172.191390430431, 16177.19114044293, 16224.918875405547, 5449.972750136303, 6535.281119076898, 6651.933480665228, 6656.267810540837, 6685.431738302299, 866.764860074404, 871.8299931513421, 872.6858331000834, 879.2570278114982, 903.20969151992, 30464.69535304663, 30466.84766576153, 30520.847395762878, 30533.694663053084, 31053.8447307762, 901.7880798012462, 1004.5579944824254, 1028.7376718936623, 1074.5003573338436, 1188.8216767484946, 14910.254487275593, 15622.921885390728, 15857.652099571435, 15873.04761714301, 15999.040057596581, 578984.4710870199, 584498.0, 584891.0755446281, 585211.0, 585382.0, 61370.69314653398, 61565.0, 61606.383936160964, 61711.691441542505, 61747.691261543405, 1371.4445649511963, 1412.413848252984, 1434.7274017936559, 1436.6767477317728, 1437.0802686280579, 29769.702302976693, 29792.10623681293, 30121.849390752905, 30199.0, 30697.0, 50182.749086254335, 50695.2395714072, 50734.49265507446, 50778.238326425875, 50893.0, 521289.7871021393, 523536.0, 523851.38074309385, 523957.0, 524282.0, 37854.24291514099, 39299.410508842964, 39744.20511589694, 39751.80124099477, 39781.20984555644, 46164.53835461737, 46819.76590117028, 46935.53064469448, 47105.2934205994, 47358.76320618375, 38238.85283441501, 38362.0409489765, 38544.807275964566, 39533.070039494305, 39725.60274397219, 38511.22977540489, 38731.0, 38969.610303896596, 39895.2020959585, 40313.59686403216, 38132.04669883275, 38221.61778382181, 38232.500474919885, 38673.41989870211, 38733.0, 31476.842615786776, 32722.34555308833, 33523.99428017066, 33624.82313119029, 33788.83105584457, 23976.442099283635, 24840.25479235626, 25017.499650006535, 25382.0, 25543.489130217662], "value": 20050.31832343578, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.682211708989, 393.1272574883759, 394.16043826649235, 401.66661670813227, 422.0693371116688, 14793.597803380855, 15368.846311536881, 18346.724799128006, 20672.793272067276, 21174.364769056916, 20801.16795328189, 21173.75378244941, 21454.463638409048, 21643.783562164375, 22052.88973555134, 5633.915491267624, 5748.2527271454865, 5972.492338151263, 6037.064255040454, 6037.305709843358, 6086.300075491331, 6146.17026701394, 6156.56904016719, 6164.660943648098, 6165.136880836686, 3369.9157521062048, 3681.079730067483, 6168.938310616903, 6328.841778955517, 7886.250806173404, 7685.923140768577, 7916.48542844719, 7942.483738556975, 7968.8804667929735, 7975.0, 7142.857142857166, 7265.636718164071, 7745.690172393098, 7767.0, 7794.3764498839955, 23820.496543588713, 29466.263343416373, 29798.851005745048, 30614.84692576545, 30647.846760766275, 2848.1597928610904, 2881.5821705852536, 2892.5950366948646, 2898.4637841999297, 2966.0656893078826, 16430.342786288533, 17228.0, 17365.652686946316, 17467.825321746874, 18036.819631803777, 1631.380075571287, 1795.2549691877855, 1920.9039548022542, 1982.0783335748945, 1993.1031036033698, 157458.0, 164081.0, 165067.17466412712, 165595.0, 169707.0, 23186.768132318797, 23260.41848953756, 23363.62636593593, 23602.7639723604, 24328.012757384695, 41329.0, 41386.72373019453, 41635.1672966545, 41708.165836683096, 41857.58142418598, 7481.877718342293, 7698.884516732253, 8288.50268983863, 8752.956235218782, 11075.224734268684, 8322.20939010793, 8341.04078031022, 8364.414490985573, 8499.61751721174, 8502.192291732275, 4684.086603112429, 4733.526647335308, 4755.215389460769, 4758.0, 4844.757762111951, 1694.4408345246038, 1699.9660006799795, 1824.324999750101, 1860.9299652699751, 2026.6757318828916, 941.6751220828803, 951.2912879904516, 956.086936975201, 997.1125698128672, 1004.7036124343336, 19377.4186774397, 20882.37352879416, 20883.895580522, 20885.68671469929, 21166.365009049754, 963.3016063354012, 975.4439969217619, 1006.6627679727374, 1021.5862575656871, 1032.8605638238741, 7814.726484573012, 10554.841677374845, 10772.730681732863, 10802.729931751612, 10821.621243256606, 709664.0, 711400.0, 725359.0, 730658.0, 734882.0, 104860.0, 107692.0, 118399.8160018406, 142587.0, 153714.0, 964.8118616869783, 984.2618036472645, 1027.0961553832578, 1064.9627263045757, 1069.2889228662852, 17936.91031544834, 18022.459326220236, 18142.54643633867, 18394.356197533023, 18456.446306610822, 58007.0, 58272.0, 58936.70531647314, 60038.399616003284, 60307.396926030175, 83464.0, 85877.57061214653, 88115.66380706834, 88215.1178488207, 89060.0, 7913.881291780513, 8221.54781487024, 8460.323174146177, 8474.872876906975, 8608.311335093304, 9445.0, 12937.805932911202, 13429.0, 13461.528846490326, 13498.730025399633, 10869.402182880018, 11163.330200188015, 11164.162687798285, 11238.606648767254, 11376.829347559958, 10865.728356791144, 10866.456677166268, 11140.721481963015, 11433.1996760226, 11456.083513318748, 11142.27575207609, 11271.0, 11325.263857849213, 11455.198136130724, 11556.826647600124, 7158.391536719437, 7316.341529262392, 7557.886631700639, 7831.804204894923, 8656.523891185794, 9954.900450995397, 10101.242406819665, 10656.667916510436, 11531.308121512737, 11533.192676512563], "value": 10682.938210142056, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1224.3082658298063, 1424.209563692151, 1430.9856901430983, 1442.4158215922548, 1445.8626430489103, 7863.095743989443, 8121.553314567696, 8232.711855085074, 8254.66981320748, 8261.13258107899, 7309.305615966488, 7545.547267163974, 7553.282438168365, 7857.960710196456, 8156.95921520393, 2212.281008672184, 2258.717660292455, 2264.4338915271182, 2267.251806903718, 2269.205777977711, 2240.73111226653, 2270.489139943516, 2278.5215104828007, 2279.4985103277254, 2283.2008796921027, 1982.9603407931834, 2046.9692954605694, 2156.4393257753018, 2202.878841663708, 2215.977840221601, 2224.8665080095166, 2236.6756820261135, 2239.708837851069, 2239.944001399962, 2243.05791567542, 2167.6423390140767, 2221.7444993825757, 2225.332400279926, 2225.5660146271484, 2262.3552287597954, 8146.26683598473, 8198.42611017229, 8207.343412526983, 8210.178982101801, 8261.463004904723, 4926.2118061110405, 5082.390113186441, 5094.337736094284, 5117.8720531987, 5121.975604879002, 3231.224506118538, 3406.659334066598, 3407.9318413631836, 3469.080693616194, 3480.2343484433386, 1175.4357908204024, 1212.7392610588765, 1242.1801610936739, 1255.7614053329837, 1262.5328628407456, 10490.737731556696, 10508.842367364496, 10514.158867290598, 10517.684469465928, 10535.315204511682, 4469.463664360298, 4563.520830312769, 4574.4968053514085, 4623.93064104032, 4630.3748993886065, 9269.073092690676, 9270.582823772811, 9272.30457715674, 9272.72181834546, 9277.58250878712, 5163.819266325736, 5169.689818610896, 5177.301064356339, 5178.689278643294, 5181.740912954413, 3943.802809859553, 4095.5494895561465, 4344.761038142869, 4667.9766601166775, 4755.358026666356, 3242.935141297161, 3711.3319602471815, 3731.552213734315, 3779.168582911755, 3828.942565861514, 1069.7325668582855, 1072.2494254022215, 1252.2987127208792, 1261.4890969157507, 1263.8420197475316, 807.5316316536395, 836.2097817562467, 837.0792128658427, 869.3827382558454, 924.7746735575389, 5297.576193904479, 5316.840494785162, 5490.3411590609385, 5534.7786088556, 5600.915986260209, 916.7478943290648, 949.924006079512, 964.4454438697777, 985.6451677396132, 1022.2844009193445, 3487.5466189395725, 3717.4052151655605, 3728.7203459740626, 3732.2588045202, 3765.8870233893026, 9177.632894684139, 9538.713838584854, 9631.759206019766, 9716.562754676057, 9726.756831079138, 9682.031796820262, 9693.854592181124, 9701.805963880683, 9705.175060119827, 9705.563249653782, 7485.588292643848, 7532.322091011835, 7586.393088552903, 7630.008098947102, 7676.078870535572, 4486.833423309898, 4925.704457732548, 5342.652727572696, 5345.278387417648, 5346.759395827119, 8556.229939305493, 8602.440841345293, 8913.732588022369, 9055.0, 9058.909410905806, 8915.197632213132, 9056.818863622822, 9107.180353768194, 9185.035571265189, 9185.862212066691, 6471.838204044749, 6644.10304608891, 6842.657867106525, 6896.620685862325, 7028.121484814398, 7696.8460630788195, 7791.454598178299, 7806.804829879298, 7809.960950195213, 7836.216378362118, 6784.830379240361, 6911.5853048817235, 6918.51570390088, 6972.442204623517, 7011.404030657452, 6788.66056697173, 6814.8637027260165, 6827.112475378368, 6880.518363714692, 6884.896726549206, 6143.416375444325, 6223.128761973237, 6273.404026617464, 6287.371262873676, 6302.054691796084, 4857.149998750134, 4880.804767809248, 4882.340883980617, 4936.506349365035, 4981.252812078217, 4798.95201047999, 4860.8298709545, 4913.115639184981, 4993.675411098412, 4999.175136102503], "value": 4300.7026795318625, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.7379375118652, 354.12354422803554, 356.1612402791426, 365.73118757713087, 376.1442717816968, 4500.617447516956, 5351.545118664913, 5428.647137936031, 5435.972820135894, 5487.42382049885, 4974.676646018015, 5040.42035165956, 5215.947840521593, 5218.921716174261, 5363.919541206876, 3324.833758312087, 4087.5912408759036, 4132.793360331986, 4147.398627199054, 4187.33002719565, 4108.424820525129, 4128.938065929014, 4136.834526618932, 4139.627433530982, 4139.94431419989, 3080.0431585677775, 3904.1650424300674, 4020.396940458925, 4104.363823607346, 4110.301248787713, 3537.2748586539697, 3542.4059173371957, 4117.629413352783, 4122.0214297137245, 4140.1098763765785, 2962.9333439961597, 3435.914102147441, 3506.912327191815, 3601.3877640800865, 3616.2044350242904, 5114.619052855745, 5116.974415127937, 5141.0, 5143.7685304161405, 5164.690118592859, 3762.849486020556, 4173.5409104998425, 4565.13262480131, 4580.725156490621, 4585.463869603686, 5447.727613619343, 5456.536194423479, 5544.695041772701, 5577.247071645316, 5584.636998595079, 3562.358775420423, 3730.869419570302, 3753.868614598476, 3774.0942173878348, 3799.9430008549894, 4463.977680111611, 4898.363212782316, 5737.713114344266, 5814.5057670098095, 5913.172155898178, 3848.499695039627, 3853.5953724859046, 3864.632859878307, 3888.902777430587, 3897.3569361055106, 3385.5598772159956, 3807.629253468749, 3892.9416058759143, 3894.2600905827803, 3920.7647541147053, 4268.317069268902, 4540.88647783808, 4556.908861822745, 4564.908701826012, 4577.939927032849, 5464.726763661801, 5635.21107045014, 5654.321481422256, 5656.123300888369, 5679.659220446786, 1175.8530183727034, 1235.234154824015, 1269.5780725587401, 1271.4914034386134, 1277.881853378294, 723.4357201382825, 811.2293321344746, 819.2381085590458, 820.5609998650693, 839.4669384940606, 4475.932861007088, 4841.540053694894, 4869.829555965524, 4876.366072410635, 4929.598576981871, 5244.744759753266, 5321.5476684482255, 5324.494173053554, 5445.37378201504, 5450.31871016123, 4123.443335149776, 4391.956080439219, 4439.822407103744, 4881.755912204376, 5202.0116177926075, 2398.9640155397683, 2682.061278552491, 2723.414465889843, 2770.667519897625, 2849.843258620796, 4758.452777930513, 5127.769250383742, 5494.0, 5583.469570390806, 5758.510526605201, 4537.593346062731, 4668.323093151474, 5825.271841019872, 5903.0, 5903.26209223847, 4663.300504924288, 5221.6083793715625, 5929.110633404937, 6028.914795336794, 6038.456538911519, 5001.474845141208, 5284.044903385772, 5291.989044163193, 5702.51528620072, 5801.680907550125, 4510.932336015028, 4690.249560070372, 5636.0, 5711.571632127524, 5725.513331366714, 5137.2037334213255, 5233.293505376725, 5834.453869724442, 5998.430149135826, 5999.400059993965, 3362.7309815215212, 3691.3640064535875, 3878.8060596970604, 4112.547619761764, 4174.645155161846, 4866.8365562383315, 5545.944540554543, 5610.831675049755, 5664.518515926193, 5793.217915581343, 5483.479069488392, 5514.145307477347, 5526.944730552643, 5581.888362232814, 5635.380108188014, 5337.306150200604, 5477.589180811535, 5495.807646732345, 5505.972470137784, 5595.9295060826125, 4732.965469026881, 5010.799568017239, 5205.791768329376, 5319.803044314998, 5524.8342549723575, 4554.499005109369, 4767.642426818072, 4957.157283261782, 5439.401665816836, 5447.859626683669, 4721.787519561559, 5118.539331460186, 5247.475252474722, 5425.755840987086, 5428.457154284698], "value": 4010.5372177432905, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.4324075878155, 719.4244604316546, 720.578461599964, 766.3524321947956, 810.4124509730447, 14735.410583576657, 15657.355977622357, 15738.134402607851, 15769.053856768587, 15771.842281577196, 14477.348519316629, 14633.122012679247, 14634.926825365885, 14636.780448293284, 14696.265186740673, 660.326467003656, 680.8400025993888, 683.1324218242829, 841.4782834642515, 853.9615717292737, 841.877927700483, 850.9659613615479, 861.4314552395421, 864.4769914201912, 865.3164000439646, 904.0326850270213, 905.3210092430677, 905.8097799462121, 905.9988712472689, 907.6097278170384, 902.3818684201277, 902.9322800789935, 903.0923921458957, 903.9593218305192, 904.1094521895927, 523.8061917090663, 539.9865003374907, 653.8888388973838, 669.9095622091004, 676.1480534526532, 15460.768088478682, 15488.838337124647, 15491.457798976982, 15504.992175508669, 15508.069515828973, 13850.930745346208, 13870.306484675726, 13899.652508687263, 13930.58208253754, 13948.721025579533, 12427.192232504858, 12711.110222284444, 12726.936365318206, 12737.745245095046, 13069.281189534571, 4032.153765034748, 4068.3897415387632, 4135.0, 4184.853530126461, 4194.874153775361, 101854.0, 104073.0, 104785.95214047839, 105452.0, 106885.0, 9195.724128276162, 10801.513931873085, 11101.278416902875, 11259.831102533468, 11505.0, 21372.572548548942, 21573.892130539247, 22572.0, 22572.66141007886, 22599.983000764678, 7799.649015794303, 7849.058113026359, 7854.136045035041, 7915.287624113857, 7935.960320198362, 4084.509858816961, 4147.502299724052, 4407.801648925806, 4444.73331600105, 4445.155420470101, 3412.9317413652084, 3434.8969530914114, 3508.245727168671, 3512.7365447591533, 3523.8590456381457, 563.7632194478329, 565.2651552981108, 568.0712035821462, 569.6354333226739, 578.3811321885543, 532.5446743034727, 609.6524980761012, 618.780332981794, 621.8445388652837, 654.9934500655028, 8890.507380488038, 9537.952310238543, 9616.615335386647, 9645.37305075168, 9706.077922597342, 546.4999525434183, 554.6090006545376, 594.402625361509, 631.3844002097918, 633.8478765096344, 4609.1473077480105, 4632.2356811126465, 4645.907081858411, 4649.767511624405, 4689.976550117228, 80461.0, 94194.0, 104516.0, 106925.46537267264, 107340.0, 73465.0, 74000.0, 93988.53005734927, 95027.52486237524, 97015.0, 81744.0, 83081.16918830856, 83108.0, 83120.58439707763, 84284.57857710918, 9202.447853128833, 9297.628094876129, 9320.928093269089, 9324.487153206639, 9382.0, 40365.990850228976, 42580.78709606432, 43185.92035199145, 53526.73236633948, 54940.03369511318, 53267.46732532625, 64753.0, 65193.34806651873, 69047.3095269061, 69420.30579694138, 12522.186057906207, 12579.685507862378, 12802.871971280541, 12818.359082045674, 13510.459581616626, 14523.927380363031, 14593.270336482921, 14625.195614241318, 15170.620734481727, 15529.84470155284, 10137.543810528692, 10800.783984320113, 13443.46226150943, 13484.528041518892, 13773.38019789132, 12910.354482275661, 12988.090833641554, 13098.469707365062, 13507.459701611826, 13513.189208647513, 13421.328933553088, 13583.86416135826, 13588.184708917497, 13650.822140456556, 13958.45070071444, 7829.103777564989, 10837.349759014485, 10969.341839489656, 11266.66200013968, 11437.599684011353, 10002.849957250794, 10894.50974706156, 10910.890891090987, 10912.0, 10930.070943969851], "value": 7352.414638922785, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 111.0, 109.0, 147.0, 113.0, 109.0, 109.0, 112.0, 130.0, 108.0], "value": 118.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 181.0, 184.0, 186.0, 185.0, 188.0, 181.0, 187.0, 196.0, 183.0], "value": 185.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 88.0, 61.0, 58.0, 59.0, 58.0, 74.0, 58.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 84.0, 69.0, 68.0, 94.0, 120.0, 97.0, 68.0, 83.0], "value": 84.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 91.0, 89.0, 91.0, 88.0, 92.0, 89.0, 91.0, 88.0], "value": 89.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 97.0, 97.0, 96.0, 110.0, 145.0, 149.0, 97.0], "value": 108.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 86.0, 86.0, 86.0, 88.0, 86.0, 85.0, 88.0, 86.0], "value": 86.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 54.0, 54.0, 55.0, 56.0, 55.0, 55.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 76.0, 82.0, 76.0, 74.0, 71.0, 73.0, 73.0, 72.0, 73.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 88.0, 86.0, 86.0, 86.0, 87.0, 88.0, 85.0, 86.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 142.0, 140.0, 139.0, 141.0, 140.0, 141.0, 182.0, 155.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 175.0, 172.0, 174.0, 172.0, 173.0, 175.0, 174.0, 173.0, 187.0], "value": 177.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 66.0, 66.0, 67.0, 67.0, 66.0, 65.0], "value": 66.9, "unit": "score"}]}]} 04:55:33 INFO - Return code: 0 04:55:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:55:33 ERROR - # TBPL SUCCESS # 04:55:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:55:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:55:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:55:33 INFO - 2017-01-27 04:55:33.354 screenresolution[1960:15346] starting screenresolution argv=screenresolution get 04:55:33 INFO - 2017-01-27 04:55:33.357 screenresolution[1960:15346] Display 0: 1600x1200x32@60 04:55:33 INFO - 2017-01-27 04:55:33.363 screenresolution[1961:15349] starting screenresolution argv=screenresolution list 04:55:33 INFO - Available Modes on Display 0 04:55:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:55:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:55:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:55:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:55:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:55:33 INFO - Intel Iris: 04:55:33 INFO - Chipset Model: Intel Iris 04:55:33 INFO - Type: GPU 04:55:33 INFO - Bus: Built-In 04:55:33 INFO - VRAM (Dynamic, Max): 1536 MB 04:55:33 INFO - Vendor: Intel (0x8086) 04:55:33 INFO - Device ID: 0x0a2e 04:55:33 INFO - Revision ID: 0x0009 04:55:33 INFO - Displays: 04:55:33 INFO - Display: 04:55:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:55:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:55:33 INFO - Display Serial Number: 1600x1200 60 04:55:33 INFO - Main Display: Yes 04:55:33 INFO - Mirror: Off 04:55:33 INFO - Online: Yes 04:55:33 INFO - Rotation: Supported 04:55:33 INFO - Return code: 0 04:55:33 INFO - Running post-action listener: _resource_record_post_action 04:55:33 INFO - [mozharness: 2017-01-27 12:55:33.600704Z] Finished run-tests step (success) 04:55:33 INFO - Running post-run listener: _resource_record_post_run 04:55:33 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 815104; Write bytes: 551327232; Read time: 9; Write time: 1641 04:55:33 INFO - TinderboxPrint: CPU usage
53.5% 04:55:33 INFO - TinderboxPrint: I/O read bytes / time
815,104 / 9 04:55:33 INFO - TinderboxPrint: I/O write bytes / time
551,327,232 / 1,641 04:55:33 INFO - TinderboxPrint: CPU idle
2,236.8 (46.5%) 04:55:33 INFO - TinderboxPrint: CPU system
960.0 (19.9%) 04:55:33 INFO - TinderboxPrint: CPU user
1,616.9 (33.6%) 04:55:33 INFO - TinderboxPrint: Swap in / out
253,206,528 / 0 04:55:33 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 233726464; Write bytes: 227927552; Read time: 17417; Write time: 496 04:55:33 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 815104; Write bytes: 296456192; Read time: 9; Write time: 1080 04:55:34 INFO - Running post-run listener: _upload_blobber_files 04:55:34 INFO - Blob upload gear active. 04:55:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:55:34 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 04:55:34 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'] 04:55:34 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 04:55:34 INFO - (blobuploader) - INFO - Open directory for files ... 04:55:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:55:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:55:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:35 INFO - (blobuploader) - INFO - Done attempting. 04:55:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:55:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:55:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:36 INFO - (blobuploader) - INFO - Done attempting. 04:55:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:55:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:55:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:37 INFO - (blobuploader) - INFO - Done attempting. 04:55:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:55:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:55:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:40 INFO - (blobuploader) - INFO - Done attempting. 04:55:40 INFO - (blobuploader) - INFO - Iteration through files over. 04:55:40 INFO - Return code: 0 04:55:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:55:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:55:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/befeb5bca837814b053eb2c3eacbc2099d04a78816290c8a5f5b06ee3a8b9ede92e8ab8473c733d3458067b901e50cd0bb0d2cdfb79b2ff52c71fb61f7303e64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c4e21b2c32a99a55fbe116a19ca78e7b1a50176feb07abf3815618806225339578a84a1e7db6804368cd9c36af5dc922bdcabbf5e221a36159ba8f214e37f03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/727269d7639150b1a32f63ea8ccfebe05fd219c11efce1b5b21bfc1dc1d9de23212f88670648b8915e6ce8d5d532c463df9f381afb9eea4b964d8961d05288cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dad300beb810d7185194948f69b902bc7acf2bf308b0270d4e7627dafe290161ee3927311ce934473a0eaac527b86de8f0bfb81e3f262430f759fa91ae36220"} 04:55:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:55:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:55:40 INFO - Contents: 04:55:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/befeb5bca837814b053eb2c3eacbc2099d04a78816290c8a5f5b06ee3a8b9ede92e8ab8473c733d3458067b901e50cd0bb0d2cdfb79b2ff52c71fb61f7303e64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c4e21b2c32a99a55fbe116a19ca78e7b1a50176feb07abf3815618806225339578a84a1e7db6804368cd9c36af5dc922bdcabbf5e221a36159ba8f214e37f03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/727269d7639150b1a32f63ea8ccfebe05fd219c11efce1b5b21bfc1dc1d9de23212f88670648b8915e6ce8d5d532c463df9f381afb9eea4b964d8961d05288cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dad300beb810d7185194948f69b902bc7acf2bf308b0270d4e7627dafe290161ee3927311ce934473a0eaac527b86de8f0bfb81e3f262430f759fa91ae36220"} 04:55:40 INFO - Running post-run listener: copy_logs_to_upload_dir 04:55:40 INFO - Copying logs to upload dir... 04:55:40 INFO - mkdir: /builds/slave/test/build/upload/logs 04:55:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.310167 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-27 04:55:40.297192) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 04:55:40.300776) ========= 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.SgHYSBQLX0/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.ay6OGrePVs/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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/befeb5bca837814b053eb2c3eacbc2099d04a78816290c8a5f5b06ee3a8b9ede92e8ab8473c733d3458067b901e50cd0bb0d2cdfb79b2ff52c71fb61f7303e64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c4e21b2c32a99a55fbe116a19ca78e7b1a50176feb07abf3815618806225339578a84a1e7db6804368cd9c36af5dc922bdcabbf5e221a36159ba8f214e37f03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/727269d7639150b1a32f63ea8ccfebe05fd219c11efce1b5b21bfc1dc1d9de23212f88670648b8915e6ce8d5d532c463df9f381afb9eea4b964d8961d05288cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dad300beb810d7185194948f69b902bc7acf2bf308b0270d4e7627dafe290161ee3927311ce934473a0eaac527b86de8f0bfb81e3f262430f759fa91ae36220"} build_url:https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010355 build_url: 'https://queue.taskcluster.net/v1/task/dHwTqgZ2Q0ez-24BKJfeRw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/befeb5bca837814b053eb2c3eacbc2099d04a78816290c8a5f5b06ee3a8b9ede92e8ab8473c733d3458067b901e50cd0bb0d2cdfb79b2ff52c71fb61f7303e64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c4e21b2c32a99a55fbe116a19ca78e7b1a50176feb07abf3815618806225339578a84a1e7db6804368cd9c36af5dc922bdcabbf5e221a36159ba8f214e37f03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/727269d7639150b1a32f63ea8ccfebe05fd219c11efce1b5b21bfc1dc1d9de23212f88670648b8915e6ce8d5d532c463df9f381afb9eea4b964d8961d05288cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dad300beb810d7185194948f69b902bc7acf2bf308b0270d4e7627dafe290161ee3927311ce934473a0eaac527b86de8f0bfb81e3f262430f759fa91ae36220"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 04:55:40.333337) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 04:55:40.333673) ========= 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.SgHYSBQLX0/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.ay6OGrePVs/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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.005084 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 04:55:40.382284) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 04:55:40.382614) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 04:55:40.382941) ========= ========= Total master_lag: 0.18 =========