builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0111 starttime: 1479390338.95 results: success (0) buildid: 20161117030212 builduid: c298b52a4b464d9ea352f6c8ae53d8d8 revision: 13f49da109ea460665ad27c8497cb1489548450c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 05:45:38.953504) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 05:45:38.954133) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 05:45:38.954459) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 05:45:38.987302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:45:38.987671) ========= 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.szTvSjwsHp/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.4bByzQap69/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-17 05:45:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.9M=0.001s 2016-11-17 05:45:39 (13.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126368 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:45:39.136372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:45:39.136682) ========= 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.szTvSjwsHp/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.4bByzQap69/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.026563 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:45:39.187276) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:45:39.187592) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 13f49da109ea460665ad27c8497cb1489548450c --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 13f49da109ea460665ad27c8497cb1489548450c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.szTvSjwsHp/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.4bByzQap69/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-17 05:45:39,286 truncating revision to first 12 chars 2016-11-17 05:45:39,286 Setting DEBUG logging. 2016-11-17 05:45:39,286 attempt 1/10 2016-11-17 05:45:39,286 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/13f49da109ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 05:45:39,737 unpacking tar archive at: mozilla-central-13f49da109ea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.730386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 05:45:39.942531) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 05:45:39.945885) ========= script_repo_revision: 13f49da109ea460665ad27c8497cb1489548450c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 05:45:39.946318) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 05:45:39.946591) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 05:45:39.965018) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-17 05:45:39.965402) ========= /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.szTvSjwsHp/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.4bByzQap69/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 05:45:40 INFO - MultiFileLogger online at 20161117 05:45:40 in /builds/slave/test 05:45:40 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 05:45:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:45:40 INFO - {'append_to_log': False, 05:45:40 INFO - 'base_work_dir': '/builds/slave/test', 05:45:40 INFO - 'blob_upload_branch': 'Firefox', 05:45:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:45:40 INFO - 'branch': 'Firefox', 05:45:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:40 INFO - 'config_files': ('talos/mac_config.py',), 05:45:40 INFO - 'default_actions': ('clobber', 05:45:40 INFO - 'read-buildbot-config', 05:45:40 INFO - 'download-and-extract', 05:45:40 INFO - 'populate-webroot', 05:45:40 INFO - 'create-virtualenv', 05:45:40 INFO - 'install', 05:45:40 INFO - 'run-tests'), 05:45:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:40 INFO - 'download_minidump_stackwalk': True, 05:45:40 INFO - 'download_symbols': 'ondemand', 05:45:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:40 INFO - 'installer_path': 'installer.exe', 05:45:40 INFO - 'log_level': 'info', 05:45:40 INFO - 'log_name': 'talos', 05:45:40 INFO - 'log_to_console': True, 05:45:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:45:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:45:40 INFO - 'opt_config_files': (), 05:45:40 INFO - 'pip_index': False, 05:45:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:45:40 INFO - 'cmd': ('bash', 05:45:40 INFO - '-c', 05:45:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:45:40 INFO - 'enabled': True, 05:45:40 INFO - 'halt_on_failure': False, 05:45:40 INFO - 'name': 'check_screen_resolution'},), 05:45:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:45:40 INFO - 'cmd': ('bash', 05:45:40 INFO - '-c', 05:45:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:45:40 INFO - 'enabled': True, 05:45:40 INFO - 'halt_on_failure': False, 05:45:40 INFO - 'name': 'check_screen_resolution'},), 05:45:40 INFO - 'run_cmd_checks_enabled': True, 05:45:40 INFO - 'sps_profile': False, 05:45:40 INFO - 'sps_profile_interval': 0, 05:45:40 INFO - 'suite': 'dromaeojs', 05:45:40 INFO - 'system_bits': '32', 05:45:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:40 INFO - 'title': 't-yosemite-r7-0111', 05:45:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:40 INFO - 'use_talos_json': True, 05:45:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:45:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:40 INFO - 'work_dir': 'build'} 05:45:40 INFO - [mozharness: 2016-11-17 13:45:40.175074Z] Running clobber step. 05:45:40 INFO - Running pre-action listener: _resource_record_pre_action 05:45:40 INFO - Running main action method: clobber 05:45:40 INFO - rmtree: /builds/slave/test/build 05:45:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:45:42 INFO - Running post-action listener: _resource_record_post_action 05:45:42 INFO - [mozharness: 2016-11-17 13:45:42.598008Z] Finished clobber step (success) 05:45:42 INFO - [mozharness: 2016-11-17 13:45:42.598139Z] Running read-buildbot-config step. 05:45:42 INFO - Running pre-action listener: _resource_record_pre_action 05:45:42 INFO - Running main action method: read_buildbot_config 05:45:42 INFO - Using buildbot properties: 05:45:42 INFO - { 05:45:42 INFO - "project": "", 05:45:42 INFO - "product": "firefox", 05:45:42 INFO - "script_repo_revision": "production", 05:45:42 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:45:42 INFO - "repository": "", 05:45:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:45:42 INFO - "buildid": "20161117030212", 05:45:42 INFO - "stage_platform": "macosx64", 05:45:42 INFO - "basedir": "/builds/slave/test", 05:45:42 INFO - "nightly_build": "True", 05:45:42 INFO - "buildnumber": 25, 05:45:42 INFO - "slavename": "t-yosemite-r7-0111", 05:45:42 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:45:42 INFO - "platform": "yosemite_r7", 05:45:42 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:45:42 INFO - "branch": "mozilla-central", 05:45:42 INFO - "repo_path": "mozilla-central", 05:45:42 INFO - "revision": "13f49da109ea460665ad27c8497cb1489548450c", 05:45:42 INFO - "pgo_build": "False", 05:45:42 INFO - "builduid": "c298b52a4b464d9ea352f6c8ae53d8d8", 05:45:42 INFO - "slavebuilddir": "test" 05:45:42 INFO - } 05:45:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 05:45:42 INFO - Running post-action listener: _resource_record_post_action 05:45:42 INFO - [mozharness: 2016-11-17 13:45:42.601461Z] Finished read-buildbot-config step (success) 05:45:42 INFO - [mozharness: 2016-11-17 13:45:42.601594Z] Running download-and-extract step. 05:45:42 INFO - Running pre-action listener: _resource_record_pre_action 05:45:42 INFO - Running main action method: download_and_extract 05:45:42 INFO - mkdir: /builds/slave/test/build/tests 05:45:42 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')]} 05:45:42 INFO - trying https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 05:45:42 INFO - Downloading https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:45:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 05:45:44 INFO - Downloaded 1199 bytes. 05:45:44 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 05:45:44 INFO - Using the following test package requirements: 05:45:44 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:45:44 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:45:44 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 05:45:44 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:45:44 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 05:45:44 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:45:44 INFO - u'jsshell-mac.zip'], 05:45:44 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:45:44 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 05:45:44 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 05:45:44 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:45:44 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 05:45:44 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:45:44 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 05:45:44 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:45:44 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 05:45:44 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 05:45:44 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 05:45:44 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:45:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:45:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:45:44 INFO - Fetch https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:45:44 INFO - Http code: 200 05:45:44 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 05:45:44 INFO - x-amz-cf-id: at6SHwBgTbONBYTcD4OtBNaRxMRdpOIGG3aMctKi0blsdsp7NG0MPg== 05:45:44 INFO - x-amz-version-id: 5nwTwTv3uUsT3JHyCUQLAOH6tCbKURlk 05:45:44 INFO - Expected file size: 16273550 05:45:44 INFO - Obtained file size: 16273550 05:45:51 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:45:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 05:45:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:45:51 INFO - Fetch https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 05:45:52 INFO - Http code: 200 05:45:52 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 05:45:52 INFO - x-amz-cf-id: g2Ygax9r8VDyVrzZI5EDZZY4xkRsWuYTT5eLzIGbl-blDcmMZyCaAw== 05:45:52 INFO - x-amz-version-id: 5nwTwTv3uUsT3JHyCUQLAOH6tCbKURlk 05:45:52 INFO - Expected file size: 16273550 05:45:52 INFO - Obtained file size: 16273550 05:45:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 05:45:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:45:58 INFO - Fetch https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 05:45:59 INFO - Http code: 200 05:45:59 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 05:45:59 INFO - x-amz-cf-id: qHNiQ2eVOvLGWlX2G01d6Bw9qF2JGveoxTD4tLu-vzgEPYHpnUqDSQ== 05:45:59 INFO - x-amz-version-id: SN272BGxZCqEwR38b36OmXBPUR1rGDmh 05:46:00 INFO - Expected file size: 14409389 05:46:00 INFO - Obtained file size: 14409389 05:46:00 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')]} 05:46:00 INFO - trying https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:46:00 INFO - Downloading https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 05:46:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 05:46:03 INFO - Downloaded 111126680 bytes. 05:46:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:46:03 INFO - mkdir: /builds/slave/test/properties 05:46:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:46:03 INFO - Writing to file /builds/slave/test/properties/build_url 05:46:03 INFO - Contents: 05:46:03 INFO - build_url:https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 05:46:03 INFO - Running post-action listener: _resource_record_post_action 05:46:03 INFO - Running post-action listener: set_extra_try_arguments 05:46:03 INFO - [mozharness: 2016-11-17 13:46:03.915360Z] Finished download-and-extract step (success) 05:46:03 INFO - [mozharness: 2016-11-17 13:46:03.915501Z] Running populate-webroot step. 05:46:03 INFO - Running pre-action listener: _resource_record_pre_action 05:46:03 INFO - Running main action method: populate_webroot 05:46:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:46:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:46:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:46:03 INFO - '--tppagecycles', 05:46:03 INFO - '7'], 05:46:03 INFO - 'tests': ['tsvgm']}}, 05:46:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:46:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:46:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:46:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:46:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:46:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:46:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:46:03 INFO - 'talos_options': ['--disable-e10s'], 05:46:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:46:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:46:03 INFO - 'talos_options': ['--disable-e10s'], 05:46:03 INFO - 'tests': ['damp', 'tps']}, 05:46:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:46:03 INFO - 'tests': ['damp', 'tps']}, 05:46:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:46:03 INFO - 'tests': ['dromaeo_dom']}, 05:46:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:46:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:46:03 INFO - 'tests': ['basic_compositor_video']}, 05:46:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:46:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:46:03 INFO - 'tests': ['a11yr', 05:46:03 INFO - 'ts_paint', 05:46:03 INFO - 'tpaint', 05:46:03 INFO - 'sessionrestore', 05:46:03 INFO - 'sessionrestore_no_auto_restore', 05:46:03 INFO - 'tabpaint']}, 05:46:03 INFO - 'other-e10s': {'tests': ['a11yr', 05:46:03 INFO - 'ts_paint', 05:46:03 INFO - 'tpaint', 05:46:03 INFO - 'sessionrestore', 05:46:03 INFO - 'sessionrestore_no_auto_restore', 05:46:03 INFO - 'tabpaint']}, 05:46:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:46:03 INFO - 'ts_paint', 05:46:03 INFO - 'tpaint', 05:46:03 INFO - 'sessionrestore', 05:46:03 INFO - 'sessionrestore_no_auto_restore', 05:46:03 INFO - 'tabpaint']}, 05:46:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:46:03 INFO - 'ts_paint', 05:46:03 INFO - 'tpaint', 05:46:03 INFO - 'sessionrestore', 05:46:03 INFO - 'sessionrestore_no_auto_restore', 05:46:03 INFO - 'tabpaint']}, 05:46:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:46:03 INFO - 'tests': ['a11yr', 05:46:03 INFO - 'ts_paint', 05:46:03 INFO - 'tpaint', 05:46:03 INFO - 'sessionrestore', 05:46:03 INFO - 'sessionrestore_no_auto_restore', 05:46:03 INFO - 'tabpaint']}, 05:46:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:46:03 INFO - 'tests': ['a11yr', 05:46:03 INFO - 'ts_paint', 05:46:03 INFO - 'tpaint', 05:46:03 INFO - 'sessionrestore', 05:46:03 INFO - 'sessionrestore_no_auto_restore', 05:46:03 INFO - 'tabpaint']}, 05:46:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:46:03 INFO - 'tests': ['tsvgx', 05:46:03 INFO - 'tsvgr_opacity', 05:46:03 INFO - 'tart', 05:46:03 INFO - 'tscrollx', 05:46:03 INFO - 'cart']}, 05:46:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:46:03 INFO - 'tsvgr_opacity', 05:46:03 INFO - 'tart', 05:46:03 INFO - 'tscrollx', 05:46:03 INFO - 'cart']}, 05:46:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:46:03 INFO - 'talos_options': ['--disable-e10s'], 05:46:03 INFO - 'tests': ['tp5o']}, 05:46:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:46:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:46:03 INFO - 'talos_options': ['--disable-e10s', 05:46:03 INFO - '--xperf_path', 05:46:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:03 INFO - 'tests': ['tp5n']}, 05:46:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:46:03 INFO - 'talos_options': ['--xperf_path', 05:46:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:03 INFO - 'tests': ['tp5n']}}, 05:46:03 INFO - 'talos.zip': {'path': '', 05:46:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:46:03 INFO - Running post-action listener: _resource_record_post_action 05:46:03 INFO - [mozharness: 2016-11-17 13:46:03.934207Z] Finished populate-webroot step (success) 05:46:03 INFO - [mozharness: 2016-11-17 13:46:03.934335Z] Running create-virtualenv step. 05:46:03 INFO - Running pre-action listener: _resource_record_pre_action 05:46:03 INFO - Running main action method: create_virtualenv 05:46:03 INFO - Creating virtualenv /builds/slave/test/build/venv 05:46:03 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 05:46:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:46:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:46:04 INFO - Using real prefix '/tools/python27' 05:46:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:46:04 INFO - Installing distribute.............................................................................................................................................................................................done. 05:46:07 INFO - Installing pip.................done. 05:46:07 INFO - Return code: 0 05:46:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:46:07 INFO - Reading from file tmpfile_stdout 05:46:07 INFO - Output received: 05:46:07 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) 05:46:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:07 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 0x107f5c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ed2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff86057e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d72d30>, '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 0x107bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d6ab20>, '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.szTvSjwsHp/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.4bByzQap69/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 05:46:07 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 05:46:07 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 05:46:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.szTvSjwsHp/Render', 05:46:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:07 INFO - 'HOME': '/Users/cltbld', 05:46:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:07 INFO - 'LOGNAME': 'cltbld', 05:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:07 INFO - 'MOZ_NO_REMOTE': '1', 05:46:07 INFO - 'NO_EM_RESTART': '1', 05:46:07 INFO - 'PAGER': '/bin/cat', 05:46:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:07 INFO - 'PWD': '/builds/slave/test', 05:46:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:07 INFO - 'SHELL': '/bin/bash', 05:46:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4bByzQap69/Listeners', 05:46:07 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 05:46:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:07 INFO - 'USER': 'cltbld', 05:46:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:07 INFO - 'XPC_FLAGS': '0x0', 05:46:07 INFO - 'XPC_SERVICE_NAME': '0', 05:46:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:08 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 05:46:08 INFO - Cleaning up... 05:46:08 INFO - Return code: 0 05:46:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:46:08 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')]} 05:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:08 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')]} 05:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:08 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 0x107f5c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ed2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff86057e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d72d30>, '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 0x107bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d6ab20>, '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.szTvSjwsHp/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.4bByzQap69/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 05:46:08 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 05:46:08 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 05:46:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.szTvSjwsHp/Render', 05:46:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:08 INFO - 'HOME': '/Users/cltbld', 05:46:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:08 INFO - 'LOGNAME': 'cltbld', 05:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:08 INFO - 'MOZ_NO_REMOTE': '1', 05:46:08 INFO - 'NO_EM_RESTART': '1', 05:46:08 INFO - 'PAGER': '/bin/cat', 05:46:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:08 INFO - 'PWD': '/builds/slave/test', 05:46:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:08 INFO - 'SHELL': '/bin/bash', 05:46:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4bByzQap69/Listeners', 05:46:08 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 05:46:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:08 INFO - 'USER': 'cltbld', 05:46:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:08 INFO - 'XPC_FLAGS': '0x0', 05:46:08 INFO - 'XPC_SERVICE_NAME': '0', 05:46:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:08 INFO - Downloading/unpacking psutil>=3.1.1 05:46:08 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 05:46:08 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 05:46:08 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 05:46:08 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 05:46:08 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 05:46:08 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 05:46:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:46:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:11 INFO - Installing collected packages: psutil 05:46:11 INFO - Running setup.py install for psutil 05:46:11 INFO - building 'psutil._psutil_osx' extension 05:46:11 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 05:46:12 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 05:46:12 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 05:46:12 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 05:46:12 INFO - building 'psutil._psutil_posix' extension 05:46:12 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 05:46:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:46:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:46:12 INFO - ^ 05:46:12 INFO - 1 warning generated. 05:46:12 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 05:46:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:13 INFO - Successfully installed psutil 05:46:13 INFO - Cleaning up... 05:46:13 INFO - Return code: 0 05:46:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f5c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ed2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff86057e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d72d30>, '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 0x107bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d6ab20>, '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.szTvSjwsHp/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.4bByzQap69/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 05:46: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:46: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 mozsystemmonitor==0.3 05:46:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.szTvSjwsHp/Render', 05:46:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:13 INFO - 'HOME': '/Users/cltbld', 05:46:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:13 INFO - 'LOGNAME': 'cltbld', 05:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:13 INFO - 'MOZ_NO_REMOTE': '1', 05:46:13 INFO - 'NO_EM_RESTART': '1', 05:46:13 INFO - 'PAGER': '/bin/cat', 05:46:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:13 INFO - 'PWD': '/builds/slave/test', 05:46:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:13 INFO - 'SHELL': '/bin/bash', 05:46:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4bByzQap69/Listeners', 05:46:13 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 05:46:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:13 INFO - 'USER': 'cltbld', 05:46:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:13 INFO - 'XPC_FLAGS': '0x0', 05:46:13 INFO - 'XPC_SERVICE_NAME': '0', 05:46:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:46:13 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 05:46:13 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 05:46:13 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 05:46:13 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 05:46:13 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 05:46:13 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 05:46:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:46:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:46:16 INFO - Installing collected packages: mozsystemmonitor 05:46:16 INFO - Running setup.py install for mozsystemmonitor 05:46:16 INFO - Successfully installed mozsystemmonitor 05:46:16 INFO - Cleaning up... 05:46:16 INFO - Return code: 0 05:46:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:46:16 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')]} 05:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:16 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')]} 05:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:16 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 0x107f5c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ed2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff86057e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d72d30>, '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 0x107bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d6ab20>, '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.szTvSjwsHp/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.4bByzQap69/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 05:46:16 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 05:46:16 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 05:46:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.szTvSjwsHp/Render', 05:46:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:16 INFO - 'HOME': '/Users/cltbld', 05:46:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:16 INFO - 'LOGNAME': 'cltbld', 05:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:16 INFO - 'MOZ_NO_REMOTE': '1', 05:46:16 INFO - 'NO_EM_RESTART': '1', 05:46:16 INFO - 'PAGER': '/bin/cat', 05:46:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:16 INFO - 'PWD': '/builds/slave/test', 05:46:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:16 INFO - 'SHELL': '/bin/bash', 05:46:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4bByzQap69/Listeners', 05:46:16 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 05:46:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:16 INFO - 'USER': 'cltbld', 05:46:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:16 INFO - 'XPC_FLAGS': '0x0', 05:46:16 INFO - 'XPC_SERVICE_NAME': '0', 05:46:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:16 INFO - Downloading/unpacking jsonschema==2.5.1 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:46:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:46:18 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 05:46:18 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 05:46:18 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 05:46:18 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 05:46:18 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 05:46:18 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 05:46:19 INFO - Downloading functools32-3.2.3-2.tar.gz 05:46:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:46:19 INFO - warning: no files found matching '*.txt' 05:46:19 INFO - no previously-included directories found matching 'build' 05:46:19 INFO - no previously-included directories found matching 'dist' 05:46:19 INFO - no previously-included directories found matching '.git*' 05:46:19 INFO - Installing collected packages: jsonschema, functools32 05:46:19 INFO - Running setup.py install for functools32 05:46:19 INFO - warning: no files found matching '*.txt' 05:46:19 INFO - no previously-included directories found matching 'build' 05:46:19 INFO - no previously-included directories found matching 'dist' 05:46:19 INFO - no previously-included directories found matching '.git*' 05:46:19 INFO - Successfully installed jsonschema functools32 05:46:19 INFO - Cleaning up... 05:46:19 INFO - Return code: 0 05:46:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:19 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 0x107f5c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ed2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff86057e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d72d30>, '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 0x107bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d6ab20>, '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.szTvSjwsHp/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.4bByzQap69/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 05:46:19 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 05:46:19 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 05:46:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.szTvSjwsHp/Render', 05:46:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:19 INFO - 'HOME': '/Users/cltbld', 05:46:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:19 INFO - 'LOGNAME': 'cltbld', 05:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:19 INFO - 'MOZ_NO_REMOTE': '1', 05:46:19 INFO - 'NO_EM_RESTART': '1', 05:46:19 INFO - 'PAGER': '/bin/cat', 05:46:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:19 INFO - 'PWD': '/builds/slave/test', 05:46:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:19 INFO - 'SHELL': '/bin/bash', 05:46:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4bByzQap69/Listeners', 05:46:19 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 05:46:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:19 INFO - 'USER': 'cltbld', 05:46:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:19 INFO - 'XPC_FLAGS': '0x0', 05:46:19 INFO - 'XPC_SERVICE_NAME': '0', 05:46:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:46:20 INFO - Cleaning up... 05:46:20 INFO - Return code: 0 05:46:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:46:20 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')]} 05:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:20 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')]} 05:46:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:20 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 0x107f5c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ed2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff86057e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d72d30>, '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 0x107bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d6ab20>, '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.szTvSjwsHp/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.4bByzQap69/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 05:46:20 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 05:46:20 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 05:46:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.szTvSjwsHp/Render', 05:46:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:20 INFO - 'HOME': '/Users/cltbld', 05:46:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:20 INFO - 'LOGNAME': 'cltbld', 05:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:20 INFO - 'MOZ_NO_REMOTE': '1', 05:46:20 INFO - 'NO_EM_RESTART': '1', 05:46:20 INFO - 'PAGER': '/bin/cat', 05:46:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:20 INFO - 'PWD': '/builds/slave/test', 05:46:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:20 INFO - 'SHELL': '/bin/bash', 05:46:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4bByzQap69/Listeners', 05:46:20 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 05:46:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:20 INFO - 'USER': 'cltbld', 05:46:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:20 INFO - 'XPC_FLAGS': '0x0', 05:46:20 INFO - 'XPC_SERVICE_NAME': '0', 05:46:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:20 INFO - Downloading/unpacking blobuploader==1.2.4 05:46:20 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 05:46:20 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 05:46:20 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 05:46:20 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 05:46:20 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 05:46:20 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 05:46:22 INFO - Downloading blobuploader-1.2.4.tar.gz 05:46:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:46:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:46:22 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 05:46:22 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 05:46:22 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 05:46:22 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 05:46:22 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 05:46:22 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 05:46:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:46:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:46:23 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 05:46:23 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 05:46:23 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 05:46:23 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 05:46:23 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 05:46:23 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 05:46:23 INFO - Downloading docopt-0.6.1.tar.gz 05:46:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:46:24 INFO - Installing collected packages: blobuploader, requests, docopt 05:46:24 INFO - Running setup.py install for blobuploader 05:46:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:46:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:46:24 INFO - Running setup.py install for requests 05:46:24 INFO - Running setup.py install for docopt 05:46:24 INFO - Successfully installed blobuploader requests docopt 05:46:24 INFO - Cleaning up... 05:46:25 INFO - Return code: 0 05:46:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:25 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')]} 05:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:25 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')]} 05:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:25 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 0x107f5c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ed2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff86057e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d72d30>, '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 0x107bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d6ab20>, '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.szTvSjwsHp/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.4bByzQap69/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 05:46:25 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 05:46:25 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 05:46:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.szTvSjwsHp/Render', 05:46:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:25 INFO - 'HOME': '/Users/cltbld', 05:46:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:25 INFO - 'LOGNAME': 'cltbld', 05:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:25 INFO - 'MOZ_NO_REMOTE': '1', 05:46:25 INFO - 'NO_EM_RESTART': '1', 05:46:25 INFO - 'PAGER': '/bin/cat', 05:46:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:25 INFO - 'PWD': '/builds/slave/test', 05:46:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:25 INFO - 'SHELL': '/bin/bash', 05:46:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4bByzQap69/Listeners', 05:46:25 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 05:46:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:25 INFO - 'USER': 'cltbld', 05:46:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:25 INFO - 'XPC_FLAGS': '0x0', 05:46:25 INFO - 'XPC_SERVICE_NAME': '0', 05:46:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-JaVmA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-bA0fQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-gw4gXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Jh2sYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-ZFnBqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-FlmTW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:25 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-4g33v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-8EhpN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-zfFHJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-wES0fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-fGp0KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-WixNXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-2ckMfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-RbI1bT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Ef4PzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-UE1lrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:26 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-HFtFY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:46:27 INFO - Running setup.py install for manifestparser 05:46:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:46:27 INFO - Running setup.py install for mozcrash 05:46:27 INFO - Running setup.py install for mozdebug 05:46:27 INFO - Running setup.py install for mozdevice 05:46:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:46:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:46:27 INFO - Running setup.py install for mozfile 05:46:27 INFO - Running setup.py install for mozhttpd 05:46:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:46:27 INFO - Running setup.py install for mozinfo 05:46:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:46:28 INFO - Running setup.py install for mozInstall 05:46:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:46:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:46:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:46:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:46:28 INFO - Running setup.py install for mozleak 05:46:28 INFO - Running setup.py install for mozlog 05:46:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:46:28 INFO - Running setup.py install for moznetwork 05:46:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:46:28 INFO - Running setup.py install for mozprocess 05:46:28 INFO - Running setup.py install for mozprofile 05:46:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:46:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:46:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:46:28 INFO - Running setup.py install for mozrunner 05:46:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:46:29 INFO - Running setup.py install for mozscreenshot 05:46:29 INFO - Running setup.py install for moztest 05:46:29 INFO - Running setup.py install for mozversion 05:46:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:46:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:46:29 INFO - Cleaning up... 05:46:29 INFO - Return code: 0 05:46:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:29 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 0x107f5c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ed2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff86057e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d72d30>, '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 0x107bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d6ab20>, '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.szTvSjwsHp/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.4bByzQap69/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 05:46:29 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 05:46:29 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 05:46:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.szTvSjwsHp/Render', 05:46:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:29 INFO - 'HOME': '/Users/cltbld', 05:46:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:29 INFO - 'LOGNAME': 'cltbld', 05:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:29 INFO - 'MOZ_NO_REMOTE': '1', 05:46:29 INFO - 'NO_EM_RESTART': '1', 05:46:29 INFO - 'PAGER': '/bin/cat', 05:46:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:29 INFO - 'PWD': '/builds/slave/test', 05:46:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:29 INFO - 'SHELL': '/bin/bash', 05:46:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4bByzQap69/Listeners', 05:46:29 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 05:46:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:29 INFO - 'USER': 'cltbld', 05:46:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:29 INFO - 'XPC_FLAGS': '0x0', 05:46:29 INFO - 'XPC_SERVICE_NAME': '0', 05:46:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:29 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-XtuVbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:30 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)) 05:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-ZQZ9ON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:30 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)) 05:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-ojRUal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:30 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)) 05:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-s7fMZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Vu_AzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:30 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)) 05:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-2tzabf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:30 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)) 05:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-XWF03K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:30 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)) 05:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-mxIoIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:30 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)) 05:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-tUXP69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:30 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)) 05:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-m_cJsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:30 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)) 05:46:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:30 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-pqAt33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:31 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)) 05:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-6gOdYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-EF2mv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:31 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)) 05:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-nKQr4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:31 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)) 05:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-h5pvNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:31 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)) 05:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-yHXFqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:31 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-ChyF1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:31 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)) 05:46:31 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)) 05:46:31 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)) 05:46:31 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)) 05:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:34 INFO - Downloading blessings-1.6.tar.gz 05:46:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:46:34 INFO - Installing collected packages: blessings 05:46:34 INFO - Running setup.py install for blessings 05:46:34 INFO - Successfully installed blessings 05:46:34 INFO - Cleaning up... 05:46:34 INFO - Return code: 0 05:46:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:46:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:34 INFO - Reading from file tmpfile_stdout 05:46:34 INFO - Current package versions: 05:46:34 INFO - blessings == 1.6 05:46:34 INFO - blobuploader == 1.2.4 05:46:34 INFO - docopt == 0.6.1 05:46:34 INFO - functools32 == 3.2.3-2 05:46:34 INFO - jsonschema == 2.5.1 05:46:34 INFO - manifestparser == 1.1 05:46:34 INFO - mozInstall == 1.12 05:46:34 INFO - mozcrash == 1.0 05:46:34 INFO - mozdebug == 0.1 05:46:34 INFO - mozdevice == 0.48 05:46:34 INFO - mozfile == 1.2 05:46:34 INFO - mozhttpd == 0.7 05:46:34 INFO - mozinfo == 0.9 05:46:34 INFO - mozleak == 0.1 05:46:34 INFO - mozlog == 3.4 05:46:34 INFO - moznetwork == 0.27 05:46:34 INFO - mozprocess == 0.23 05:46:34 INFO - mozprofile == 0.28 05:46:34 INFO - mozrunner == 6.13 05:46:34 INFO - mozscreenshot == 0.1 05:46:34 INFO - mozsystemmonitor == 0.3 05:46:34 INFO - moztest == 0.7 05:46:34 INFO - mozversion == 1.4 05:46:34 INFO - psutil == 3.1.1 05:46:34 INFO - requests == 1.2.3 05:46:34 INFO - wsgiref == 0.1.2 05:46:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:35 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 0x107f5c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ed2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff86057e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d72d30>, '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 0x107bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d6ab20>, '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.szTvSjwsHp/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.4bByzQap69/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 05:46:35 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 05:46:35 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 05:46:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.szTvSjwsHp/Render', 05:46:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:35 INFO - 'HOME': '/Users/cltbld', 05:46:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:35 INFO - 'LOGNAME': 'cltbld', 05:46:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:35 INFO - 'MOZ_NO_REMOTE': '1', 05:46:35 INFO - 'NO_EM_RESTART': '1', 05:46:35 INFO - 'PAGER': '/bin/cat', 05:46:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:35 INFO - 'PWD': '/builds/slave/test', 05:46:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:35 INFO - 'SHELL': '/bin/bash', 05:46:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4bByzQap69/Listeners', 05:46:35 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 05:46:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:35 INFO - 'USER': 'cltbld', 05:46:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:35 INFO - 'XPC_FLAGS': '0x0', 05:46:35 INFO - 'XPC_SERVICE_NAME': '0', 05:46:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:35 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)) 05:46:35 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)) 05:46:35 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)) 05:46:35 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)) 05:46:35 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)) 05:46:35 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)) 05:46:35 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)) 05:46:35 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)) 05:46:35 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)) 05:46:35 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)) 05:46:35 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)) 05:46:35 INFO - Cleaning up... 05:46:35 INFO - Return code: 0 05:46:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107f5c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ed2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff86057e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d72d30>, '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 0x107bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d6ab20>, '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.szTvSjwsHp/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.4bByzQap69/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 05:46:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:46:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:46:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.szTvSjwsHp/Render', 05:46:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:36 INFO - 'HOME': '/Users/cltbld', 05:46:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:36 INFO - 'LOGNAME': 'cltbld', 05:46:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:36 INFO - 'MOZ_NO_REMOTE': '1', 05:46:36 INFO - 'NO_EM_RESTART': '1', 05:46:36 INFO - 'PAGER': '/bin/cat', 05:46:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:36 INFO - 'PWD': '/builds/slave/test', 05:46:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:36 INFO - 'SHELL': '/bin/bash', 05:46:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4bByzQap69/Listeners', 05:46:36 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 05:46:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:36 INFO - 'USER': 'cltbld', 05:46:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:36 INFO - 'XPC_FLAGS': '0x0', 05:46:36 INFO - 'XPC_SERVICE_NAME': '0', 05:46:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:46:36 INFO - Cleaning up... 05:46:36 INFO - Return code: 0 05:46:36 INFO - Running post-action listener: _resource_record_post_action 05:46:36 INFO - Running post-action listener: _start_resource_monitoring 05:46:36 INFO - Starting resource monitoring. 05:46:36 INFO - [mozharness: 2016-11-17 13:46:36.590084Z] Finished create-virtualenv step (success) 05:46:36 INFO - [mozharness: 2016-11-17 13:46:36.591072Z] Running install step. 05:46:36 INFO - Running pre-action listener: _resource_record_pre_action 05:46:36 INFO - Running main action method: install 05:46:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:36 INFO - Reading from file tmpfile_stdout 05:46:36 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:46:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:46:36 INFO - Reading from file tmpfile_stdout 05:46:36 INFO - Output received: 05:46:36 INFO - Usage: mozinstall [options] installer 05:46:36 INFO - Options: 05:46:36 INFO - -h, --help show this help message and exit 05:46:36 INFO - -d DEST, --destination=DEST 05:46:36 INFO - Directory to install application into. [default: 05:46:36 INFO - "/builds/slave/test"] 05:46:36 INFO - --app=APP Application being installed. [default: firefox] 05:46:36 INFO - mkdir: /builds/slave/test/build/application 05:46:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:46:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:47:11 INFO - Reading from file tmpfile_stdout 05:47:11 INFO - Output received: 05:47:11 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:47:11 INFO - Running post-action listener: _resource_record_post_action 05:47:11 INFO - [mozharness: 2016-11-17 13:47:11.120683Z] Finished install step (success) 05:47:11 INFO - [mozharness: 2016-11-17 13:47:11.120836Z] Running run-tests step. 05:47:11 INFO - Running pre-action listener: _resource_record_pre_action 05:47:11 INFO - Running main action method: run_tests 05:47:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:47:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:47:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:47:11 INFO - 2016-11-17 05:47:11.135 screenresolution[1623:7347] starting screenresolution argv=screenresolution get 05:47:11 INFO - 2016-11-17 05:47:11.137 screenresolution[1623:7347] Display 0: 1600x1200x32@60 05:47:11 INFO - 2016-11-17 05:47:11.143 screenresolution[1624:7349] starting screenresolution argv=screenresolution list 05:47:11 INFO - Available Modes on Display 0 05:47:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:47:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:47:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:47:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:47:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:47:11 INFO - Intel Iris: 05:47:11 INFO - Chipset Model: Intel Iris 05:47:11 INFO - Type: GPU 05:47:11 INFO - Bus: Built-In 05:47:11 INFO - VRAM (Dynamic, Max): 1536 MB 05:47:11 INFO - Vendor: Intel (0x8086) 05:47:11 INFO - Device ID: 0x0a2e 05:47:11 INFO - Revision ID: 0x0009 05:47:11 INFO - Displays: 05:47:11 INFO - Display: 05:47:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:47:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:47:11 INFO - Display Serial Number: 1600x1200 60 05:47:11 INFO - Main Display: Yes 05:47:11 INFO - Mirror: Off 05:47:11 INFO - Online: Yes 05:47:11 INFO - Rotation: Supported 05:47:11 INFO - Return code: 0 05:47:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:47:11 INFO - Python 2.7.3 05:47:11 INFO - Return code: 0 05:47:11 INFO - grabbing minidump binary from tooltool 05:47:11 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')]} 05:47:11 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 0x107d72d30>, '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 0x107bd9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107d6ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:47:11 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 05:47:11 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 05:47:11 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 05:47:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:47:11 INFO - Return code: 0 05:47:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:47:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:47:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:47:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:47:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:47:11 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/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 05:47:11 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/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0111 --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 05:47:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.szTvSjwsHp/Render', 05:47:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:47:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:47:11 INFO - 'HOME': '/Users/cltbld', 05:47:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:47:11 INFO - 'LOGNAME': 'cltbld', 05:47:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:47:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:11 INFO - 'MOZ_NO_REMOTE': '1', 05:47:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:47:11 INFO - 'NO_EM_RESTART': '1', 05:47:11 INFO - 'PAGER': '/bin/cat', 05:47:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:11 INFO - 'PWD': '/builds/slave/test', 05:47:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:47:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:47:11 INFO - 'SHELL': '/bin/bash', 05:47:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4bByzQap69/Listeners', 05:47:11 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 05:47:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:47:11 INFO - 'USER': 'cltbld', 05:47:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:47:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:11 INFO - 'XPC_FLAGS': '0x0', 05:47:11 INFO - 'XPC_SERVICE_NAME': '0', 05:47:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:47:11 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/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 05:47:11 INFO - mozversion application_buildid: 20161117030212 05:47:11 INFO - mozversion application_changeset: 13f49da109ea460665ad27c8497cb1489548450c 05:47:11 INFO - mozversion application_display_name: Nightly 05:47:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:47:11 INFO - mozversion application_name: Firefox 05:47:11 INFO - mozversion application_remotingname: firefox 05:47:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:47:11 INFO - mozversion application_vendor: Mozilla 05:47:11 INFO - mozversion application_version: 53.0a1 05:47:11 INFO - mozversion platform_buildid: 20161117030212 05:47:11 INFO - mozversion platform_changeset: 13f49da109ea460665ad27c8497cb1489548450c 05:47:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:47:11 INFO - mozversion platform_version: 53.0a1 05:47:11 INFO - using testdate: 1479390431 05:47:11 INFO - actual date: 1479390431 05:47:11 INFO - starting webserver on 'localhost:49237' 05:47:11 INFO - SUITE-START | Running 2 tests 05:47:11 INFO - TEST-START | dromaeo_css 05:47:11 INFO - operating with platform_type : mac_ 05:47:11 INFO - Initialising browser for dromaeo_css test... 05:47:11 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpHQ1Zuz/profile http://localhost:49237/getInfo.html) 05:47:14 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 05:47:14 INFO - PROCESS | 1634 | colorDepth:24 05:47:14 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 05:47:14 INFO - PROCESS | 1634 | __metrics 05:47:14 INFO - PROCESS | 1634 | 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" 05:47:14 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:47:15 INFO - TEST-INFO | 1634: exit 0 05:47:15 INFO - Browser initialized. 05:47:15 INFO - Running cycle 1/1 for dromaeo_css test... 05:47:15 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpHQ1Zuz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:27 INFO - PROCESS | 1637 | RSS: Main: 237932544 05:47:27 INFO - PROCESS | 1637 | 05:48:18 INFO - PROCESS | 1637 | 1479390498483 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:50:32 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 05:50:34 INFO - PROCESS | 1637 | RSS: Main: 475856896 05:50:34 INFO - PROCESS | 1637 | 05:53:37 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 05:53:38 INFO - PROCESS | 1637 | RSS: Main: 372928512 05:53:38 INFO - PROCESS | 1637 | 05:56:40 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 05:56:41 INFO - PROCESS | 1637 | RSS: Main: 350285824 05:56:41 INFO - PROCESS | 1637 | 05:59:43 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 05:59:44 INFO - PROCESS | 1637 | RSS: Main: 351412224 05:59:44 INFO - PROCESS | 1637 | 06:02:47 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 06:02:48 INFO - PROCESS | 1637 | RSS: Main: 342089728 06:02:48 INFO - PROCESS | 1637 | 06:05:51 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 06:05:51 INFO - PROCESS | 1637 | RSS: Main: 448790528 06:05:51 INFO - PROCESS | 1637 | 06:05:51 INFO - PROCESS | 1637 | __start_tp_report 06:05:51 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 06:05:51 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 06:05:51 INFO - PROCESS | 1637 | |i|pagename|runs| 06:05:51 INFO - PROCESS | 1637 | |0;dojo.html;3146.952795708065;3204.1509000114966;3342.264701765611;3363.058343663772;3390.2541440882997;4841.57173633778;5394.595405344595;5625.071863142582;5688.488036076757;5691.544676425887;5617.101263797783;5633.774649014044;5659.971700141494;5729.627574207663;5739.282589676291;5154.175331946889;5166.095933211692;5196.220566914955;5214.60890433219;5215.1395019821875;5116.692998420088;5277.393099793535;5286.04851126797;5286.497782710656;5344.331958505187;5265.6840589564745;5292.020976119411;5299.470052994689;5310.62825602208;5357.705326207057;5118.411382691001;5143.485651434864;5172;5181.35233095863;5221.921671174935;5154.4072431670465;5170.1469257572835;5180.896382072375;5246.422893481714;5254.448282930275;5642.294713160855;5648.802291919763;5656.519195868356;5689.231953686241;5692.715364231772;6051.213342265477;6124;6214.502839772807;6218.9378106219265;6224.719887605069;5122;6068.757249710006;6172.722227499773;6185.010398336244;6194.946859033975;5727.255456790591;5731.914021289684;5734.684592347461;5740.253767010346;5745.109508026221;6176.227971503562;6197.25632924043;6225.3774622538285;6235.376462353728;6295.685215739195;6126.203593532812;6128.846778830565;6153.2000839890525;6157.138000679908;6160.44555989963;6234;6245.344238854855;6260.248770147611;6261.9373806262265;6262.780802671885;4969.180085285887;5968.731407086691;6066.545009124245;6125.142480052797;6127.080937859357;6050.667213303311;6057.60625559346;6058.727357268934;6067;6095.542834287447;4834.323194752737;4837.854864354004;4840.491748366371;4848.490908454562;4884.682495637772;3737.32728108943;4309.784510774449;4319.244132276839;4376.343548467756;4411.647068234533;5726.914096288559;5727.226824378656;5732.111522713986;5743.827685169452;5751.1373294006235;6169.660668663267;6197.4732147767045;6220.222472190976;6227.844303892349;6230.657313847782;5681.147827825859;5725.112607545837;5742.913856292159;5755.539556835443;5764.798232061858;4541.636669066466;5206.219067139884;5335.759890804923;5357.491038351351;5358.089124848785;6259.78090766821;6295.622262664255;6296.716647750954;6303.842403939938;6317.747290108528;6159.784407545714;6217.502599792097;6236.407541283571;6269.7178626962805;6283.088952102011;6274.968625157027;6292.087647291026;6303.779367722108;6309.33751956038;6309.968450157719;5999.400059993965;6049.425304596057;6180.351063138306;6188.9690551546955;6190.597611155261;6018.578699491169;6182.598131121463;6205.131281620667;6209.5963762357105;6212.844678883064;5862.560307976833;5964.373740757158;6006.129111278928;6011.939880601138;6025.728842202199;5228.320318358589;5324.494173053554;5991.7603295867675;6003.339632640319;6136.73353236607;5942.61373010753;5949.167116603592;5975.790847320323;6003.939960600338;6006.429389208019;6032.668203248688;6096.451319381277;6133.202683651097;6147.508199344131;6150.477209437248;5732.226149469935;5794.072948328248;5977.193078934462;5989.790357337472;5991.910121348096 06:05:51 INFO - PROCESS | 1637 | |1;ext.html;504.2411171187363;506.0056988018543;517.2448225590638;519.3170980161085;550.9614326997107;24999;31470.68529314706;32443;32568.185795355068;32600.67399326006;32135.35729285413;32632;32742;32790.50814237788;32850;6068.0291153415465;7154.391876690487;7337.816554586125;7345.522541034816;7346.706131754723;6230.345813689565;7236.2401947795515;7495.400367970549;7500.362469190125;7539.849203015937;7493.625318734069;7538.1331146918255;7543.735969241077;7546.54720716756;7570.432217583676;7502.924970750277;7549.698012079482;7560.395168386516;7566.962165189194;7573.545587264782;7552.055993000875;7646.8088297793;7646.929429879821;7650.808729781745;7652.693892244303;30890.918817841266;31195.220119497193;31231.84384078065;31275.84362078175;31297.374052518822;3194.9361012779614;3398.9660103398896;3468.9653103468895;3816.3321418751607;3845.692344612424;21136;21517.892410538003;21701.806400647958;21711.674324885138;21761;2826.2369160326803;2833.4049849531625;2862.255813488487;2890.262982939358;2917.722816332445;485800.99999999645;488675;494164;494175;506774;59191.70404147952;59592;59707;59740.10389844156;59752.506187345665;67352;68587.65706171437;68768;71255.2874471259;72221.63889180521;15390.153541555323;15782.68434631301;15789.973651712602;15792.447264345692;15822;10911.618093366695;11038.448077596087;11055.00504954558;11929.403529823474;12067.939660301643;19802.801971980094;20221;20234.595308093754;20644.69032964507;20736.889466579833;7172;8353.37349698775;8526.65893364271;8527.573621319034;8666.220040196287;709.2481969112757;885.7431344909904;902.1745103230471;985.7042887133831;1019.1388276906151;22482.66276005861;28685.426291474472;28837.42325153527;29233;29286.848174439136;986.1519093579516;1050.3277902142636;1051.363924825485;1080.7622323088908;1096.6381094238882;14533.92733036328;15065.246737663074;15074.944753867125;15350.923245383701;15468.92265538665;667024;670140.9337926103;670222;672584;672634;50435.49564504381;51157.23264151041;51181.74409128005;51218;51411.228831567554;1197.8263151842934;1249.28790589365;1249.8187762774164;1327.1904138475522;1358.9388477518535;27875.860620696767;28643.427131457673;29157.833686652295;29418.940674152604;29969;49407.011859761886;49781.50218497769;49843.750781245864;49978.500214998836;50086.749566251936;504985;591747;596377;598432;600746;32479.837600811843;33436.33127337488;34281.97154085382;37828.43257351087;39473.210535789694;39434;40995;41085.35582268793;41108.38337424881;41620.791896040326;34571;34608.78869239565;34663.13342166466;35103.94688159359;35936.28127437489;25974;34108.488372674925;34220.657793422746;35309.29381412409;35341.82329088338;34040.82979585086;34155.4876676855;34493.82753086218;34684.82657586696;34689.30621387609;25071.623925640764;25823.48353032891;26168.214953551425;26545;26620;21056.894715526323;21786.564268714854;22961.655575166053;23772;23790 06:05:51 INFO - PROCESS | 1637 | |2;jquery.html;371.1093375897847;371.63765328804413;377.1495278147776;385.9170278390149;397.6004115863557;15206.92396538017;16299.577088811335;16320.75518867218;16514.917425412856;16734.41429549966;18052.638947221047;18673.159707813145;19044.33344832931;19584.314548990787;19817.900910495464;4946.381702287223;5233.502817232356;5237.607179461536;5241.554467870235;5245.816396426126;3446.5174875517446;3615.728820338472;3718.1634132320282;5102.923456148161;5192.013517431695;5181.559567436772;5183.144781111112;5193.324867767204;5197.7401129943355;5213.2962050123315;4947.431045429786;5120.103981803207;5171.0692075426405;5194.558462530689;5208.661437006602;4583.839565615188;4587.24310488769;4592.862214133581;4595.310703394484;4598.816047358102;21044.368668939802;21240.575188496143;22253.44366390837;22458;22568.548629027493;2082.83337333013;2192.6053310404122;2260.536589999046;2336.684547586071;2346.460314127743;13713.931430342884;14241.145531268157;14265.714685706227;14392.424303027867;15021;1770.9645807083914;1824.1791193962638;1840.834324910751;1874.690676038452;1878.4176905159445;127311.36344318218;130834;138348;139583.60416395808;140316;16277.59306017359;18678.719819202724;20649.58700825975;21110.577788444145;21317.147314107573;31524.684753152633;34779.82610086984;34879.302413952086;34888;34995.300093997976;10080.445575493419;10249.436281004617;10455;10460.63387781424;10651.254412191072;8503.447275927045;8506.702265420681;8526.57367131641;8697.999730031;8714.607842647096;7833.686652533949;9420.764480888032;9496.008757241447;9656.517174141265;9659.372140810825;3243.351329734063;3497.0732755819727;3729.1236559408517;3729.1609387887506;3755.586885442599;811.7524155132623;847.8516259654535;858.4463021351194;874.5889431966965;902.2962089570145;20067.899660501604;20522.281720139723;20619.4845128873;20737.481562960744;20920.581588368146;766.3639179481017;845.1168528887205;890.172139909877;903.5075883643431;930.7905721212672;10591.94704026475;10943.890561094287;11000.559977600806;11043.668689939153;11064.557417703363;552287.2385638127;564874;573503;578109;579260;124584.37707811584;124736;126905.3654731739;127626.36186819007;129768.3511582455;946.6402766948653;958.2334132693817;965.7199412170532;966.5602151021268;970.2965350121247;16149.67700645957;17496;17864.69503141923;18542.232699376786;18635.347762828234;49559.75220123876;49561.25658115059;51878.48121518736;51983;52724.73637631787;77011.84482232659;77216;77812.22187778277;80451;84983;7092.6099064551945;7274;7376.188619251985;7455.329020388191;7909.960450197712;11023.61417350389;11296.6046188383;11826.940865295619;12517.499300027897;12833.3424973882;8884.689035883714;10623.89376106229;10859.294145880493;11024.779504409706;11104.222704410613;10474.52864621109;10629.309094908805;10861;11047.281926674741;11047.779044419227;10034.785390136014;10856.537200479444;11253.324800511995;11288.887111128784;11291.266067705574;7257;7319.158296795937;7375.963120184365;7400.666969986256;7521.210272921265;10536;10666.520006599876;11008.009279164913;11055;11109.277896936674 06:05:51 INFO - PROCESS | 1637 | |3;mootools.html;1286.421110500275;1344.5361350334133;1484.0947022316386;1618.9190540472973;1831.1302131487553;6505.479561635069;7559.319661230488;7771.766846994592;8019.759407217793;8025.237602427775;7934.7222847200355;8019.839603207933;8027.91972080279;8032.959835200816;8035.517868927854;1997.2410484016054;2023.8178563929243;2027.3715148304;2027.726256955307;2031.035258252333;2069.503319203388;2088.968665470019;2103.495161161318;2114.46081249282;2118.3433135727973;2072.0986370928617;2080.5110798962232;2100.831933445321;2104.1898868935496;2104.884231367274;2072.917083316673;2096.9790302096935;2097.7168082308845;2098.821600163988;2106.683997400387;2074.09776747114;2105.3473423238843;2105.789421057882;2107.7365329333834;2117.089651449876;7903.012123484565;7931.643076061533;8001.079875814239;8018.037835459724;8021.95989020057;4979.601631869442;5175.430702622709;5190.195519694454;5204.42751297357;5222.947770522284;3220.5491231227647;3407.744419168572;3445.1903802606366;3494.318607871466;3498.5451891253974;951.5527701980059;965.2374624046995;1003.8717918013784;1025.912797412221;1029.433811403725;10974.231803773739;11018.44907754617;11087.778244435147;11093.33439993595;11141.220114591983;3781.810909454571;4202.411662367271;4277;4415.955840441618;4419.359192917009;8672.956635216784;8683.392162548687;8686.218240358397;8692.91307086921;8701.738947831574;5056.9494305057215;5076.7207803571155;5081.7967281309075;5082.491750824888;5083.822066227664;3982.104026594051;4309.41822853917;4392.648588112943;4726.952730472652;4807.807687692523;3589.953726375993;3619.583747868976;3685.7051435885064;3700.666939975415;3701.1487357907295;1128.15388458656;1140.5722853929776;1145.7994850901225;1155.6937411585768;1156.4275683536703;848.4909054567211;853.4409961475244;854.9145085491401;862.5816479007676;875.8598624220094;5353.197020446886;5410.458954104558;5511.476409741068;5689.975804355173;5740.598158128891;859.8349236784193;867.3798234262532;880.6829541365104;883.5538053283051;894.4543828264754;3484.3728128937037;3518.683318501347;3634.23681026982;3637.436197389409;3780.1872597391693;9417.529123543796;10097.646582369582;10109.494525273854;10224.744381390525;10243.282970192015;9917.851232231522;10044.849327260097;10185.185185185168;10189.23580731448;10192.694219173436;7546.132194797558;7776;7794.727184548514;7834.099078605919;7852.057753069554;5338;5384.111621582395;5492.093804522369;5510.8071217507195;5546.140348245867;9051.90948090537;9309.255259579353;9367.391119577478;9459.432434053979;9534;9411.81176376455;9446.480443575394;9476.715698529055;9658.420494770337;9696.6121355145;6896.379325860697;7120.181179164462;7304;7306.305900939402;7311.817204569716;7844.9607751960875;8093.473924194908;8097.595120244082;8102.987126609174;8106.189381061847;7047.224805271519;7148.535345202546;7288.416926645961;7292.635368231461;7293.598852063187;7077.1507419107975;7105.253948335557;7105.644717764195;7164.9641751790905;7184.568925864465;6497.18785151856;6637.535372523877;6701.765438209639;6707.42986846104;6717.193936727624;4755.191617424977;4779.665423420327;4847.418309802846;4881.194602890625;4982.576480999156;4748.240281554935;4874.147024270809;4896.4858689838475;4917.409910810726;4978.751062446936 06:05:51 INFO - PROCESS | 1637 | |4;prototype.html;274.42918729043583;297.8361900954475;305.6057685585595;309.34573377307004;313.03897036099187;4448.620927512469;4666.510016448275;5148.683092608322;5173.689578625285;5195.441367589722;4851.611871050316;4895.5838753705975;4918.163912134936;4953.801847926079;5121.923171152435;3289.8848540301096;3918.294706952747;3928.29119333091;3932.4101384792366;3932.4297976793346;3358.4811391456406;3474.8436320365518;3772.3775577029755;3918.5689574146822;3944.73768394114;3367.6632336766374;3555.5911070227;3736.4395340698975;3921.117748506592;3933.9606603934026;3942.980285098556;3943.6647884929816;3947.3289540778137;3949.8420063197436;3981.904976131558;3045.7969102204506;3305.190228394059;3481.181922248295;3484.860605575774;3494.860205591773;4125.752454852718;4761.452432970218;5009.924851127236;5054.725373581903;5065.316182315414;3987.7407968481957;4531.614812740921;4538.341940418621;4556.863294101182;4577.313402989545;5427.3758517770175;5441.863953401157;5449.591280653927;5451.754671039813;5482.641300166378;3835.6547910688173;3849.7295892355455;3850.249201405727;3853.807309634535;3856.055266459707;4681.057361195066;5364.356277246756;5647.604667673265;5728.513076388554;5729.140628905656;3539.4513850353237;3740.31685741412;3895.6365272155085;3899.3760998240714;3920.3923391874305;3385.272166484218;3483.8780642677384;3883.203943191639;3933.940990885139;3967.484227050523;4017.5449113762143;4484.0583477469445;4556.97721511397;4618.445786505641;4619.445666519972;5000.424951130593;5452.482014208644;5465.535429488538;5485.4788795064405;5506.504414602705;1096.660035389032;1176.6646505745994;1287.3305880941857;1289.5873320537337;1299.7010687541917;742.7808796405074;767.9577623230664;849.362977766675;860.6514361683528;908.3913777768911;4271.978640106841;4284.464441944757;4699.318598803155;4884.975575122102;4900.721164658451;4122.732022418533;5095.80248641569;5232.293640358579;5260.789568417221;5279.102552565996;3856.749311294757;4200.684948628865;4621.353010578522;4648.628109751212;4703.905921881612;2473.5547601431554;2685.5971604259516;2720.564709646447;2734.9589756153673;2772.6395568575954;5036.924446133311;5202.886608235309;5286.20706893969;5365.8390248291835;5442.700651464207;4812.879678008007;5336.4129945705945;5384.596155288369;5394.9460505394445;5787.450192231731;5242.842714718565;5882.852928676817;5916;5938.792142275086;5957.582969192115;4643.628509719282;4839.879003024953;5675.262215911905;5704.8019915816485;5729.369769325288;5241.008416801591;5554.305711786027;5621.100623900156;5636.830895073154;5666.03677374839;4944.332515110558;5683.584476597513;5813;5877.206577112035;5922.881542369042;3146.98426507866;3679.7856707287065;3708.2744183024915;3787.4697542344643;3825.4261860720003;4928.314068832423;5450.482204190595;5655.971720141538;5658.801941932013;5680.602357834912;5452.236686863922;5501.284832971848;5517.475839795213;5530.889382212414;5550.030733557527;4885.853424397274;5061.683962169789;5484;5511.779528818963;5544.889102217852;5352.41123476425;5364.275822763877;5379.892402152013;5394.298741163623;5405.486478784509;4590.495045544921;5233.39815921174;5280.867978300574;5419.187121931742;5461.590380721541;5315.867103322294;5344.7060411676175;5362.785488580413;5395.325584301962;5423.29497165366 06:05:51 INFO - PROCESS | 1637 | |5;yui.html;672.9831754206145;766.769969009297;772.5133166105354;785.4429908398081;799.8800179973003;11803.70490737732;12852.550160744377;13347.332633368342;13736.725265494684;13783.517576884811;12390.504379824797;12747.298898560575;12749.235045897252;12769.744605107891;12778;643.7618081309898;807.991920080799;827.4166712467726;827.7227128911821;832.7543374704446;665.490899461912;673.4275865514322;789.7907054630499;816.2082779703678;818.2758258940821;855.5294587976588;863.8229163021565;867.5055218525443;867.9826403471927;868.4572142410993;862.9309655227567;863.6588547523693;863.8013256950906;864.2178828160494;865.3423398217337;502.20651370833997;518.7017464957627;613.0773186354553;631.2708821311347;638.5147288061061;10967.780644387067;11754.05967522596;11758.823617645741;11769.117316201318;11849.40752962357;8934.4192627479;10184.338018028804;10347.379157250514;10470.42412667303;10537.315074520207;8261.421700480969;9228.91073095487;9483.810323793485;9517.191038761714;9824;3012.774041946863;3019.0791808498398;3033.8028028178096;3057.6942305769467;3125.2030732163153;84106.15893841044;88379.99999999936;88841.11158888393;89499;90294.09705902923;7081.291870812877;8131.105578386373;8147.063087744867;8156.632951517196;8261.752147435587;15773.68452630941;16455.177241137895;16464.176791160393;16797.664046718997;16810.15949202535;7475.6262186890435;7560.206178351194;7621.885671714928;7642.656080476392;7720.382369410434;4186.539480657125;4202.495700515958;4237.491501019836;4239.1521695660995;4249.065205654751;3292.489664102068;3392.8642854286045;3397.725852805198;3399.2351720863103;3400.5579274694132;591.5504216795266;604.5943182101631;632.3234139470815;642.4507046475289;655.7639249870043;537.5108651127455;543.6330476928058;558.3439458636086;562.8761672432058;657.8585604095142;8318.8336233275;8459.196376344238;8541.743747687578;8544.829103417896;8587.313014958789;601.4256385152256;633.1104797759156;634.3783092569216;637.8756142552251;657.9868402631921;3981.8606348778235;4051.554329023805;4078.286299897506;4132.938005929914;4184.727992680466;76083.23916760873;96005.039949601;120102;121290.3935480317;126020.36989814992;85223.14776852276;103407;103890;104696.47651761693;106832;89704.20591588132;90044;92922;92994.53502732307;93425.5328723352;7976.9202307976175;8057.315128213933;8069.7175598853755;8271.13153118938;8367.916320836714;40588;47119.225327820524;48126.79683007813;49459.50540494693;54404;51008;67974;71863.92204116838;73392.63303683448;77331.61334193293;9730.902690973282;9879.357841740264;10046.346987445793;10303.896961030594;11222.943885280521;12029.578964736193;12049.634920001372;12234.816477752664;12371.257724536557;12707.745845083231;10989.560417583207;11074.889251107386;11105.722356941142;11254.549818007516;11563.88436115628;11019.559217631526;11342.60300889465;11448.141389395661;11695.76608467809;12118;11101.50043248072;11134.832977505182;11205.943970280096;11289.20975531705;11491.310521368745;8074.434789564674;9266.11971862672;9346;9385.343025988115;9520.166898470317;9284.118008789153;9538.380005299634;9544.093311135432;9742.31803773729;9797.804043919225 06:05:51 INFO - PROCESS | 1637 | __end_tp_report 06:05:51 INFO - PROCESS | 1637 | __start_cc_report 06:05:51 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1739 06:05:51 INFO - PROCESS | 1637 | __end_cc_report 06:05:51 INFO - PROCESS | 1637 | __startTimestamp1479391551532__endTimestamp 06:05:51 INFO - PROCESS | 1637 | 06:05:51 INFO - PROCESS | 1637 | ------- Summary: start ------- 06:05:51 INFO - PROCESS | 1637 | Number of tests: 6 06:05:51 INFO - PROCESS | 1637 | 06:05:51 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5676.54 Median:5942.61 stddev:659.12 (11.1%) stddev-sans-first:630.56 06:05:51 INFO - PROCESS | 1637 | Values: 3147.0 3204.2 3342.3 3363.1 3390.3 4841.6 5394.6 5625.1 5688.5 5691.5 5617.1 5633.8 5660.0 5729.6 5739.3 5154.2 5166.1 5196.2 5214.6 5215.1 5116.7 5277.4 5286.0 5286.5 5344.3 5265.7 5292.0 5299.5 5310.6 5357.7 5118.4 5143.5 5172.0 5181.4 5221.9 5154.4 5170.1 5180.9 5246.4 5254.4 5642.3 5648.8 5656.5 5689.2 5692.7 6051.2 6124.0 6214.5 6218.9 6224.7 5122.0 6068.8 6172.7 6185.0 6194.9 5727.3 5731.9 5734.7 5740.3 5745.1 6176.2 6197.3 6225.4 6235.4 6295.7 6126.2 6128.8 6153.2 6157.1 6160.4 6234.0 6245.3 6260.2 6261.9 6262.8 4969.2 5968.7 6066.5 6125.1 6127.1 6050.7 6057.6 6058.7 6067.0 6095.5 4834.3 4837.9 4840.5 4848.5 4884.7 3737.3 4309.8 4319.2 4376.3 4411.6 5726.9 5727.2 5732.1 5743.8 5751.1 6169.7 6197.5 6220.2 6227.8 6230.7 5681.1 5725.1 5742.9 5755.5 5764.8 4541.6 5206.2 5335.8 5357.5 5358.1 6259.8 6295.6 6296.7 6303.8 6317.7 6159.8 6217.5 6236.4 6269.7 6283.1 6275.0 6292.1 6303.8 6309.3 6310.0 5999.4 6049.4 6180.4 6189.0 6190.6 6018.6 6182.6 6205.1 6209.6 6212.8 5862.6 5964.4 6006.1 6011.9 6025.7 5228.3 5324.5 5991.8 6003.3 6136.7 5942.6 5949.2 5975.8 6003.9 6006.4 6032.7 6096.5 6133.2 6147.5 6150.5 5732.2 5794.1 5977.2 5989.8 5991.9 06:05:51 INFO - PROCESS | 1637 | 06:05:51 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:69203.02 Median:34687.07 stddev:157207.87 (453.2%) stddev-sans-first:157564.26 06:05:51 INFO - PROCESS | 1637 | Values: 504.2 506.0 517.2 519.3 551.0 24999.0 31470.7 32443.0 32568.2 32600.7 32135.4 32632.0 32742.0 32790.5 32850.0 6068.0 7154.4 7337.8 7345.5 7346.7 6230.3 7236.2 7495.4 7500.4 7539.8 7493.6 7538.1 7543.7 7546.5 7570.4 7502.9 7549.7 7560.4 7567.0 7573.5 7552.1 7646.8 7646.9 7650.8 7652.7 30890.9 31195.2 31231.8 31275.8 31297.4 3194.9 3399.0 3469.0 3816.3 3845.7 21136.0 21517.9 21701.8 21711.7 21761.0 2826.2 2833.4 2862.3 2890.3 2917.7 485801.0 488675.0 494164.0 494175.0 506774.0 59191.7 59592.0 59707.0 59740.1 59752.5 67352.0 68587.7 68768.0 71255.3 72221.6 15390.2 15782.7 15790.0 15792.4 15822.0 10911.6 11038.4 11055.0 11929.4 12067.9 19802.8 20221.0 20234.6 20644.7 20736.9 7172.0 8353.4 8526.7 8527.6 8666.2 709.2 885.7 902.2 985.7 1019.1 22482.7 28685.4 28837.4 29233.0 29286.8 986.2 1050.3 1051.4 1080.8 1096.6 14533.9 15065.2 15074.9 15350.9 15468.9 667024.0 670140.9 670222.0 672584.0 672634.0 50435.5 51157.2 51181.7 51218.0 51411.2 1197.8 1249.3 1249.8 1327.2 1358.9 27875.9 28643.4 29157.8 29418.9 29969.0 49407.0 49781.5 49843.8 49978.5 50086.7 504985.0 591747.0 596377.0 598432.0 600746.0 32479.8 33436.3 34282.0 37828.4 39473.2 39434.0 40995.0 41085.4 41108.4 41620.8 34571.0 34608.8 34663.1 35103.9 35936.3 25974.0 34108.5 34220.7 35309.3 35341.8 34040.8 34155.5 34493.8 34684.8 34689.3 25071.6 25823.5 26168.2 26545.0 26620.0 21056.9 21786.6 22961.7 23772.0 23790.0 06:05:51 INFO - PROCESS | 1637 | 06:05:51 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:35273.77 Median:3344.93 stddev:95711.78 (2861.4%) stddev-sans-first:95944.40 06:05:51 INFO - PROCESS | 1637 | Values: 371.1 371.6 377.1 385.9 397.6 15206.9 16299.6 16320.8 16514.9 16734.4 18052.6 18673.2 19044.3 19584.3 19817.9 4946.4 5233.5 5237.6 5241.6 5245.8 3446.5 3615.7 3718.2 5102.9 5192.0 5181.6 5183.1 5193.3 5197.7 5213.3 4947.4 5120.1 5171.1 5194.6 5208.7 4583.8 4587.2 4592.9 4595.3 4598.8 21044.4 21240.6 22253.4 22458.0 22568.5 2082.8 2192.6 2260.5 2336.7 2346.5 13713.9 14241.1 14265.7 14392.4 15021.0 1771.0 1824.2 1840.8 1874.7 1878.4 127311.4 130834.0 138348.0 139583.6 140316.0 16277.6 18678.7 20649.6 21110.6 21317.1 31524.7 34779.8 34879.3 34888.0 34995.3 10080.4 10249.4 10455.0 10460.6 10651.3 8503.4 8506.7 8526.6 8698.0 8714.6 7833.7 9420.8 9496.0 9656.5 9659.4 3243.4 3497.1 3729.1 3729.2 3755.6 811.8 847.9 858.4 874.6 902.3 20067.9 20522.3 20619.5 20737.5 20920.6 766.4 845.1 890.2 903.5 930.8 10591.9 10943.9 11000.6 11043.7 11064.6 552287.2 564874.0 573503.0 578109.0 579260.0 124584.4 124736.0 126905.4 127626.4 129768.4 946.6 958.2 965.7 966.6 970.3 16149.7 17496.0 17864.7 18542.2 18635.3 49559.8 49561.3 51878.5 51983.0 52724.7 77011.8 77216.0 77812.2 80451.0 84983.0 7092.6 7274.0 7376.2 7455.3 7910.0 11023.6 11296.6 11826.9 12517.5 12833.3 8884.7 10623.9 10859.3 11024.8 11104.2 10474.5 10629.3 10861.0 11047.3 11047.8 10034.8 10856.5 11253.3 11288.9 11291.3 7257.0 7319.2 7376.0 7400.7 7521.2 10536.0 10666.5 11008.0 11055.0 11109.3 06:05:51 INFO - PROCESS | 1637 | 06:05:51 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5344.85 Median:5083.16 stddev:3006.13 (59.1%) stddev-sans-first:2999.09 06:05:51 INFO - PROCESS | 1637 | Values: 1286.4 1344.5 1484.1 1618.9 1831.1 6505.5 7559.3 7771.8 8019.8 8025.2 7934.7 8019.8 8027.9 8033.0 8035.5 1997.2 2023.8 2027.4 2027.7 2031.0 2069.5 2089.0 2103.5 2114.5 2118.3 2072.1 2080.5 2100.8 2104.2 2104.9 2072.9 2097.0 2097.7 2098.8 2106.7 2074.1 2105.3 2105.8 2107.7 2117.1 7903.0 7931.6 8001.1 8018.0 8022.0 4979.6 5175.4 5190.2 5204.4 5222.9 3220.5 3407.7 3445.2 3494.3 3498.5 951.6 965.2 1003.9 1025.9 1029.4 10974.2 11018.4 11087.8 11093.3 11141.2 3781.8 4202.4 4277.0 4416.0 4419.4 8673.0 8683.4 8686.2 8692.9 8701.7 5056.9 5076.7 5081.8 5082.5 5083.8 3982.1 4309.4 4392.6 4727.0 4807.8 3590.0 3619.6 3685.7 3700.7 3701.1 1128.2 1140.6 1145.8 1155.7 1156.4 848.5 853.4 854.9 862.6 875.9 5353.2 5410.5 5511.5 5690.0 5740.6 859.8 867.4 880.7 883.6 894.5 3484.4 3518.7 3634.2 3637.4 3780.2 9417.5 10097.6 10109.5 10224.7 10243.3 9917.9 10044.8 10185.2 10189.2 10192.7 7546.1 7776.0 7794.7 7834.1 7852.1 5338.0 5384.1 5492.1 5510.8 5546.1 9051.9 9309.3 9367.4 9459.4 9534.0 9411.8 9446.5 9476.7 9658.4 9696.6 6896.4 7120.2 7304.0 7306.3 7311.8 7845.0 8093.5 8097.6 8103.0 8106.2 7047.2 7148.5 7288.4 7292.6 7293.6 7077.2 7105.3 7105.6 7165.0 7184.6 6497.2 6637.5 6701.8 6707.4 6717.2 4755.2 4779.7 4847.4 4881.2 4982.6 4748.2 4874.1 4896.5 4917.4 4978.8 06:05:51 INFO - PROCESS | 1637 | 06:05:51 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4376.16 Median:4890.72 stddev:1360.73 (27.8%) stddev-sans-first:1329.27 06:05:51 INFO - PROCESS | 1637 | Values: 274.4 297.8 305.6 309.3 313.0 4448.6 4666.5 5148.7 5173.7 5195.4 4851.6 4895.6 4918.2 4953.8 5121.9 3289.9 3918.3 3928.3 3932.4 3932.4 3358.5 3474.8 3772.4 3918.6 3944.7 3367.7 3555.6 3736.4 3921.1 3934.0 3943.0 3943.7 3947.3 3949.8 3981.9 3045.8 3305.2 3481.2 3484.9 3494.9 4125.8 4761.5 5009.9 5054.7 5065.3 3987.7 4531.6 4538.3 4556.9 4577.3 5427.4 5441.9 5449.6 5451.8 5482.6 3835.7 3849.7 3850.2 3853.8 3856.1 4681.1 5364.4 5647.6 5728.5 5729.1 3539.5 3740.3 3895.6 3899.4 3920.4 3385.3 3483.9 3883.2 3933.9 3967.5 4017.5 4484.1 4557.0 4618.4 4619.4 5000.4 5452.5 5465.5 5485.5 5506.5 1096.7 1176.7 1287.3 1289.6 1299.7 742.8 768.0 849.4 860.7 908.4 4272.0 4284.5 4699.3 4885.0 4900.7 4122.7 5095.8 5232.3 5260.8 5279.1 3856.7 4200.7 4621.4 4648.6 4703.9 2473.6 2685.6 2720.6 2735.0 2772.6 5036.9 5202.9 5286.2 5365.8 5442.7 4812.9 5336.4 5384.6 5394.9 5787.5 5242.8 5882.9 5916.0 5938.8 5957.6 4643.6 4839.9 5675.3 5704.8 5729.4 5241.0 5554.3 5621.1 5636.8 5666.0 4944.3 5683.6 5813.0 5877.2 5922.9 3147.0 3679.8 3708.3 3787.5 3825.4 4928.3 5450.5 5656.0 5658.8 5680.6 5452.2 5501.3 5517.5 5530.9 5550.0 4885.9 5061.7 5484.0 5511.8 5544.9 5352.4 5364.3 5379.9 5394.3 5405.5 4590.5 5233.4 5280.9 5419.2 5461.6 5315.9 5344.7 5362.8 5395.3 5423.3 06:05:51 INFO - PROCESS | 1637 | 06:05:51 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19633.08 Median:631.80 stddev:30684.12 (4856.6%) stddev-sans-first:30737.18 06:05:51 INFO - PROCESS | 1637 | Values: 673.0 766.8 772.5 785.4 799.9 11803.7 12852.6 13347.3 13736.7 13783.5 12390.5 12747.3 12749.2 12769.7 12778.0 643.8 808.0 827.4 827.7 832.8 665.5 673.4 789.8 816.2 818.3 855.5 863.8 867.5 868.0 868.5 862.9 863.7 863.8 864.2 865.3 502.2 518.7 613.1 631.3 638.5 10967.8 11754.1 11758.8 11769.1 11849.4 8934.4 10184.3 10347.4 10470.4 10537.3 8261.4 9228.9 9483.8 9517.2 9824.0 3012.8 3019.1 3033.8 3057.7 3125.2 84106.2 88380.0 88841.1 89499.0 90294.1 7081.3 8131.1 8147.1 8156.6 8261.8 15773.7 16455.2 16464.2 16797.7 16810.2 7475.6 7560.2 7621.9 7642.7 7720.4 4186.5 4202.5 4237.5 4239.2 4249.1 3292.5 3392.9 3397.7 3399.2 3400.6 591.6 604.6 632.3 642.5 655.8 537.5 543.6 558.3 562.9 657.9 8318.8 8459.2 8541.7 8544.8 8587.3 601.4 633.1 634.4 637.9 658.0 3981.9 4051.6 4078.3 4132.9 4184.7 76083.2 96005.0 120102.0 121290.4 126020.4 85223.1 103407.0 103890.0 104696.5 106832.0 89704.2 90044.0 92922.0 92994.5 93425.5 7976.9 8057.3 8069.7 8271.1 8367.9 40588.0 47119.2 48126.8 49459.5 54404.0 51008.0 67974.0 71863.9 73392.6 77331.6 9730.9 9879.4 10046.3 10303.9 11222.9 12029.6 12049.6 12234.8 12371.3 12707.7 10989.6 11074.9 11105.7 11254.5 11563.9 11019.6 11342.6 11448.1 11695.8 12118.0 11101.5 11134.8 11205.9 11289.2 11491.3 8074.4 9266.1 9346.0 9385.3 9520.2 9284.1 9538.4 9544.1 9742.3 9797.8 06:05:51 INFO - PROCESS | 1637 | -------- Summary: end -------- 06:05:51 INFO - PROCESS | 1637 | 06:05:52 INFO - TEST-INFO | 1637: exit 0 06:05:52 INFO - TEST-OK | dromaeo_css | took 1120460ms 06:05:52 INFO - TEST-START | kraken 06:05:52 INFO - operating with platform_type : mac_ 06:05:52 INFO - Initialising browser for kraken test... 06:05:52 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpQ1Upaf/profile http://localhost:49237/getInfo.html) 06:05:54 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 06:05:54 INFO - PROCESS | 1647 | colorDepth:24 06:05:54 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 06:05:54 INFO - PROCESS | 1647 | __metrics 06:05:54 INFO - PROCESS | 1647 | 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" 06:05:54 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:05:55 INFO - TEST-INFO | 1647: exit 0 06:05:55 INFO - Browser initialized. 06:05:55 INFO - Running cycle 1/1 for kraken test... 06:05:55 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpQ1Upaf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:07 INFO - PROCESS | 1649 | RSS: Main: 238112768 06:06:07 INFO - PROCESS | 1649 | 06:06:10 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 06:06:11 INFO - PROCESS | 1649 | RSS: Main: 289136640 06:06:11 INFO - PROCESS | 1649 | 06:06:13 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 06:06:14 INFO - PROCESS | 1649 | RSS: Main: 289394688 06:06:14 INFO - PROCESS | 1649 | 06:06:17 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 06:06:18 INFO - PROCESS | 1649 | RSS: Main: 381247488 06:06:18 INFO - PROCESS | 1649 | 06:06:20 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 06:06:21 INFO - PROCESS | 1649 | RSS: Main: 281731072 06:06:21 INFO - PROCESS | 1649 | 06:06:23 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:06:23 INFO - PROCESS | 1649 | RSS: Main: 286318592 06:06:23 INFO - PROCESS | 1649 | 06:06:26 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 06:06:27 INFO - PROCESS | 1649 | RSS: Main: 328036352 06:06:27 INFO - PROCESS | 1649 | 06:06:30 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 06:06:30 INFO - PROCESS | 1649 | RSS: Main: 329949184 06:06:30 INFO - PROCESS | 1649 | 06:06:33 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 06:06:34 INFO - PROCESS | 1649 | RSS: Main: 326656000 06:06:34 INFO - PROCESS | 1649 | 06:06:36 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:06:36 INFO - PROCESS | 1649 | RSS: Main: 302870528 06:06:36 INFO - PROCESS | 1649 | 06:06:38 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:06:39 INFO - PROCESS | 1649 | RSS: Main: 307212288 06:06:39 INFO - PROCESS | 1649 | 06:06:41 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:06:42 INFO - PROCESS | 1649 | RSS: Main: 310726656 06:06:42 INFO - PROCESS | 1649 | 06:06:44 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:06:45 INFO - PROCESS | 1649 | RSS: Main: 325185536 06:06:45 INFO - PROCESS | 1649 | 06:06:48 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:06:49 INFO - PROCESS | 1649 | RSS: Main: 319275008 06:06:49 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 06:06:51 INFO - PROCESS | 1649 | RSS: Main: 362729472 06:06:51 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | __start_tp_report 06:06:51 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 06:06:51 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 06:06:51 INFO - PROCESS | 1649 | |i|pagename|runs| 06:06:51 INFO - PROCESS | 1649 | |0;ai-astar;111;111;114;112;112;113;112;112;113;112 06:06:51 INFO - PROCESS | 1649 | |1;audio-beat-detection;146;112;112;150;114;112;115;112;139;111 06:06:51 INFO - PROCESS | 1649 | |2;audio-dft;185;183;180;184;185;183;183;182;253;185 06:06:51 INFO - PROCESS | 1649 | |3;audio-fft;80;56;76;110;87;58;59;59;81;58 06:06:51 INFO - PROCESS | 1649 | |4;audio-oscillator;86;71;90;70;69;68;89;68;68;93 06:06:51 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;89;87;90;87;90;86;90;89;90;86 06:06:51 INFO - PROCESS | 1649 | |6;imaging-darkroom;95;95;95;94;95;95;109;149;149;96 06:06:51 INFO - PROCESS | 1649 | |7;imaging-desaturate;129;140;88;88;86;87;87;87;88;85 06:06:51 INFO - PROCESS | 1649 | |8;json-parse-financial;56;57;55;57;56;55;57;57;57;55 06:06:51 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;64;78;80;76;74;70;70;70;70;72 06:06:51 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;86;90;88;86;90;85;104;87;86;90 06:06:51 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;151;149;148;148;146;144;149;149;192;154 06:06:51 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;177;173;173;175;175;174;171;173;174;173 06:06:51 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;66;64;79;89;91;72;67;67;66;69 06:06:51 INFO - PROCESS | 1649 | __end_tp_report 06:06:51 INFO - PROCESS | 1649 | __start_cc_report 06:06:51 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2033 06:06:51 INFO - PROCESS | 1649 | __end_cc_report 06:06:51 INFO - PROCESS | 1649 | __startTimestamp1479391611371__endTimestamp 06:06:51 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | ------- Summary: start ------- 06:06:51 INFO - PROCESS | 1649 | Number of tests: 14 06:06:51 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:0.92 (0.8%) stddev-sans-first:0.87 06:06:51 INFO - PROCESS | 1649 | Values: 111.0 111.0 114.0 112.0 112.0 113.0 112.0 112.0 113.0 112.0 06:06:51 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:122.30 Median:114.50 stddev:15.92 (13.9%) stddev-sans-first:14.40 06:06:51 INFO - PROCESS | 1649 | Values: 146.0 112.0 112.0 150.0 114.0 112.0 115.0 112.0 139.0 111.0 06:06:51 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:190.30 Median:184.50 stddev:22.09 (12.0%) stddev-sans-first:23.34 06:06:51 INFO - PROCESS | 1649 | Values: 185.0 183.0 180.0 184.0 185.0 183.0 183.0 182.0 253.0 185.0 06:06:51 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:72.40 Median:67.50 stddev:17.68 (26.2%) stddev-sans-first:18.54 06:06:51 INFO - PROCESS | 1649 | Values: 80.0 56.0 76.0 110.0 87.0 58.0 59.0 59.0 81.0 58.0 06:06:51 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:78.50 stddev:10.76 (13.7%) stddev-sans-first:10.93 06:06:51 INFO - PROCESS | 1649 | Values: 86.0 71.0 90.0 70.0 69.0 68.0 89.0 68.0 68.0 93.0 06:06:51 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:89.50 stddev:1.71 (1.9%) stddev-sans-first:1.80 06:06:51 INFO - PROCESS | 1649 | Values: 89.0 87.0 90.0 87.0 90.0 86.0 90.0 89.0 90.0 86.0 06:06:51 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:107.20 Median:95.00 stddev:22.46 (23.6%) stddev-sans-first:23.39 06:06:51 INFO - PROCESS | 1649 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 109.0 149.0 149.0 96.0 06:06:51 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:87.00 stddev:20.22 (23.2%) stddev-sans-first:17.69 06:06:51 INFO - PROCESS | 1649 | Values: 129.0 140.0 88.0 88.0 86.0 87.0 87.0 87.0 88.0 85.0 06:06:51 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:0.92 (1.6%) stddev-sans-first:0.97 06:06:51 INFO - PROCESS | 1649 | Values: 56.0 57.0 55.0 57.0 56.0 55.0 57.0 57.0 57.0 55.0 06:06:51 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:73.00 stddev:4.70 (6.4%) stddev-sans-first:3.87 06:06:51 INFO - PROCESS | 1649 | Values: 64.0 78.0 80.0 76.0 74.0 70.0 70.0 70.0 70.0 72.0 06:06:51 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:87.50 stddev:5.53 (6.3%) stddev-sans-first:5.75 06:06:51 INFO - PROCESS | 1649 | Values: 86.0 90.0 88.0 86.0 90.0 85.0 104.0 87.0 86.0 90.0 06:06:51 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:153.00 Median:149.00 stddev:13.96 (9.4%) stddev-sans-first:14.79 06:06:51 INFO - PROCESS | 1649 | Values: 151.0 149.0 148.0 148.0 146.0 144.0 149.0 149.0 192.0 154.0 06:06:51 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:174.00 stddev:1.62 (0.9%) stddev-sans-first:1.24 06:06:51 INFO - PROCESS | 1649 | Values: 177.0 173.0 173.0 175.0 175.0 174.0 171.0 173.0 174.0 173.0 06:06:51 INFO - PROCESS | 1649 | 06:06:51 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:70.50 stddev:9.91 (14.1%) stddev-sans-first:10.18 06:06:51 INFO - PROCESS | 1649 | Values: 66.0 64.0 79.0 89.0 91.0 72.0 67.0 67.0 66.0 69.0 06:06:51 INFO - PROCESS | 1649 | -------- Summary: end -------- 06:06:51 INFO - PROCESS | 1649 | 06:06:52 INFO - TEST-INFO | 1649: exit 0 06:06:52 INFO - TEST-OK | kraken | took 60165ms 06:06:52 INFO - SUITE-END | took 1180s 06:06:52 INFO - Completed test suite (00:19:40) 06:06:52 INFO - javascript benchmark 06:06:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3146.952795708065, 3204.1509000114966, 3342.264701765611, 3363.058343663772, 3390.2541440882997, 4841.57173633778, 5394.595405344595, 5625.071863142582, 5688.488036076757, 5691.544676425887, 5617.101263797783, 5633.774649014044, 5659.971700141494, 5729.627574207663, 5739.282589676291, 5154.175331946889, 5166.095933211692, 5196.220566914955, 5214.60890433219, 5215.1395019821875, 5116.692998420088, 5277.393099793535, 5286.04851126797, 5286.497782710656, 5344.331958505187, 5265.6840589564745, 5292.020976119411, 5299.470052994689, 5310.62825602208, 5357.705326207057, 5118.411382691001, 5143.485651434864, 5172.0, 5181.35233095863, 5221.921671174935, 5154.4072431670465, 5170.1469257572835, 5180.896382072375, 5246.422893481714, 5254.448282930275, 5642.294713160855, 5648.802291919763, 5656.519195868356, 5689.231953686241, 5692.715364231772, 6051.213342265477, 6124.0, 6214.502839772807, 6218.9378106219265, 6224.719887605069, 5122.0, 6068.757249710006, 6172.722227499773, 6185.010398336244, 6194.946859033975, 5727.255456790591, 5731.914021289684, 5734.684592347461, 5740.253767010346, 5745.109508026221, 6176.227971503562, 6197.25632924043, 6225.3774622538285, 6235.376462353728, 6295.685215739195, 6126.203593532812, 6128.846778830565, 6153.2000839890525, 6157.138000679908, 6160.44555989963, 6234.0, 6245.344238854855, 6260.248770147611, 6261.9373806262265, 6262.780802671885, 4969.180085285887, 5968.731407086691, 6066.545009124245, 6125.142480052797, 6127.080937859357, 6050.667213303311, 6057.60625559346, 6058.727357268934, 6067.0, 6095.542834287447, 4834.323194752737, 4837.854864354004, 4840.491748366371, 4848.490908454562, 4884.682495637772, 3737.32728108943, 4309.784510774449, 4319.244132276839, 4376.343548467756, 4411.647068234533, 5726.914096288559, 5727.226824378656, 5732.111522713986, 5743.827685169452, 5751.1373294006235, 6169.660668663267, 6197.4732147767045, 6220.222472190976, 6227.844303892349, 6230.657313847782, 5681.147827825859, 5725.112607545837, 5742.913856292159, 5755.539556835443, 5764.798232061858, 4541.636669066466, 5206.219067139884, 5335.759890804923, 5357.491038351351, 5358.089124848785, 6259.78090766821, 6295.622262664255, 6296.716647750954, 6303.842403939938, 6317.747290108528, 6159.784407545714, 6217.502599792097, 6236.407541283571, 6269.7178626962805, 6283.088952102011, 6274.968625157027, 6292.087647291026, 6303.779367722108, 6309.33751956038, 6309.968450157719, 5999.400059993965, 6049.425304596057, 6180.351063138306, 6188.9690551546955, 6190.597611155261, 6018.578699491169, 6182.598131121463, 6205.131281620667, 6209.5963762357105, 6212.844678883064, 5862.560307976833, 5964.373740757158, 6006.129111278928, 6011.939880601138, 6025.728842202199, 5228.320318358589, 5324.494173053554, 5991.7603295867675, 6003.339632640319, 6136.73353236607, 5942.61373010753, 5949.167116603592, 5975.790847320323, 6003.939960600338, 6006.429389208019, 6032.668203248688, 6096.451319381277, 6133.202683651097, 6147.508199344131, 6150.477209437248, 5732.226149469935, 5794.072948328248, 5977.193078934462, 5989.790357337472, 5991.910121348096], "value": 5633.5661739397, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.2411171187363, 506.0056988018543, 517.2448225590638, 519.3170980161085, 550.9614326997107, 24999.0, 31470.68529314706, 32443.0, 32568.185795355068, 32600.67399326006, 32135.35729285413, 32632.0, 32742.0, 32790.50814237788, 32850.0, 6068.0291153415465, 7154.391876690487, 7337.816554586125, 7345.522541034816, 7346.706131754723, 6230.345813689565, 7236.2401947795515, 7495.400367970549, 7500.362469190125, 7539.849203015937, 7493.625318734069, 7538.1331146918255, 7543.735969241077, 7546.54720716756, 7570.432217583676, 7502.924970750277, 7549.698012079482, 7560.395168386516, 7566.962165189194, 7573.545587264782, 7552.055993000875, 7646.8088297793, 7646.929429879821, 7650.808729781745, 7652.693892244303, 30890.918817841266, 31195.220119497193, 31231.84384078065, 31275.84362078175, 31297.374052518822, 3194.9361012779614, 3398.9660103398896, 3468.9653103468895, 3816.3321418751607, 3845.692344612424, 21136.0, 21517.892410538003, 21701.806400647958, 21711.674324885138, 21761.0, 2826.2369160326803, 2833.4049849531625, 2862.255813488487, 2890.262982939358, 2917.722816332445, 485800.99999999645, 488675.0, 494164.0, 494175.0, 506774.0, 59191.70404147952, 59592.0, 59707.0, 59740.10389844156, 59752.506187345665, 67352.0, 68587.65706171437, 68768.0, 71255.2874471259, 72221.63889180521, 15390.153541555323, 15782.68434631301, 15789.973651712602, 15792.447264345692, 15822.0, 10911.618093366695, 11038.448077596087, 11055.00504954558, 11929.403529823474, 12067.939660301643, 19802.801971980094, 20221.0, 20234.595308093754, 20644.69032964507, 20736.889466579833, 7172.0, 8353.37349698775, 8526.65893364271, 8527.573621319034, 8666.220040196287, 709.2481969112757, 885.7431344909904, 902.1745103230471, 985.7042887133831, 1019.1388276906151, 22482.66276005861, 28685.426291474472, 28837.42325153527, 29233.0, 29286.848174439136, 986.1519093579516, 1050.3277902142636, 1051.363924825485, 1080.7622323088908, 1096.6381094238882, 14533.92733036328, 15065.246737663074, 15074.944753867125, 15350.923245383701, 15468.92265538665, 667024.0, 670140.9337926103, 670222.0, 672584.0, 672634.0, 50435.49564504381, 51157.23264151041, 51181.74409128005, 51218.0, 51411.228831567554, 1197.8263151842934, 1249.28790589365, 1249.8187762774164, 1327.1904138475522, 1358.9388477518535, 27875.860620696767, 28643.427131457673, 29157.833686652295, 29418.940674152604, 29969.0, 49407.011859761886, 49781.50218497769, 49843.750781245864, 49978.500214998836, 50086.749566251936, 504985.0, 591747.0, 596377.0, 598432.0, 600746.0, 32479.837600811843, 33436.33127337488, 34281.97154085382, 37828.43257351087, 39473.210535789694, 39434.0, 40995.0, 41085.35582268793, 41108.38337424881, 41620.791896040326, 34571.0, 34608.78869239565, 34663.13342166466, 35103.94688159359, 35936.28127437489, 25974.0, 34108.488372674925, 34220.657793422746, 35309.29381412409, 35341.82329088338, 34040.82979585086, 34155.4876676855, 34493.82753086218, 34684.82657586696, 34689.30621387609, 25071.623925640764, 25823.48353032891, 26168.214953551425, 26545.0, 26620.0, 21056.894715526323, 21786.564268714854, 22961.655575166053, 23772.0, 23790.0], "value": 18220.84478150614, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.1093375897847, 371.63765328804413, 377.1495278147776, 385.9170278390149, 397.6004115863557, 15206.92396538017, 16299.577088811335, 16320.75518867218, 16514.917425412856, 16734.41429549966, 18052.638947221047, 18673.159707813145, 19044.33344832931, 19584.314548990787, 19817.900910495464, 4946.381702287223, 5233.502817232356, 5237.607179461536, 5241.554467870235, 5245.816396426126, 3446.5174875517446, 3615.728820338472, 3718.1634132320282, 5102.923456148161, 5192.013517431695, 5181.559567436772, 5183.144781111112, 5193.324867767204, 5197.7401129943355, 5213.2962050123315, 4947.431045429786, 5120.103981803207, 5171.0692075426405, 5194.558462530689, 5208.661437006602, 4583.839565615188, 4587.24310488769, 4592.862214133581, 4595.310703394484, 4598.816047358102, 21044.368668939802, 21240.575188496143, 22253.44366390837, 22458.0, 22568.548629027493, 2082.83337333013, 2192.6053310404122, 2260.536589999046, 2336.684547586071, 2346.460314127743, 13713.931430342884, 14241.145531268157, 14265.714685706227, 14392.424303027867, 15021.0, 1770.9645807083914, 1824.1791193962638, 1840.834324910751, 1874.690676038452, 1878.4176905159445, 127311.36344318218, 130834.0, 138348.0, 139583.60416395808, 140316.0, 16277.59306017359, 18678.719819202724, 20649.58700825975, 21110.577788444145, 21317.147314107573, 31524.684753152633, 34779.82610086984, 34879.302413952086, 34888.0, 34995.300093997976, 10080.445575493419, 10249.436281004617, 10455.0, 10460.63387781424, 10651.254412191072, 8503.447275927045, 8506.702265420681, 8526.57367131641, 8697.999730031, 8714.607842647096, 7833.686652533949, 9420.764480888032, 9496.008757241447, 9656.517174141265, 9659.372140810825, 3243.351329734063, 3497.0732755819727, 3729.1236559408517, 3729.1609387887506, 3755.586885442599, 811.7524155132623, 847.8516259654535, 858.4463021351194, 874.5889431966965, 902.2962089570145, 20067.899660501604, 20522.281720139723, 20619.4845128873, 20737.481562960744, 20920.581588368146, 766.3639179481017, 845.1168528887205, 890.172139909877, 903.5075883643431, 930.7905721212672, 10591.94704026475, 10943.890561094287, 11000.559977600806, 11043.668689939153, 11064.557417703363, 552287.2385638127, 564874.0, 573503.0, 578109.0, 579260.0, 124584.37707811584, 124736.0, 126905.3654731739, 127626.36186819007, 129768.3511582455, 946.6402766948653, 958.2334132693817, 965.7199412170532, 966.5602151021268, 970.2965350121247, 16149.67700645957, 17496.0, 17864.69503141923, 18542.232699376786, 18635.347762828234, 49559.75220123876, 49561.25658115059, 51878.48121518736, 51983.0, 52724.73637631787, 77011.84482232659, 77216.0, 77812.22187778277, 80451.0, 84983.0, 7092.6099064551945, 7274.0, 7376.188619251985, 7455.329020388191, 7909.960450197712, 11023.61417350389, 11296.6046188383, 11826.940865295619, 12517.499300027897, 12833.3424973882, 8884.689035883714, 10623.89376106229, 10859.294145880493, 11024.779504409706, 11104.222704410613, 10474.52864621109, 10629.309094908805, 10861.0, 11047.281926674741, 11047.779044419227, 10034.785390136014, 10856.537200479444, 11253.324800511995, 11288.887111128784, 11291.266067705574, 7257.0, 7319.158296795937, 7375.963120184365, 7400.666969986256, 7521.210272921265, 10536.0, 10666.520006599876, 11008.009279164913, 11055.0, 11109.277896936674], "value": 9940.695551360808, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.421110500275, 1344.5361350334133, 1484.0947022316386, 1618.9190540472973, 1831.1302131487553, 6505.479561635069, 7559.319661230488, 7771.766846994592, 8019.759407217793, 8025.237602427775, 7934.7222847200355, 8019.839603207933, 8027.91972080279, 8032.959835200816, 8035.517868927854, 1997.2410484016054, 2023.8178563929243, 2027.3715148304, 2027.726256955307, 2031.035258252333, 2069.503319203388, 2088.968665470019, 2103.495161161318, 2114.46081249282, 2118.3433135727973, 2072.0986370928617, 2080.5110798962232, 2100.831933445321, 2104.1898868935496, 2104.884231367274, 2072.917083316673, 2096.9790302096935, 2097.7168082308845, 2098.821600163988, 2106.683997400387, 2074.09776747114, 2105.3473423238843, 2105.789421057882, 2107.7365329333834, 2117.089651449876, 7903.012123484565, 7931.643076061533, 8001.079875814239, 8018.037835459724, 8021.95989020057, 4979.601631869442, 5175.430702622709, 5190.195519694454, 5204.42751297357, 5222.947770522284, 3220.5491231227647, 3407.744419168572, 3445.1903802606366, 3494.318607871466, 3498.5451891253974, 951.5527701980059, 965.2374624046995, 1003.8717918013784, 1025.912797412221, 1029.433811403725, 10974.231803773739, 11018.44907754617, 11087.778244435147, 11093.33439993595, 11141.220114591983, 3781.810909454571, 4202.411662367271, 4277.0, 4415.955840441618, 4419.359192917009, 8672.956635216784, 8683.392162548687, 8686.218240358397, 8692.91307086921, 8701.738947831574, 5056.9494305057215, 5076.7207803571155, 5081.7967281309075, 5082.491750824888, 5083.822066227664, 3982.104026594051, 4309.41822853917, 4392.648588112943, 4726.952730472652, 4807.807687692523, 3589.953726375993, 3619.583747868976, 3685.7051435885064, 3700.666939975415, 3701.1487357907295, 1128.15388458656, 1140.5722853929776, 1145.7994850901225, 1155.6937411585768, 1156.4275683536703, 848.4909054567211, 853.4409961475244, 854.9145085491401, 862.5816479007676, 875.8598624220094, 5353.197020446886, 5410.458954104558, 5511.476409741068, 5689.975804355173, 5740.598158128891, 859.8349236784193, 867.3798234262532, 880.6829541365104, 883.5538053283051, 894.4543828264754, 3484.3728128937037, 3518.683318501347, 3634.23681026982, 3637.436197389409, 3780.1872597391693, 9417.529123543796, 10097.646582369582, 10109.494525273854, 10224.744381390525, 10243.282970192015, 9917.851232231522, 10044.849327260097, 10185.185185185168, 10189.23580731448, 10192.694219173436, 7546.132194797558, 7776.0, 7794.727184548514, 7834.099078605919, 7852.057753069554, 5338.0, 5384.111621582395, 5492.093804522369, 5510.8071217507195, 5546.140348245867, 9051.90948090537, 9309.255259579353, 9367.391119577478, 9459.432434053979, 9534.0, 9411.81176376455, 9446.480443575394, 9476.715698529055, 9658.420494770337, 9696.6121355145, 6896.379325860697, 7120.181179164462, 7304.0, 7306.305900939402, 7311.817204569716, 7844.9607751960875, 8093.473924194908, 8097.595120244082, 8102.987126609174, 8106.189381061847, 7047.224805271519, 7148.535345202546, 7288.416926645961, 7292.635368231461, 7293.598852063187, 7077.1507419107975, 7105.253948335557, 7105.644717764195, 7164.9641751790905, 7184.568925864465, 6497.18785151856, 6637.535372523877, 6701.765438209639, 6707.42986846104, 6717.193936727624, 4755.191617424977, 4779.665423420327, 4847.418309802846, 4881.194602890625, 4982.576480999156, 4748.240281554935, 4874.147024270809, 4896.4858689838475, 4917.409910810726, 4978.751062446936], "value": 4275.674675152266, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.42918729043583, 297.8361900954475, 305.6057685585595, 309.34573377307004, 313.03897036099187, 4448.620927512469, 4666.510016448275, 5148.683092608322, 5173.689578625285, 5195.441367589722, 4851.611871050316, 4895.5838753705975, 4918.163912134936, 4953.801847926079, 5121.923171152435, 3289.8848540301096, 3918.294706952747, 3928.29119333091, 3932.4101384792366, 3932.4297976793346, 3358.4811391456406, 3474.8436320365518, 3772.3775577029755, 3918.5689574146822, 3944.73768394114, 3367.6632336766374, 3555.5911070227, 3736.4395340698975, 3921.117748506592, 3933.9606603934026, 3942.980285098556, 3943.6647884929816, 3947.3289540778137, 3949.8420063197436, 3981.904976131558, 3045.7969102204506, 3305.190228394059, 3481.181922248295, 3484.860605575774, 3494.860205591773, 4125.752454852718, 4761.452432970218, 5009.924851127236, 5054.725373581903, 5065.316182315414, 3987.7407968481957, 4531.614812740921, 4538.341940418621, 4556.863294101182, 4577.313402989545, 5427.3758517770175, 5441.863953401157, 5449.591280653927, 5451.754671039813, 5482.641300166378, 3835.6547910688173, 3849.7295892355455, 3850.249201405727, 3853.807309634535, 3856.055266459707, 4681.057361195066, 5364.356277246756, 5647.604667673265, 5728.513076388554, 5729.140628905656, 3539.4513850353237, 3740.31685741412, 3895.6365272155085, 3899.3760998240714, 3920.3923391874305, 3385.272166484218, 3483.8780642677384, 3883.203943191639, 3933.940990885139, 3967.484227050523, 4017.5449113762143, 4484.0583477469445, 4556.97721511397, 4618.445786505641, 4619.445666519972, 5000.424951130593, 5452.482014208644, 5465.535429488538, 5485.4788795064405, 5506.504414602705, 1096.660035389032, 1176.6646505745994, 1287.3305880941857, 1289.5873320537337, 1299.7010687541917, 742.7808796405074, 767.9577623230664, 849.362977766675, 860.6514361683528, 908.3913777768911, 4271.978640106841, 4284.464441944757, 4699.318598803155, 4884.975575122102, 4900.721164658451, 4122.732022418533, 5095.80248641569, 5232.293640358579, 5260.789568417221, 5279.102552565996, 3856.749311294757, 4200.684948628865, 4621.353010578522, 4648.628109751212, 4703.905921881612, 2473.5547601431554, 2685.5971604259516, 2720.564709646447, 2734.9589756153673, 2772.6395568575954, 5036.924446133311, 5202.886608235309, 5286.20706893969, 5365.8390248291835, 5442.700651464207, 4812.879678008007, 5336.4129945705945, 5384.596155288369, 5394.9460505394445, 5787.450192231731, 5242.842714718565, 5882.852928676817, 5916.0, 5938.792142275086, 5957.582969192115, 4643.628509719282, 4839.879003024953, 5675.262215911905, 5704.8019915816485, 5729.369769325288, 5241.008416801591, 5554.305711786027, 5621.100623900156, 5636.830895073154, 5666.03677374839, 4944.332515110558, 5683.584476597513, 5813.0, 5877.206577112035, 5922.881542369042, 3146.98426507866, 3679.7856707287065, 3708.2744183024915, 3787.4697542344643, 3825.4261860720003, 4928.314068832423, 5450.482204190595, 5655.971720141538, 5658.801941932013, 5680.602357834912, 5452.236686863922, 5501.284832971848, 5517.475839795213, 5530.889382212414, 5550.030733557527, 4885.853424397274, 5061.683962169789, 5484.0, 5511.779528818963, 5544.889102217852, 5352.41123476425, 5364.275822763877, 5379.892402152013, 5394.298741163623, 5405.486478784509, 4590.495045544921, 5233.39815921174, 5280.867978300574, 5419.187121931742, 5461.590380721541, 5315.867103322294, 5344.7060411676175, 5362.785488580413, 5395.325584301962, 5423.29497165366], "value": 3939.6167814566634, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.9831754206145, 766.769969009297, 772.5133166105354, 785.4429908398081, 799.8800179973003, 11803.70490737732, 12852.550160744377, 13347.332633368342, 13736.725265494684, 13783.517576884811, 12390.504379824797, 12747.298898560575, 12749.235045897252, 12769.744605107891, 12778.0, 643.7618081309898, 807.991920080799, 827.4166712467726, 827.7227128911821, 832.7543374704446, 665.490899461912, 673.4275865514322, 789.7907054630499, 816.2082779703678, 818.2758258940821, 855.5294587976588, 863.8229163021565, 867.5055218525443, 867.9826403471927, 868.4572142410993, 862.9309655227567, 863.6588547523693, 863.8013256950906, 864.2178828160494, 865.3423398217337, 502.20651370833997, 518.7017464957627, 613.0773186354553, 631.2708821311347, 638.5147288061061, 10967.780644387067, 11754.05967522596, 11758.823617645741, 11769.117316201318, 11849.40752962357, 8934.4192627479, 10184.338018028804, 10347.379157250514, 10470.42412667303, 10537.315074520207, 8261.421700480969, 9228.91073095487, 9483.810323793485, 9517.191038761714, 9824.0, 3012.774041946863, 3019.0791808498398, 3033.8028028178096, 3057.6942305769467, 3125.2030732163153, 84106.15893841044, 88379.99999999936, 88841.11158888393, 89499.0, 90294.09705902923, 7081.291870812877, 8131.105578386373, 8147.063087744867, 8156.632951517196, 8261.752147435587, 15773.68452630941, 16455.177241137895, 16464.176791160393, 16797.664046718997, 16810.15949202535, 7475.6262186890435, 7560.206178351194, 7621.885671714928, 7642.656080476392, 7720.382369410434, 4186.539480657125, 4202.495700515958, 4237.491501019836, 4239.1521695660995, 4249.065205654751, 3292.489664102068, 3392.8642854286045, 3397.725852805198, 3399.2351720863103, 3400.5579274694132, 591.5504216795266, 604.5943182101631, 632.3234139470815, 642.4507046475289, 655.7639249870043, 537.5108651127455, 543.6330476928058, 558.3439458636086, 562.8761672432058, 657.8585604095142, 8318.8336233275, 8459.196376344238, 8541.743747687578, 8544.829103417896, 8587.313014958789, 601.4256385152256, 633.1104797759156, 634.3783092569216, 637.8756142552251, 657.9868402631921, 3981.8606348778235, 4051.554329023805, 4078.286299897506, 4132.938005929914, 4184.727992680466, 76083.23916760873, 96005.039949601, 120102.0, 121290.3935480317, 126020.36989814992, 85223.14776852276, 103407.0, 103890.0, 104696.47651761693, 106832.0, 89704.20591588132, 90044.0, 92922.0, 92994.53502732307, 93425.5328723352, 7976.9202307976175, 8057.315128213933, 8069.7175598853755, 8271.13153118938, 8367.916320836714, 40588.0, 47119.225327820524, 48126.79683007813, 49459.50540494693, 54404.0, 51008.0, 67974.0, 71863.92204116838, 73392.63303683448, 77331.61334193293, 9730.902690973282, 9879.357841740264, 10046.346987445793, 10303.896961030594, 11222.943885280521, 12029.578964736193, 12049.634920001372, 12234.816477752664, 12371.257724536557, 12707.745845083231, 10989.560417583207, 11074.889251107386, 11105.722356941142, 11254.549818007516, 11563.88436115628, 11019.559217631526, 11342.60300889465, 11448.141389395661, 11695.76608467809, 12118.0, 11101.50043248072, 11134.832977505182, 11205.943970280096, 11289.20975531705, 11491.310521368745, 8074.434789564674, 9266.11971862672, 9346.0, 9385.343025988115, 9520.166898470317, 9284.118008789153, 9538.380005299634, 9544.093311135432, 9742.31803773729, 9797.804043919225], "value": 6665.338180849699, "unit": "score"}], "name": "dromaeo_css", "value": 6969.198947377897, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 114.0, 112.0, 112.0, 113.0, 112.0, 112.0, 113.0, 112.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 112.0, 112.0, 150.0, 114.0, 112.0, 115.0, 112.0, 139.0, 111.0], "value": 122.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 180.0, 184.0, 185.0, 183.0, 183.0, 182.0, 253.0, 185.0], "value": 190.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 56.0, 76.0, 110.0, 87.0, 58.0, 59.0, 59.0, 81.0, 58.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 90.0, 70.0, 69.0, 68.0, 89.0, 68.0, 68.0, 93.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 90.0, 87.0, 90.0, 86.0, 90.0, 89.0, 90.0, 86.0], "value": 88.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 109.0, 149.0, 149.0, 96.0], "value": 107.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 140.0, 88.0, 88.0, 86.0, 87.0, 87.0, 87.0, 88.0, 85.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 55.0, 57.0, 56.0, 55.0, 57.0, 57.0, 57.0, 55.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 78.0, 80.0, 76.0, 74.0, 70.0, 70.0, 70.0, 70.0, 72.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 88.0, 86.0, 90.0, 85.0, 104.0, 87.0, 86.0, 90.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 148.0, 148.0, 146.0, 144.0, 149.0, 149.0, 192.0, 154.0], "value": 153.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 173.0, 173.0, 175.0, 175.0, 174.0, 171.0, 173.0, 174.0, 173.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 79.0, 89.0, 91.0, 72.0, 67.0, 67.0, 66.0, 69.0], "value": 73.0, "unit": "score"}], "name": "kraken", "value": 1484.1000000000001, "alertThreshold": 2.0}]} 06:06:52 INFO - Return code: 0 06:06:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:06:52 INFO - # TBPL SUCCESS # 06:06:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:06:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:06:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:06:52 INFO - 2016-11-17 06:06:52.692 screenresolution[1653:9784] starting screenresolution argv=screenresolution get 06:06:52 INFO - 2016-11-17 06:06:52.695 screenresolution[1653:9784] Display 0: 1600x1200x32@60 06:06:52 INFO - 2016-11-17 06:06:52.701 screenresolution[1654:9787] starting screenresolution argv=screenresolution list 06:06:52 INFO - Available Modes on Display 0 06:06:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:06:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:06:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:06:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:06:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:06:52 INFO - Intel Iris: 06:06:52 INFO - Chipset Model: Intel Iris 06:06:52 INFO - Type: GPU 06:06:52 INFO - Bus: Built-In 06:06:52 INFO - VRAM (Dynamic, Max): 1536 MB 06:06:52 INFO - Vendor: Intel (0x8086) 06:06:52 INFO - Device ID: 0x0a2e 06:06:52 INFO - Revision ID: 0x0009 06:06:52 INFO - Displays: 06:06:52 INFO - Display: 06:06:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:06:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:06:52 INFO - Display Serial Number: 1600x1200 60 06:06:52 INFO - Main Display: Yes 06:06:52 INFO - Mirror: Off 06:06:52 INFO - Online: Yes 06:06:52 INFO - Rotation: Supported 06:06:52 INFO - Return code: 0 06:06:52 INFO - Running post-action listener: _resource_record_post_action 06:06:52 INFO - [mozharness: 2016-11-17 14:06:52.942404Z] Finished run-tests step (success) 06:06:52 INFO - Running post-run listener: _resource_record_post_run 06:06:53 INFO - Total resource usage - Wall time: 1215s; CPU: 53.0%; Read bytes: 38818816; Write bytes: 701280256; Read time: 376; Write time: 1920 06:06:53 INFO - TinderboxPrint: CPU usage
53.4% 06:06:53 INFO - TinderboxPrint: I/O read bytes / time
38,818,816 / 376 06:06:53 INFO - TinderboxPrint: I/O write bytes / time
701,280,256 / 1,920 06:06:53 INFO - TinderboxPrint: CPU idle
2,263.3 (46.6%) 06:06:53 INFO - TinderboxPrint: CPU system
970.6 (20.0%) 06:06:53 INFO - TinderboxPrint: CPU user
1,627.6 (33.5%) 06:06:53 INFO - TinderboxPrint: Swap in / out
437,043,200 / 0 06:06:53 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389480960; Write bytes: 383112704; Read time: 29446; Write time: 660 06:06:53 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 36791296; Write bytes: 296772096; Read time: 353; Write time: 1093 06:06:53 INFO - Running post-run listener: _upload_blobber_files 06:06:53 INFO - Blob upload gear active. 06:06:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:06:53 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 06:06:53 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'] 06:06:53 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 06:06:53 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:06:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:06:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:55 INFO - (blobuploader) - INFO - Done attempting. 06:06:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:06:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:06:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:55 INFO - (blobuploader) - INFO - Done attempting. 06:06:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:06:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:06:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:58 INFO - (blobuploader) - INFO - Done attempting. 06:06:58 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:58 INFO - Return code: 0 06:06:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:06:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf48644e3cce2a4a0c110042e7bd29c4f1741e30dfe18b0e581371d59f51c3ab727d6e1e0c21d1fcca9817f51b1fcf5f21209a56926084827b3a9c69ea0d7433", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c20abd787416688051a2ca98773aa8ce05e2b5f20ff7eb65f51d21b80b00a950082e8d0ff3cf41961224e962e066fc9daea73f8b99b1ae3da91992b69e31d967", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/402df7f033a0011243a2523fbc8d0fcd7e3e99eb1cb5d6c950e5b1b7b266c83f2e616446a5d49e279a719ae592f30c6b71a2301252567e177c9dcc13ce136239"} 06:06:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:06:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:06:58 INFO - Contents: 06:06:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf48644e3cce2a4a0c110042e7bd29c4f1741e30dfe18b0e581371d59f51c3ab727d6e1e0c21d1fcca9817f51b1fcf5f21209a56926084827b3a9c69ea0d7433", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c20abd787416688051a2ca98773aa8ce05e2b5f20ff7eb65f51d21b80b00a950082e8d0ff3cf41961224e962e066fc9daea73f8b99b1ae3da91992b69e31d967", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/402df7f033a0011243a2523fbc8d0fcd7e3e99eb1cb5d6c950e5b1b7b266c83f2e616446a5d49e279a719ae592f30c6b71a2301252567e177c9dcc13ce136239"} 06:06:58 INFO - Running post-run listener: copy_logs_to_upload_dir 06:06:58 INFO - Copying logs to upload dir... 06:06:58 INFO - mkdir: /builds/slave/test/build/upload/logs 06:06:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.280442 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-17 06:06:58.282421) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 06:06:58.286289) ========= 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.szTvSjwsHp/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.4bByzQap69/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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/bf48644e3cce2a4a0c110042e7bd29c4f1741e30dfe18b0e581371d59f51c3ab727d6e1e0c21d1fcca9817f51b1fcf5f21209a56926084827b3a9c69ea0d7433", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c20abd787416688051a2ca98773aa8ce05e2b5f20ff7eb65f51d21b80b00a950082e8d0ff3cf41961224e962e066fc9daea73f8b99b1ae3da91992b69e31d967", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/402df7f033a0011243a2523fbc8d0fcd7e3e99eb1cb5d6c950e5b1b7b266c83f2e616446a5d49e279a719ae592f30c6b71a2301252567e177c9dcc13ce136239"} build_url:https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011060 build_url: 'https://queue.taskcluster.net/v1/task/MsCrFnpwQE-iTu3tgEVw1g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf48644e3cce2a4a0c110042e7bd29c4f1741e30dfe18b0e581371d59f51c3ab727d6e1e0c21d1fcca9817f51b1fcf5f21209a56926084827b3a9c69ea0d7433", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c20abd787416688051a2ca98773aa8ce05e2b5f20ff7eb65f51d21b80b00a950082e8d0ff3cf41961224e962e066fc9daea73f8b99b1ae3da91992b69e31d967", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/402df7f033a0011243a2523fbc8d0fcd7e3e99eb1cb5d6c950e5b1b7b266c83f2e616446a5d49e279a719ae592f30c6b71a2301252567e177c9dcc13ce136239"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 06:06:58.318695) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 06:06:58.319135) ========= 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.szTvSjwsHp/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.4bByzQap69/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.005090 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 06:06:58.367980) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 06:06:58.368300) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 06:06:58.368662) ========= ========= Total master_lag: 0.17 =========