builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0300 starttime: 1493120903.06 results: success (0) buildid: 20170425030221 builduid: b33fc7c5d4b64958a0102d88156ab255 revision: a30dc237c3a600a5231f2974fc2b85dfb5513414 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:23.059082) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:23.059827) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:23.060304) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:23.089943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:23.090474) ========= 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.CanPpGoivq/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.cy0yw0TnnV/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-25 04:48:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.8M=0.001s 2017-04-25 04:48:23 (17.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138929 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:23.256365) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:23.256970) ========= 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.CanPpGoivq/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.cy0yw0TnnV/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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.027058 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:23.308026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 04:48:23.308381) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a30dc237c3a600a5231f2974fc2b85dfb5513414 --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 a30dc237c3a600a5231f2974fc2b85dfb5513414 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CanPpGoivq/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.cy0yw0TnnV/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-25 04:48:23,417 truncating revision to first 12 chars 2017-04-25 04:48:23,417 Setting DEBUG logging. 2017-04-25 04:48:23,418 attempt 1/10 2017-04-25 04:48:23,418 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a30dc237c3a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-25 04:48:25,074 unpacking tar archive at: mozilla-central-a30dc237c3a6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.928920 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 04:48:25.262768) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:25.263172) ========= script_repo_revision: a30dc237c3a600a5231f2974fc2b85dfb5513414 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:25.263653) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:25.264060) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 04:48:25.285252) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-25 04:48:25.285681) ========= /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.CanPpGoivq/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.cy0yw0TnnV/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:48:25 INFO - MultiFileLogger online at 20170425 04:48:25 in /builds/slave/test 04:48:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:48:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:48:25 INFO - {'append_to_log': False, 04:48:25 INFO - 'base_work_dir': '/builds/slave/test', 04:48:25 INFO - 'blob_upload_branch': 'Firefox', 04:48:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:48:25 INFO - 'branch': 'Firefox', 04:48:25 INFO - 'buildbot_json_path': 'buildprops.json', 04:48:25 INFO - 'config_files': ('talos/mac_config.py',), 04:48:25 INFO - 'default_actions': ('clobber', 04:48:25 INFO - 'read-buildbot-config', 04:48:25 INFO - 'download-and-extract', 04:48:25 INFO - 'populate-webroot', 04:48:25 INFO - 'create-virtualenv', 04:48:25 INFO - 'install', 04:48:25 INFO - 'run-tests'), 04:48:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:48:25 INFO - 'download_minidump_stackwalk': True, 04:48:25 INFO - 'download_symbols': 'ondemand', 04:48:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:48:25 INFO - 'tooltool.py': '/tools/tooltool.py', 04:48:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:48:25 INFO - '/tools/misc-python/virtualenv.py')}, 04:48:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:48:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:48:25 INFO - 'gecko_profile': False, 04:48:25 INFO - 'gecko_profile_interval': 0, 04:48:25 INFO - 'installer_path': 'installer.exe', 04:48:25 INFO - 'log_level': 'info', 04:48:25 INFO - 'log_name': 'talos', 04:48:25 INFO - 'log_to_console': True, 04:48:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:48:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:48:25 INFO - 'opt_config_files': (), 04:48:25 INFO - 'pip_index': False, 04:48:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:48:25 INFO - 'cmd': ('bash', 04:48:25 INFO - '-c', 04:48:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:48:25 INFO - 'enabled': True, 04:48:25 INFO - 'halt_on_failure': False, 04:48:25 INFO - 'name': 'check_screen_resolution'},), 04:48:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:48:25 INFO - 'cmd': ('bash', 04:48:25 INFO - '-c', 04:48:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:48:25 INFO - 'enabled': True, 04:48:25 INFO - 'halt_on_failure': False, 04:48:25 INFO - 'name': 'check_screen_resolution'},), 04:48:25 INFO - 'run_cmd_checks_enabled': True, 04:48:25 INFO - 'suite': 'dromaeojs', 04:48:25 INFO - 'system_bits': '32', 04:48:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:48:25 INFO - 'title': 't-yosemite-r7-0300', 04:48:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:48:25 INFO - 'use_talos_json': True, 04:48:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:48:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:48:25 INFO - 'work_dir': 'build'} 04:48:25 INFO - [mozharness: 2017-04-25 11:48:25.499537Z] Running clobber step. 04:48:25 INFO - Running pre-action listener: _resource_record_pre_action 04:48:25 INFO - Running main action method: clobber 04:48:25 INFO - rmtree: /builds/slave/test/build 04:48:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:48:27 INFO - Running post-action listener: _resource_record_post_action 04:48:27 INFO - [mozharness: 2017-04-25 11:48:27.944981Z] Finished clobber step (success) 04:48:27 INFO - [mozharness: 2017-04-25 11:48:27.945152Z] Running read-buildbot-config step. 04:48:27 INFO - Running pre-action listener: _resource_record_pre_action 04:48:27 INFO - Running main action method: read_buildbot_config 04:48:27 INFO - Using buildbot properties: 04:48:27 INFO - { 04:48:27 INFO - "project": "", 04:48:27 INFO - "product": "firefox", 04:48:27 INFO - "script_repo_revision": "production", 04:48:27 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:48:27 INFO - "repository": "", 04:48:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:48:27 INFO - "buildid": "20170425030221", 04:48:27 INFO - "stage_platform": "macosx64", 04:48:27 INFO - "basedir": "/builds/slave/test", 04:48:27 INFO - "nightly_build": "True", 04:48:27 INFO - "buildnumber": 40, 04:48:27 INFO - "slavename": "t-yosemite-r7-0300", 04:48:27 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:48:27 INFO - "platform": "yosemite_r7", 04:48:27 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:48:27 INFO - "branch": "mozilla-central", 04:48:27 INFO - "repo_path": "mozilla-central", 04:48:27 INFO - "revision": "a30dc237c3a600a5231f2974fc2b85dfb5513414", 04:48:27 INFO - "pgo_build": "False", 04:48:27 INFO - "builduid": "b33fc7c5d4b64958a0102d88156ab255", 04:48:27 INFO - "slavebuilddir": "test" 04:48:27 INFO - } 04:48:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:48:27 INFO - Running post-action listener: _resource_record_post_action 04:48:27 INFO - [mozharness: 2017-04-25 11:48:27.950956Z] Finished read-buildbot-config step (success) 04:48:27 INFO - [mozharness: 2017-04-25 11:48:27.951188Z] Running download-and-extract step. 04:48:27 INFO - Running pre-action listener: _resource_record_pre_action 04:48:27 INFO - Running main action method: download_and_extract 04:48:27 INFO - mkdir: /builds/slave/test/build/tests 04:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:27 INFO - trying https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:48:27 INFO - Downloading https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:48:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:48:28 INFO - Downloaded 1325 bytes. 04:48:28 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:48:28 INFO - Using the following test package requirements: 04:48:28 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:28 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:48:28 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:48:28 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:28 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:48:28 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:28 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:48:28 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:28 INFO - u'jsshell-mac.zip'], 04:48:28 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:28 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:48:28 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:48:28 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:28 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:48:28 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:28 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:48:28 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:28 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:48:28 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:28 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:48:28 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:48:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:48:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:48:28 INFO - Fetch https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:48:31 INFO - Content-Length response header: 52530772 04:48:31 INFO - Bytes received: 52530772 04:48:47 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:48:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:48:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:48:47 INFO - Fetch https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:48:49 INFO - Content-Length response header: 52530772 04:48:49 INFO - Bytes received: 52530772 04:49:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:49:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:49:04 INFO - Fetch https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:49:05 INFO - Content-Length response header: 14408822 04:49:05 INFO - Bytes received: 14408822 04:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:05 INFO - trying https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:49:05 INFO - Downloading https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:49:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:49:07 INFO - Downloaded 71189263 bytes. 04:49:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:49:07 INFO - mkdir: /builds/slave/test/properties 04:49:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:49:07 INFO - Writing to file /builds/slave/test/properties/build_url 04:49:07 INFO - Contents: 04:49:07 INFO - build_url:https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:49:08 INFO - Running post-action listener: _resource_record_post_action 04:49:08 INFO - Running post-action listener: set_extra_try_arguments 04:49:08 INFO - [mozharness: 2017-04-25 11:49:08.160964Z] Finished download-and-extract step (success) 04:49:08 INFO - [mozharness: 2017-04-25 11:49:08.161083Z] Running populate-webroot step. 04:49:08 INFO - Running pre-action listener: _resource_record_pre_action 04:49:08 INFO - Running main action method: populate_webroot 04:49:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:49:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:49:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:49:08 INFO - '--tppagecycles', 04:49:08 INFO - '7'], 04:49:08 INFO - 'tests': ['tsvgm']}}, 04:49:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:49:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:49:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:49:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:49:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:49:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:49:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:49:08 INFO - 'talos_options': ['--disable-e10s'], 04:49:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:49:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:49:08 INFO - 'talos_options': ['--disable-e10s'], 04:49:08 INFO - 'tests': ['damp', 'tps']}, 04:49:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:49:08 INFO - 'tests': ['damp', 'tps']}, 04:49:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:49:08 INFO - 'tests': ['dromaeo_dom']}, 04:49:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:49:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:49:08 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:49:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:49:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:49:08 INFO - 'tests': ['a11yr', 04:49:08 INFO - 'ts_paint', 04:49:08 INFO - 'tpaint', 04:49:08 INFO - 'sessionrestore', 04:49:08 INFO - 'sessionrestore_no_auto_restore', 04:49:08 INFO - 'tabpaint']}, 04:49:08 INFO - 'other-e10s': {'tests': ['a11yr', 04:49:08 INFO - 'ts_paint', 04:49:08 INFO - 'tpaint', 04:49:08 INFO - 'sessionrestore', 04:49:08 INFO - 'sessionrestore_no_auto_restore', 04:49:08 INFO - 'tabpaint']}, 04:49:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:49:08 INFO - 'ts_paint', 04:49:08 INFO - 'tpaint', 04:49:08 INFO - 'sessionrestore', 04:49:08 INFO - 'sessionrestore_no_auto_restore', 04:49:08 INFO - 'tabpaint']}, 04:49:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:49:08 INFO - 'ts_paint', 04:49:08 INFO - 'tpaint', 04:49:08 INFO - 'sessionrestore', 04:49:08 INFO - 'sessionrestore_no_auto_restore', 04:49:08 INFO - 'tabpaint']}, 04:49:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:49:08 INFO - 'tests': ['a11yr', 04:49:08 INFO - 'ts_paint', 04:49:08 INFO - 'tpaint', 04:49:08 INFO - 'sessionrestore', 04:49:08 INFO - 'sessionrestore_no_auto_restore', 04:49:08 INFO - 'tabpaint']}, 04:49:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:49:08 INFO - 'tests': ['a11yr', 04:49:08 INFO - 'ts_paint', 04:49:08 INFO - 'tpaint', 04:49:08 INFO - 'sessionrestore', 04:49:08 INFO - 'sessionrestore_no_auto_restore', 04:49:08 INFO - 'tabpaint']}, 04:49:08 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:49:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:49:08 INFO - 'bloom_basic_ref']}, 04:49:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:49:08 INFO - 'tests': ['tsvgx', 04:49:08 INFO - 'tsvgr_opacity', 04:49:08 INFO - 'tart', 04:49:08 INFO - 'tscrollx', 04:49:08 INFO - 'cart', 04:49:08 INFO - 'tsvg_static']}, 04:49:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:49:08 INFO - 'tsvgr_opacity', 04:49:08 INFO - 'tart', 04:49:08 INFO - 'tscrollx', 04:49:08 INFO - 'cart', 04:49:08 INFO - 'tsvg_static']}, 04:49:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:49:08 INFO - 'talos_options': ['--disable-e10s'], 04:49:08 INFO - 'tests': ['tp5o']}, 04:49:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:49:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:49:08 INFO - 'talos_options': ['--disable-e10s', 04:49:08 INFO - '--xperf_path', 04:49:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:08 INFO - 'tests': ['tp5n']}, 04:49:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:49:08 INFO - 'talos_options': ['--xperf_path', 04:49:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:08 INFO - 'tests': ['tp5n']}}, 04:49:08 INFO - 'talos.zip': {'path': '', 04:49:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:49:08 INFO - Running post-action listener: _resource_record_post_action 04:49:08 INFO - [mozharness: 2017-04-25 11:49:08.180110Z] Finished populate-webroot step (success) 04:49:08 INFO - [mozharness: 2017-04-25 11:49:08.180236Z] Running create-virtualenv step. 04:49:08 INFO - Running pre-action listener: _resource_record_pre_action 04:49:08 INFO - Running main action method: create_virtualenv 04:49:08 INFO - Creating virtualenv /builds/slave/test/build/venv 04:49:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:49:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:49:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:49:08 INFO - Using real prefix '/tools/python27' 04:49:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:49:09 INFO - Installing distribute.............................................................................................................................................................................................done. 04:49:11 INFO - Installing pip.................done. 04:49:11 INFO - Return code: 0 04:49:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:49:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:49:12 INFO - Reading from file tmpfile_stdout 04:49:12 INFO - Output received: 04:49:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:49:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:12 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 0x10184ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10184d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd624c6a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101628d30>, '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 0x10154edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10161dbe8>, '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.CanPpGoivq/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.cy0yw0TnnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:49:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CanPpGoivq/Render', 04:49:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:12 INFO - 'HOME': '/Users/cltbld', 04:49:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:12 INFO - 'LOGNAME': 'cltbld', 04:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:12 INFO - 'MOZ_NO_REMOTE': '1', 04:49:12 INFO - 'NO_EM_RESTART': '1', 04:49:12 INFO - 'PAGER': '/bin/cat', 04:49:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:12 INFO - 'PWD': '/builds/slave/test', 04:49:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:12 INFO - 'SHELL': '/bin/bash', 04:49:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cy0yw0TnnV/Listeners', 04:49:12 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 04:49:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:12 INFO - 'USER': 'cltbld', 04:49:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:12 INFO - 'XPC_FLAGS': '0x0', 04:49:12 INFO - 'XPC_SERVICE_NAME': '0', 04:49:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:49:12 INFO - Cleaning up... 04:49:12 INFO - Return code: 0 04:49:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:12 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 0x10184ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10184d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd624c6a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101628d30>, '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 0x10154edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10161dbe8>, '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.CanPpGoivq/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.cy0yw0TnnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:49:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CanPpGoivq/Render', 04:49:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:12 INFO - 'HOME': '/Users/cltbld', 04:49:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:12 INFO - 'LOGNAME': 'cltbld', 04:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:12 INFO - 'MOZ_NO_REMOTE': '1', 04:49:12 INFO - 'NO_EM_RESTART': '1', 04:49:12 INFO - 'PAGER': '/bin/cat', 04:49:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:12 INFO - 'PWD': '/builds/slave/test', 04:49:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:12 INFO - 'SHELL': '/bin/bash', 04:49:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cy0yw0TnnV/Listeners', 04:49:12 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 04:49:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:12 INFO - 'USER': 'cltbld', 04:49:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:12 INFO - 'XPC_FLAGS': '0x0', 04:49:12 INFO - 'XPC_SERVICE_NAME': '0', 04:49:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:12 INFO - Downloading/unpacking psutil>=3.1.1 04:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:49:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:16 INFO - Installing collected packages: psutil 04:49:16 INFO - Running setup.py install for psutil 04:49:16 INFO - building 'psutil._psutil_osx' extension 04:49:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:49:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:49:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:49:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:49:17 INFO - building 'psutil._psutil_posix' extension 04:49:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:49:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:49:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:49:17 INFO - ^ 04:49:17 INFO - 1 warning generated. 04:49:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:49:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:17 INFO - Successfully installed psutil 04:49:17 INFO - Cleaning up... 04:49:17 INFO - Return code: 0 04:49:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:17 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 0x10184ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10184d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd624c6a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101628d30>, '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 0x10154edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10161dbe8>, '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.CanPpGoivq/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.cy0yw0TnnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:49:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CanPpGoivq/Render', 04:49:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:17 INFO - 'HOME': '/Users/cltbld', 04:49:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:17 INFO - 'LOGNAME': 'cltbld', 04:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:17 INFO - 'MOZ_NO_REMOTE': '1', 04:49:17 INFO - 'NO_EM_RESTART': '1', 04:49:17 INFO - 'PAGER': '/bin/cat', 04:49:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:17 INFO - 'PWD': '/builds/slave/test', 04:49:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:17 INFO - 'SHELL': '/bin/bash', 04:49:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cy0yw0TnnV/Listeners', 04:49:17 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 04:49:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:17 INFO - 'USER': 'cltbld', 04:49:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:17 INFO - 'XPC_FLAGS': '0x0', 04:49:17 INFO - 'XPC_SERVICE_NAME': '0', 04:49:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:49:20 INFO - Installing collected packages: mozsystemmonitor 04:49:20 INFO - Running setup.py install for mozsystemmonitor 04:49:20 INFO - Successfully installed mozsystemmonitor 04:49:20 INFO - Cleaning up... 04:49:20 INFO - Return code: 0 04:49:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:21 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 0x10184ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10184d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd624c6a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101628d30>, '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 0x10154edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10161dbe8>, '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.CanPpGoivq/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.cy0yw0TnnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:49:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CanPpGoivq/Render', 04:49:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:21 INFO - 'HOME': '/Users/cltbld', 04:49:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:21 INFO - 'LOGNAME': 'cltbld', 04:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:21 INFO - 'MOZ_NO_REMOTE': '1', 04:49:21 INFO - 'NO_EM_RESTART': '1', 04:49:21 INFO - 'PAGER': '/bin/cat', 04:49:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:21 INFO - 'PWD': '/builds/slave/test', 04:49:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:21 INFO - 'SHELL': '/bin/bash', 04:49:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cy0yw0TnnV/Listeners', 04:49:21 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 04:49:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:21 INFO - 'USER': 'cltbld', 04:49:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:21 INFO - 'XPC_FLAGS': '0x0', 04:49:21 INFO - 'XPC_SERVICE_NAME': '0', 04:49:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:21 INFO - Downloading/unpacking jsonschema==2.5.1 04:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:49:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:24 INFO - Downloading functools32-3.2.3-2.tar.gz 04:49:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:49:25 INFO - warning: no files found matching '*.txt' 04:49:25 INFO - no previously-included directories found matching 'build' 04:49:25 INFO - no previously-included directories found matching 'dist' 04:49:25 INFO - no previously-included directories found matching '.git*' 04:49:25 INFO - Installing collected packages: jsonschema, functools32 04:49:25 INFO - Running setup.py install for functools32 04:49:25 INFO - warning: no files found matching '*.txt' 04:49:25 INFO - no previously-included directories found matching 'build' 04:49:25 INFO - no previously-included directories found matching 'dist' 04:49:25 INFO - no previously-included directories found matching '.git*' 04:49:25 INFO - Successfully installed jsonschema functools32 04:49:25 INFO - Cleaning up... 04:49:25 INFO - Return code: 0 04:49:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:25 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 0x10184ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10184d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd624c6a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101628d30>, '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 0x10154edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10161dbe8>, '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.CanPpGoivq/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.cy0yw0TnnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:49:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CanPpGoivq/Render', 04:49:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:25 INFO - 'HOME': '/Users/cltbld', 04:49:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:25 INFO - 'LOGNAME': 'cltbld', 04:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:25 INFO - 'MOZ_NO_REMOTE': '1', 04:49:25 INFO - 'NO_EM_RESTART': '1', 04:49:25 INFO - 'PAGER': '/bin/cat', 04:49:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:25 INFO - 'PWD': '/builds/slave/test', 04:49:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:25 INFO - 'SHELL': '/bin/bash', 04:49:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cy0yw0TnnV/Listeners', 04:49:25 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 04:49:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:25 INFO - 'USER': 'cltbld', 04:49:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:25 INFO - 'XPC_FLAGS': '0x0', 04:49:25 INFO - 'XPC_SERVICE_NAME': '0', 04:49:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:49:25 INFO - Cleaning up... 04:49:25 INFO - Return code: 0 04:49:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:25 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 0x10184ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10184d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd624c6a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101628d30>, '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 0x10154edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10161dbe8>, '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.CanPpGoivq/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.cy0yw0TnnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:49:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CanPpGoivq/Render', 04:49:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:25 INFO - 'HOME': '/Users/cltbld', 04:49:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:25 INFO - 'LOGNAME': 'cltbld', 04:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:25 INFO - 'MOZ_NO_REMOTE': '1', 04:49:25 INFO - 'NO_EM_RESTART': '1', 04:49:25 INFO - 'PAGER': '/bin/cat', 04:49:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:25 INFO - 'PWD': '/builds/slave/test', 04:49:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:25 INFO - 'SHELL': '/bin/bash', 04:49:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cy0yw0TnnV/Listeners', 04:49:25 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 04:49:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:25 INFO - 'USER': 'cltbld', 04:49:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:25 INFO - 'XPC_FLAGS': '0x0', 04:49:25 INFO - 'XPC_SERVICE_NAME': '0', 04:49:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:25 INFO - Downloading/unpacking blobuploader==1.2.4 04:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:28 INFO - Downloading blobuploader-1.2.4.tar.gz 04:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:49:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:49:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:29 INFO - Downloading docopt-0.6.1.tar.gz 04:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:49:29 INFO - Installing collected packages: blobuploader, requests, docopt 04:49:29 INFO - Running setup.py install for blobuploader 04:49:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:49:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:49:30 INFO - Running setup.py install for requests 04:49:30 INFO - Running setup.py install for docopt 04:49:30 INFO - Successfully installed blobuploader requests docopt 04:49:30 INFO - Cleaning up... 04:49:30 INFO - Return code: 0 04:49:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:30 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 0x10184ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10184d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd624c6a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101628d30>, '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 0x10154edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10161dbe8>, '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.CanPpGoivq/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.cy0yw0TnnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:49:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CanPpGoivq/Render', 04:49:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:30 INFO - 'HOME': '/Users/cltbld', 04:49:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:30 INFO - 'LOGNAME': 'cltbld', 04:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:30 INFO - 'MOZ_NO_REMOTE': '1', 04:49:30 INFO - 'NO_EM_RESTART': '1', 04:49:30 INFO - 'PAGER': '/bin/cat', 04:49:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:30 INFO - 'PWD': '/builds/slave/test', 04:49:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:30 INFO - 'SHELL': '/bin/bash', 04:49:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cy0yw0TnnV/Listeners', 04:49:30 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 04:49:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:30 INFO - 'USER': 'cltbld', 04:49:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:30 INFO - 'XPC_FLAGS': '0x0', 04:49:30 INFO - 'XPC_SERVICE_NAME': '0', 04:49:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:31 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-wJsHmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:31 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-bSs_a5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:31 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-er9Bbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:31 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-ehEfJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:31 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-HbmLzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:31 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Q_TuA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:31 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-HhDmxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:31 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-XZ2x2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:31 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-kZNssS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:32 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-3FYweb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:32 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-5QybbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:32 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-zWADqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:32 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-c6l3PR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:32 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-tcRyhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:32 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-PwwbXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:32 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-kmVVeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:32 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-TDPecl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:49:32 INFO - Running setup.py install for manifestparser 04:49:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:49:33 INFO - Running setup.py install for mozcrash 04:49:33 INFO - Running setup.py install for mozdebug 04:49:33 INFO - Running setup.py install for mozdevice 04:49:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:49:33 INFO - Running setup.py install for mozfile 04:49:33 INFO - Running setup.py install for mozhttpd 04:49:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:49:33 INFO - Running setup.py install for mozinfo 04:49:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:49:33 INFO - Running setup.py install for mozInstall 04:49:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:49:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:49:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:49:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:49:34 INFO - Running setup.py install for mozleak 04:49:34 INFO - Running setup.py install for mozlog 04:49:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:49:34 INFO - Running setup.py install for moznetwork 04:49:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:49:34 INFO - Running setup.py install for mozprocess 04:49:34 INFO - Running setup.py install for mozprofile 04:49:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:49:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:49:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:49:34 INFO - Running setup.py install for mozrunner 04:49:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:49:35 INFO - Running setup.py install for mozscreenshot 04:49:35 INFO - Running setup.py install for moztest 04:49:35 INFO - Running setup.py install for mozversion 04:49:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:49:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:49:35 INFO - Cleaning up... 04:49:35 INFO - Return code: 0 04:49:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:35 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 0x10184ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10184d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd624c6a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101628d30>, '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 0x10154edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10161dbe8>, '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.CanPpGoivq/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.cy0yw0TnnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:49:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CanPpGoivq/Render', 04:49:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:35 INFO - 'HOME': '/Users/cltbld', 04:49:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:35 INFO - 'LOGNAME': 'cltbld', 04:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:35 INFO - 'MOZ_NO_REMOTE': '1', 04:49:35 INFO - 'NO_EM_RESTART': '1', 04:49:35 INFO - 'PAGER': '/bin/cat', 04:49:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:35 INFO - 'PWD': '/builds/slave/test', 04:49:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:35 INFO - 'SHELL': '/bin/bash', 04:49:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cy0yw0TnnV/Listeners', 04:49:35 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 04:49:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:35 INFO - 'USER': 'cltbld', 04:49:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:35 INFO - 'XPC_FLAGS': '0x0', 04:49:35 INFO - 'XPC_SERVICE_NAME': '0', 04:49:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:35 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-5uwAzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:35 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-TiSJzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:35 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Ugr76j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:36 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Lv9hqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:36 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-U25_pI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:36 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-voTLSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:36 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-lTjfhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:36 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-VSBEsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:36 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-44IKO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:36 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-k9hkve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:36 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-N0moCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:36 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-WiG9iH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:37 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-N4YcqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:37 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-0e0Mwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:37 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Am3u26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:37 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-rSV1SL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:37 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-IKSFJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:49:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:49:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:49:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:49:37 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:49:37 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:49:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:40 INFO - Downloading blessings-1.6.tar.gz 04:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:49:40 INFO - Installing collected packages: blessings 04:49:40 INFO - Running setup.py install for blessings 04:49:40 INFO - Successfully installed blessings 04:49:40 INFO - Cleaning up... 04:49:40 INFO - Return code: 0 04:49:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:49:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:40 INFO - Reading from file tmpfile_stdout 04:49:40 INFO - Current package versions: 04:49:40 INFO - blessings == 1.6 04:49:40 INFO - blobuploader == 1.2.4 04:49:40 INFO - docopt == 0.6.1 04:49:40 INFO - functools32 == 3.2.3-2 04:49:40 INFO - jsonschema == 2.5.1 04:49:40 INFO - manifestparser == 1.1 04:49:40 INFO - mozInstall == 1.12 04:49:40 INFO - mozcrash == 1.0 04:49:40 INFO - mozdebug == 0.1 04:49:40 INFO - mozdevice == 0.50 04:49:40 INFO - mozfile == 1.2 04:49:40 INFO - mozhttpd == 0.7 04:49:40 INFO - mozinfo == 0.9 04:49:40 INFO - mozleak == 0.1 04:49:40 INFO - mozlog == 3.4 04:49:40 INFO - moznetwork == 0.27 04:49:40 INFO - mozprocess == 0.25 04:49:40 INFO - mozprofile == 0.28 04:49:40 INFO - mozrunner == 6.13 04:49:40 INFO - mozscreenshot == 0.1 04:49:40 INFO - mozsystemmonitor == 0.3 04:49:40 INFO - moztest == 0.8 04:49:40 INFO - mozversion == 1.4 04:49:40 INFO - psutil == 3.1.1 04:49:40 INFO - requests == 1.2.3 04:49:40 INFO - wsgiref == 0.1.2 04:49:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:40 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 0x10184ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10184d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd624c6a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101628d30>, '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 0x10154edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10161dbe8>, '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.CanPpGoivq/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.cy0yw0TnnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:49:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CanPpGoivq/Render', 04:49:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:40 INFO - 'HOME': '/Users/cltbld', 04:49:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:40 INFO - 'LOGNAME': 'cltbld', 04:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:40 INFO - 'MOZ_NO_REMOTE': '1', 04:49:40 INFO - 'NO_EM_RESTART': '1', 04:49:40 INFO - 'PAGER': '/bin/cat', 04:49:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:40 INFO - 'PWD': '/builds/slave/test', 04:49:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:40 INFO - 'SHELL': '/bin/bash', 04:49:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cy0yw0TnnV/Listeners', 04:49:40 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 04:49:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:40 INFO - 'USER': 'cltbld', 04:49:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:40 INFO - 'XPC_FLAGS': '0x0', 04:49:40 INFO - 'XPC_SERVICE_NAME': '0', 04:49:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:49:41 INFO - Cleaning up... 04:49:41 INFO - Return code: 0 04:49:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:41 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 0x10184ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10184d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbd624c6a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101628d30>, '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 0x10154edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10161dbe8>, '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.CanPpGoivq/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.cy0yw0TnnV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:49:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:49:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CanPpGoivq/Render', 04:49:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:41 INFO - 'HOME': '/Users/cltbld', 04:49:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:41 INFO - 'LOGNAME': 'cltbld', 04:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:41 INFO - 'MOZ_NO_REMOTE': '1', 04:49:41 INFO - 'NO_EM_RESTART': '1', 04:49:41 INFO - 'PAGER': '/bin/cat', 04:49:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:41 INFO - 'PWD': '/builds/slave/test', 04:49:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:41 INFO - 'SHELL': '/bin/bash', 04:49:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cy0yw0TnnV/Listeners', 04:49:41 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 04:49:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:41 INFO - 'USER': 'cltbld', 04:49:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:41 INFO - 'XPC_FLAGS': '0x0', 04:49:41 INFO - 'XPC_SERVICE_NAME': '0', 04:49:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:49:41 INFO - Cleaning up... 04:49:41 INFO - Return code: 0 04:49:41 INFO - Running post-action listener: _resource_record_post_action 04:49:41 INFO - Running post-action listener: _start_resource_monitoring 04:49:41 INFO - Starting resource monitoring. 04:49:41 INFO - [mozharness: 2017-04-25 11:49:41.353008Z] Finished create-virtualenv step (success) 04:49:41 INFO - [mozharness: 2017-04-25 11:49:41.353952Z] Running install step. 04:49:41 INFO - Running pre-action listener: _resource_record_pre_action 04:49:41 INFO - Running main action method: install 04:49:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:41 INFO - Reading from file tmpfile_stdout 04:49:41 INFO - Detecting whether we're running mozinstall >=1.0... 04:49:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:49:41 INFO - Reading from file tmpfile_stdout 04:49:41 INFO - Output received: 04:49:41 INFO - Usage: mozinstall [options] installer 04:49:41 INFO - Options: 04:49:41 INFO - -h, --help show this help message and exit 04:49:41 INFO - -d DEST, --destination=DEST 04:49:41 INFO - Directory to install application into. [default: 04:49:41 INFO - "/builds/slave/test"] 04:49:41 INFO - --app=APP Application being installed. [default: firefox] 04:49:41 INFO - mkdir: /builds/slave/test/build/application 04:49:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:50:01 INFO - Reading from file tmpfile_stdout 04:50:01 INFO - Output received: 04:50:01 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:50:01 INFO - Running post-action listener: _resource_record_post_action 04:50:01 INFO - [mozharness: 2017-04-25 11:50:01.489180Z] Finished install step (success) 04:50:01 INFO - [mozharness: 2017-04-25 11:50:01.489283Z] Running run-tests step. 04:50:01 INFO - Running pre-action listener: _resource_record_pre_action 04:50:01 INFO - Running main action method: run_tests 04:50:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:50:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:50:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:50:01 INFO - 2017-04-25 04:50:01.501 screenresolution[1621:7336] starting screenresolution argv=screenresolution get 04:50:01 INFO - 2017-04-25 04:50:01.504 screenresolution[1621:7336] Display 0: 1600x1200x32@60 04:50:01 INFO - 2017-04-25 04:50:01.509 screenresolution[1622:7339] starting screenresolution argv=screenresolution list 04:50:01 INFO - Available Modes on Display 0 04:50:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:50:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:50:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:50:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:50:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:50:01 INFO - Intel Iris: 04:50:01 INFO - Chipset Model: Intel Iris 04:50:01 INFO - Type: GPU 04:50:01 INFO - Bus: Built-In 04:50:01 INFO - VRAM (Dynamic, Max): 1536 MB 04:50:01 INFO - Vendor: Intel (0x8086) 04:50:01 INFO - Device ID: 0x0a2e 04:50:01 INFO - Revision ID: 0x0009 04:50:01 INFO - Displays: 04:50:01 INFO - Display: 04:50:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:50:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:50:01 INFO - Display Serial Number: 1600x1200 60 04:50:01 INFO - Main Display: Yes 04:50:01 INFO - Mirror: Off 04:50:01 INFO - Online: Yes 04:50:01 INFO - Rotation: Supported 04:50:01 INFO - Return code: 0 04:50:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:50:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:50:01 INFO - Python 2.7.3 04:50:01 INFO - Return code: 0 04:50:01 INFO - grabbing minidump binary from tooltool 04:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:01 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 0x101628d30>, '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 0x10154edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10161dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:50:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:50:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:50:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:50:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:50:01 INFO - Return code: 0 04:50:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:50:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:50:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:50:01 INFO - ENV: RUST_BACKTRACE is now 1 04:50:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:50:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:50:01 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/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0300', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:50:01 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/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0300 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:50:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CanPpGoivq/Render', 04:50:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:01 INFO - 'HOME': '/Users/cltbld', 04:50:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:01 INFO - 'LOGNAME': 'cltbld', 04:50:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:50:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:01 INFO - 'MOZ_NO_REMOTE': '1', 04:50:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:50:01 INFO - 'NO_EM_RESTART': '1', 04:50:01 INFO - 'PAGER': '/bin/cat', 04:50:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:01 INFO - 'PWD': '/builds/slave/test', 04:50:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:50:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:01 INFO - 'RUST_BACKTRACE': '1', 04:50:01 INFO - 'SHELL': '/bin/bash', 04:50:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cy0yw0TnnV/Listeners', 04:50:01 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 04:50:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:01 INFO - 'USER': 'cltbld', 04:50:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:01 INFO - 'XPC_FLAGS': '0x0', 04:50:01 INFO - 'XPC_SERVICE_NAME': '0', 04:50:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:01 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/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0300', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:50:02 INFO - mozversion application_buildid: 20170425030221 04:50:02 INFO - mozversion application_changeset: a30dc237c3a600a5231f2974fc2b85dfb5513414 04:50:02 INFO - mozversion application_display_name: Nightly 04:50:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:50:02 INFO - mozversion application_name: Firefox 04:50:02 INFO - mozversion application_remotingname: firefox 04:50:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:50:02 INFO - mozversion application_vendor: Mozilla 04:50:02 INFO - mozversion application_version: 55.0a1 04:50:02 INFO - mozversion platform_buildid: 20170425030221 04:50:02 INFO - mozversion platform_changeset: a30dc237c3a600a5231f2974fc2b85dfb5513414 04:50:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:50:02 INFO - mozversion platform_version: 55.0a1 04:50:02 INFO - using testdate: 1493121002 04:50:02 INFO - actual date: 1493121002 04:50:02 INFO - starting webserver on 'localhost:49235' 04:50:02 INFO - SUITE-START | Running 2 tests 04:50:02 INFO - TEST-START | dromaeo_css 04:50:02 INFO - operating with platform_type : mac_ 04:50:02 INFO - Initialising browser for dromaeo_css test... 04:50:02 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmphcMxmz/profile http://localhost:49235/getInfo.html) 04:50:04 INFO - PID 1632 | __metrics Screen width/height:1600/1200 04:50:04 INFO - PID 1632 | colorDepth:24 04:50:04 INFO - PID 1632 | Browser inner width/height: 1024/689 04:50:04 INFO - PID 1632 | __metrics 04:50:05 INFO - PID 1632 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:50:05 INFO - PID 1632 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:05 INFO - TEST-INFO | 1632: exit 0 04:50:05 INFO - Browser initialized. 04:50:05 INFO - Running cycle 1/1 for dromaeo_css test... 04:50:05 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmphcMxmz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:18 INFO - PID 1635 | RSS: Main: 242065408 04:50:18 INFO - PID 1635 | 04:53:22 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 04:53:24 INFO - PID 1635 | RSS: Main: 455462912 04:53:24 INFO - PID 1635 | 04:55:08 INFO - PID 1635 | ************************* 04:55:08 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 04:55:08 INFO - PID 1635 | 04:55:08 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:55:08 INFO - PID 1635 | Full stack: 04:55:08 INFO - PID 1635 | ************************* 04:55:08 INFO - PID 1635 | ************************* 04:55:08 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 04:55:08 INFO - PID 1635 | 04:55:08 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:55:08 INFO - PID 1635 | Full stack: 04:55:08 INFO - PID 1635 | ************************* 04:55:08 INFO - PID 1635 | ************************* 04:55:08 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 04:55:08 INFO - PID 1635 | 04:55:08 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:55:08 INFO - PID 1635 | Full stack: 04:55:08 INFO - PID 1635 | ************************* 04:55:08 INFO - PID 1635 | ************************* 04:55:08 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 04:55:08 INFO - PID 1635 | 04:55:08 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:55:08 INFO - PID 1635 | Full stack: 04:55:08 INFO - PID 1635 | ************************* 04:56:27 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 04:56:27 INFO - PID 1635 | RSS: Main: 369942528 04:56:27 INFO - PID 1635 | 04:59:29 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 04:59:30 INFO - PID 1635 | RSS: Main: 327368704 04:59:30 INFO - PID 1635 | 05:02:32 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 05:02:33 INFO - PID 1635 | RSS: Main: 345497600 05:02:33 INFO - PID 1635 | 05:05:36 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 05:05:37 INFO - PID 1635 | RSS: Main: 333746176 05:05:37 INFO - PID 1635 | 05:08:39 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 05:08:39 INFO - PID 1635 | RSS: Main: 378077184 05:08:39 INFO - PID 1635 | 05:08:39 INFO - PID 1635 | __start_tp_report 05:08:39 INFO - PID 1635 | _x_x_mozilla_page_load 05:08:39 INFO - PID 1635 | _x_x_mozilla_page_load_details 05:08:39 INFO - PID 1635 | |i|pagename|runs| 05:08:39 INFO - PID 1635 | |0;dojo.html;2838.1911155320736;2895.6235689360387;3418.5555877735906;3471.8784842530517;3497.947530787037;5036.269740887578;5619.915701264485;5915.319738230105;5994.490468310199;5998.4301491358365;5556.583256255777;5798.275215598051;5798.797042103527;5814.796482123126;5845.941540584593;5078.771455284521;5112.156494178456;5121.411037730652;5148.433672296063;5169.948300517003;5188.221766734982;5196.558292545138;5205.531502164805;5211.843644690665;5213.087709650796;4287.528371879091;5194.896102077956;5197.688138711689;5199.350081239845;5238.816641417532;4316.309390497537;5213.400458947212;5230.189320655304;5300.867478313035;5320.334958130234;5156.767945442464;5195.298634684307;5206.401263854667;5211.687298762086;5272.340957380327;5613.326400831886;5749.223854779593;5996.610220335664;6001.609895356832;6069.787557435468;6276.403741644536;6303.117563541108;6336.841578960517;6351.269603995507;6353.904691429632;6402.48780097591;6403;6404.743810247584;6424.775132870373;6431.871362572769;6108.992016317302;6113.541484388688;6131.908021379683;6132.50939924805;6142.232220972379;6279.529035322369;6319.684015799192;6342.365763423713;6426.4216220540375;6446.065320528591;6384.680765961683;6389.393007664265;6391.1371964785085;6393.328700486475;6411.5832470889245;6329.9872020476505;6330.746770129143;6383.840403989844;6387.169667943138;6403.615783053032;6202.689865506707;6265.342139075331;6295.779647712308;6382.361763823674;6395.360463953661;6158.846028849225;6247.156633854463;6326.5255105867245;6345.079963405373;6375.681215939185;5013.849584512471;5035.144025515671;5043.445221025684;5076.670016448919;5089.898202035939;4617.976910115428;4623.491415944243;4658.487566367697;4674.555917187861;4722.905541889143;6019.578629495893;6025.3372129065765;6031;6046.848828779316;6076.21009268801;6251.374862513712;6367.329888755773;6412.4549413299455;6415.358464153547;6426.2931077581425;5062.784931616386;5654.8303550892715;5769.88460230793;5816.447437493432;5825.50483208932;5485.561155107582;5496.120620700749;5505.504504594605;5513.007658621486;5519.530839878656;6332.145160403286;6353.5234857385885;6381.489480841615;6384.265809431789;6389.904151437732;6301.96849015752;6308.211473565804;6326.4622507087415;6350.618962862243;6367.90448143269;6528.086067950586;6536.640484773383;6537.117489139096;6556.016597510412;6560.343965603402;6333.683315834282;6342.682865856781;6356.2054743157105;6356.745730170742;6371.331010243857;5008.524190201925;6321.96839015802;6328.303886572381;6333.36666333363;6337.493000560036;6064.818055458167;6142.928535732134;6170;6173.783917562864;6184.134221209124;5854.590178687451;6141.117811340085;6171.753129874754;6288.339724328879;6336.8098957029515;6233.846738353419;6267.561270711007;6273.843153921189;6276.089966954674;6279.71741271653;6321.683915804283;6324.3991820776955;6331.873362532631;6336.493080553637;6350.745970161327;5905;5971.28344598651;5981.222441082631;6200.3799620037635;6210.3168651449205 05:08:39 INFO - PID 1635 | |1;ext.html;791.0902462168506;806.57251656622;1103.3931337764232;1127.6617014895535;1131.700099473639;36601.26797464049;36976.89069327918;37030.62969370306;37111.76320617481;37196;38839.22321553567;39274;39323.60676393235;39349.21301573967;39387;6065.939340606604;6126.632402055869;8303.95848020759;8418.410711250215;8440.451370660887;6922.307769223088;8101.473404228706;8235.670573177065;8253.463524870864;8260.793480162984;8258.876116858251;8314.501129932192;8319.209675080889;8323.04285007226;8329.167083291653;8237.546934918577;8284.46151000183;8291.378146639026;8291.83416331676;8304.83390332196;8219;8260.710875119343;8264.917350826536;8274.544900030496;8287.95856020722;36761.81619091914;37063.888083357546;37146.81426592877;37182.628173718185;37360.87917362483;3022.335086281015;3536.8585256589704;3536.9646303536892;3537.221811201557;3541.4333706607076;30349.544756828665;30356.69643303561;30391.24021899448;30459.847700761577;30572.69427305721;2956.615639966812;3012.9397412051635;3016.7284944355115;3027.2129246395875;3029.166979080748;287302;294529.52735236404;294540;294927;295705.5214723934;38803.223935521135;39372.2125557493;39580;48086.27870581944;48225.7943551414;40513.569185848944;41241;41272;50436;50816.98366032659;12063.819042714365;13416.932915335556;13802.93098534521;13882.652933676738;13883.097598656055;11225.576199259305;11232.66302010941;11238.38188899602;11255;11263.493142808593;12156.513739450324;12468.820450785173;12509.74980500403;12544.74910501803;12615.621531354074;5567.610267281332;5578.497935185853;5613.354464236583;5618.52242559387;5633.014222511044;970.6651205334149;989.7525618595351;1009.369144284822;1043.1758910460803;1046.884842667306;23582.56697321051;30096.849515752718;30196.698033019828;30705.846470767505;30716.38567228643;1065.717584840018;1071.737424331044;1100.1308965916835;1101.5043230546287;1108.5177947592822;11760.117991150699;12009;12347.75304493923;12348.691282717824;12355.505779768888;309226;310113.898861013;310463;311451;312399.43800280854;51800.48199518032;51973.740131299855;52045.47954520482;52054.73972630112;52132.21801672978;1419.3471003338373;1440.1978776031285;1485.8811295096366;1490.478332583587;1518.4078209498305;23583.29250122499;23717;23717.644235336138;23770.881145594853;23771.930263138547;38199.42700859545;38244.426333605574;38311.04222394463;38355.61644383632;38369;283361.5831920827;283463;284246;284758;285297;29286.41427171402;29744.256393590334;33044.83477582597;33661.663383365856;33958.32083358269;42411;42945.785271073444;42978.57021429871;43043;43100.78449607732;28001.299967500974;29061.564076538445;29824.403511929206;29938.70061299359;30246;28873.56689649699;29558.852205738833;29681.54076088391;30144.54783178298;30155.849220753757;35425.82287088651;35635.643643563235;36097.27805443929;36186.45720314145;36423.63576364202;29013.41973160567;29167.416651666423;29690.554641680825;29717.405651887275;29830.55254171146;19333.90333048326;19497.512562186057;22016.33950981473;22615.88692056529;23338.53322933566 05:08:39 INFO - PID 1635 | |2;jquery.html;433.80695590462255;436.2605383874333;437.33961717806125;446.2079808340197;456.8035744629808;17368;18766.718499222523;20426.2850800222;20988.89505552474;21132.683009754866;20640.587188256224;20941.895290523564;21345;21439.464013399673;21527;5457.181422786584;6131.325554189036;6145.324014358417;6146.907796383058;6149.938500614981;5880.147378630118;5971.34315225327;5972.940270597303;5978.611390259641;6052.182955301044;5140.995011945344;6034.336223015487;6055.333913269536;6059.303180134297;6062;5905.320888097859;5925.525957923356;6017.2779266488305;6053.364396738367;6064.878702425926;5257.211418287249;5333.546648534879;5350.197470379435;5368.91946620801;5382.1926710993275;25906.336859365307;26196.60705089425;26209.475810483684;26497.602535961974;26591.73408265912;1745.7905051393786;2103.63186442372;2142.8928553572414;2144.4960434297927;2151.0965394534333;17772.91113544437;17916.193771280323;18004.819951800444;18217.726734098866;18221.7266740999;2124.458263142889;2133.562619662981;2134.8185404240658;2154.881481518516;2163.1888041984257;169148;170714;171375.14312428483;172077;172239;9862.50687465624;11936.641900742992;12071.05086914361;12127;12393.318367489876;15826.44607438734;16239.51281461558;16246.675066498603;16280.674386512203;16282.127555331052;7159.355657990805;8568.186022327869;8749.300055995505;8816.691415800544;8918.974317953389;7100.218975912646;8264.21489958453;8301.46040507365;8462.83074338522;8486.490810551386;6167.753289868445;7291.197968223491;7546.622668866535;7552.320291173821;7574.697012119454;1943.6200297788446;2097.5070858348276;2106.8314534837177;2116.7565729940948;2119.6714509250783;866.994286627509;900.7342833864026;907.1744712311764;920.742192186189;946.5030858799186;20013.59972800536;20591.794082058987;20591.79408205929;20651.760894346386;20851.374458766262;871.6382701179067;919.5126582911067;928.767808047988;948.8339540580508;988.2736188901152;10279.434631095362;10542.789144217226;10543.31468454548;10628.89371106279;10759.085477734323;559182;561635.4119276336;561851;580096;582585;133219.33390332985;133669;135030;136566.31716841352;138192.9271060935;1113.194749231931;1140.1391949078559;1158.478684591937;1158.8551431071116;1159.5999380213814;13909.37407816671;16860.57848553796;17391.391301304393;17751.201195946473;17892.015939123474;41277.587224127376;51382.97234055373;52051.21923171231;53153;54307.45692543182;61395.860413958246;67842.98235526372;74631.8805217933;75905;76128.23871761211;7261.673224704795;8326.875096873673;8359.456635318928;8558.657653693783;8817.426867253607;10874.510647020745;13643.590692279247;13742.175469471864;14048.035152543984;14134.78797818054;11900.523979040741;12022.879771202175;12312.876871231172;12313.44589493457;12343.321117338633;11519.136064795006;11536.653900383002;11633.941830290794;11814.113941454598;11879.168458207843;11991.400429978292;12088.093392995737;12397.93801030989;12401.751964960831;12552.748945020865;8625.094365091825;8659.6103175356;8735;8975.596098175729;9166.22087122602;9848.753781155528;11778.057755379721;11958.342291174069;12112.15214934946;12154.806591725841 05:08:39 INFO - PID 1635 | |3;mootools.html;1140.5152810055736;1323.9536616218431;1360.870477503672;1377.249399077502;1391.3738817532112;9808.705738827837;11451.282307653846;11621.535138594467;11777.70555736107;11799.174057815957;11521.36632485213;11619.244749091304;11623.47694353754;11623.6512904613;11626.709332266697;2486.4156923123005;2527.153403609793;2531.2659328794625;2532.240327901631;2535.0746977353224;2134.5304033112766;2208.967749670307;2484.35406794233;2581.4062765563835;2598.414577495395;2494.5759220932487;2499.3251822008046;2528.734482879299;2529.544681957247;2531.4683916377585;2508.8871000804916;2516.848989060644;2521.1176088369198;2521.168014555211;2522.382016405974;2463.1132792194794;2485.5401750676183;2486.3038349262238;2489.5269898719184;2491.7134529528976;11725.179237453382;11809.350485723282;11937;11944.820827687592;11955.402229888557;6453.935460645427;6717;6720.865582688368;6722.327767223239;6732.93267067328;4014.9397759033636;4116.403121547389;4328.437303150602;4404.779761011937;4407.316865885793;1127.4419162514525;1233.8210959410835;1246.1712960881002;1286.1768468180371;1304.0545604436802;16652.75020874688;16683.91658041702;16692;16711.91644041784;16779.244933978;5767.509761670305;5930.584859059911;5965.075413310944;6063.878722425527;6082.726277317532;13913;13933;13949.093308934887;13954.790678139836;13982.860171398359;6832.521723479309;6834.829129271808;6843.3575941773615;6844.623545704934;6866.141732283465;5235.816746413857;6127.142200091991;6195.287541932736;6279.654618995908;6289.7484100635465;4159.961618806823;4241.936370954438;4244.129953359616;4252.4046633471335;4263.253930562139;1118.2842980492492;1231.335079057299;1320.392619395089;1469.1258701072845;1500.6173425776358;719.7768691705588;765.1430397954216;770.816796217803;786.0488808541728;790.9446338756347;5918.437748413894;5960.403959604092;6203;6278.434940855345;6309.558330916791;901.8376692195468;909.0999910088964;915.9267258619294;918.6784625381063;922.6770630279349;4086.4891888513935;4287.421198138274;4313.8490152845125;4445.977770111193;4509.887252818706;13206.811386975027;13930;15239.923800380928;15266.694666106838;15283.847161528241;14672.633184170267;14944.850551494563;15096.39614415433;15137.243137843065;15159.24203789806;8576.185262400062;8613.22480976715;8633.093525179891;8634.568271586395;8638.697645582375;6432.748538011659;6513.576617519846;6683.699233534599;6704.6982885769285;6761;11362.659120226406;13653.590392288248;13683.179009259477;13703.657408564866;13714.93142534281;13446.260455675032;13752.65618359549;13802.930985345009;13832.515861944783;13854.376553054935;9537.666181683608;9604.66383676568;9639.469829159463;9708.077732615391;9725.173360264456;10477.842832357674;10582.682519524427;10759.30064545802;10777.676669699922;10791.730206744895;6950.51346405767;8997.685081022133;9079.409838360485;9121.042290559395;9243.722688319362;8963.596638151168;8966.910330896868;9037.548122593975;9064.592093355946;9094.636214551343;8138.9186108138165;8157.632906519102;8206.548639824867;8225.341972642294;8230.588470576567;5896.823095307148;5950.3454619992635;5987.5808693391045;6033.487153591994;6149.7847575334645;4841.370621819141;5050.065737838511;5402.541843461137;6046.667433291212;6060 05:08:39 INFO - PID 1635 | |4;prototype.html;343.42133505044;372.63667923774324;391.9059425737824;404.2965240481563;405.81332587009973;5401.135818269077;5559.8888022239635;5731.856703582407;5808.738606762695;5847.64914105154;4448.3523510721225;5721.684012677077;5748.281464816898;5753.482186603205;5754.453326933945;4321.697481176319;4385.407969924067;4426.800793964279;4457.576530229631;4463.70985885918;4424.40270563473;4425.8229670813125;4433.467983841927;4440.86677399677;4444.599986001259;3595.3168897909445;4375.190589740892;4390.692651514395;4409.669274804386;4410.955890441102;4208.789560521992;4372.868813935587;4395.736255824629;4408.40486534317;4425.291953287475;3037.787354885159;3801.733878628497;3928.332183528807;3931.410288456726;3936.976386139596;5562.6611243230345;5569.66582005081;5571.331440227199;5577.637453565505;5600.691961942091;5170.663906846043;5207.297014903015;5283.418823929364;5298.735063246822;5315.973420132875;6177.25872895251;6178.474829639486;6182.536309776785;6182.783602573888;6183.846238418394;4452.1986042512335;4463.709858859163;4471.955280447187;4490.550944905516;4490.57339552742;5924.644521328691;6010.909836352502;6195.504359651217;6429.292777794439;6512.93487065128;4538.773061346919;4539.818407263672;4564.1556312082375;4573.49691533931;4574.908501830011;4381.452318460192;4574.771261436915;4612.377329060534;4638.930416043762;4658.301254811805;4380.255356589388;4740.857774266778;4797.832075877328;5001.574551252876;5307.363116426053;5325.3609566851455;5483.341998960151;5653.265075540236;6117.021276595723;6140.969295153495;1454.4691187716408;1468.728285267229;1472.263868065967;1472.580314610331;1480.8074950256614;942.7595963029383;981.764376549623;982.2044144243043;983.311681822727;997.2769741937183;5035.571976381975;5725.971370143206;5789.8552536186935;5796.478316951495;5832.766689332464;6286.968565157145;6294.213223347082;6305.243370795534;6313.652749098844;6338.651374174372;4651.279051746985;5463.672179669233;5721.284839395075;5780.88438231233;5783.045797443375;2751.9449611007667;2917.8912013435183;3194.568733221032;3224.5976747323393;3315.950260746091;5215.6609820361555;6306.540449224806;6438.130852334969;6454.997377032837;6456.741730330828;5472.398036216013;5759.2512973313205;5911.556633252523;6411.711472983634;6431.614103153825;5360.222767698662;6115.3578874217565;6411.531560349205;6427.865069772549;6431.710573024132;5430.429804870431;5591.496765290981;6291.370862913672;6341.685284870897;6381.840453988688;5177.689338639693;6226.875462490815;6272.240214305691;6310.873782524232;6314.778982735582;5105.948940510547;5489.505944465017;6551.246606640107;6598.637074960923;6646.268910419946;3528.8764893228613;4209.052963083282;4237.4067630531135;4243;4249.194092510609;5530.917036244379;6404.783091212655;6410.487161027013;6422.133012043314;6435.131257280207;5376.677399356051;5940.851478712894;6141.201643786279;6187.319394866651;6207.286162091236;6077;6098.603590766586;6136.447719705248;6199.659018754011;6216.533759968111;5513.338399392099;6034.63792172471;6066.787662431793;6084.330723620486;6107.755689772359;6152.538559607958;6163.722632481638;6169.907451388322;6179.536534760001;6195.721192546436;5084.720340381315;5653.915191272216;5743.798967036134;5944.732487038007;6015.368386319374 05:08:39 INFO - PID 1635 | |5;yui.html;714.3963350968436;855.2601999270632;855.824555966027;855.8887344645198;872.4198408058639;12955.805662915052;17903.46289611312;18614.62770744584;18632.441026769186;18669.346572869952;16070.035797852137;16082.758758618631;16117.919410402961;16154.515364539053;16172.11053392063;958.650092716157;970.0445061614304;991.0584944302905;1013.7262939006464;1020.9994205678439;1021.8211812932744;1021.887592364843;1022.616518805448;1022.667633019268;1025.5538840604324;1030.5414090729628;1032.0814475117152;1033.1115240892825;1035.0063938618935;1071.9892801072006;1028.4035259549444;1030.5465595138114;1032.9431881246528;1033.4316126130598;1069.0058245831374;767.6161919040479;769.0732667136087;770.818857568471;779.5128044971892;806.7418426103649;13831.377588008563;15035.699286014327;15917.044977301282;16033.599160020976;17080.06059666718;16824.15879206035;16954.491365259062;17124.40064597733;17252.05113718745;17367.565810854703;12123.272603643722;13936.790948135786;13938.163710177421;13939.372728227254;13987.65030874226;3493.510908472816;3521.6126226115107;3521.7358698097487;3527.3650742866275;3529.135361836341;137308;138664.61335386618;138677;139293;140831;10398.740031499274;11006.394648294261;12839.422225999853;13150.342482875818;13166.946644268628;19190.232390704496;25075.247742567753;25124.87437562837;25215.117470888432;25267;7815.726449574237;7958.602069896598;7962.482438641586;7967.123616402191;7975.641096150687;3827.9808600956817;3873.32216862048;3876.8517686076193;3942.743721658083;3945.7237993340764;4273.957260427356;4336.913261734748;4356.825726970949;4369.628581570602;4375.518692943773;877.9017065384479;909.2587694564967;914.7392992996964;917.7384445433153;918.3296193778446;561.4638020690231;644.2076246217179;649.1560970738021;665.6904539389208;686.4131167851515;10754.946225268823;11007.449627518592;11840.644780656594;11896.014695311958;12108.939455302843;506.6959824105581;629.2417636747708;646.9906945165557;648.6367634124905;674.9673000309534;5330.951157068953;5516.806911758069;5518.530924871431;5617.43825617435;5656.981743286248;111433.44283278694;112323;112987;115883.42058289655;117103.53309369361;92494;95201.52399238099;95592;96065.51967240119;97304.02695973091;85041.14958850456;86766.83082922851;87400.56299718587;87984;88119.67820482698;10761.408122553335;11160.330380177214;11184.552617895193;11288.43557822122;11335.433228338716;31880.84059579687;41198.38202426906;41909.58090419057;41955.95110122149;42324;54084;54532;55004.72497637646;55226;55726.44273557213;13612.86387136116;13745.24401157906;14151.575452736435;14167.008309418241;14220.786688199893;15310.923445382701;15446.459373921858;15559.988600740915;15602.219889005277;15661;12013.519459221534;12152.088593355356;12308.815367769312;12443.688907777378;12455.190412623151;14102.717945641234;14254.144751314954;14513.129212247299;14594.489192878198;14598.197099159648;11711.590094346657;13954.441822327399;14101.929490352482;14127.505537306144;14266.144031358152;10460.947695261475;10545.050945414949;10844.728881778019;10949.069329107115;11063;11377.715557111138;11735.941320293345;11768.352740599006;11831.40842957866;11924.344161070878 05:08:39 INFO - PID 1635 | __end_tp_report 05:08:39 INFO - PID 1635 | __start_cc_report 05:08:39 INFO - PID 1635 | _x_x_mozilla_cycle_collect,2253 05:08:39 INFO - PID 1635 | __end_cc_report 05:08:39 INFO - PID 1635 | __startTimestamp1493122119824__endTimestamp 05:08:39 INFO - PID 1635 | 05:08:39 INFO - PID 1635 | ------- Summary: start ------- 05:08:39 INFO - PID 1635 | Number of tests: 6 05:08:39 INFO - PID 1635 | 05:08:39 INFO - PID 1635 | [#0] dojo.html Cycles:165 Average:5838.95 Median:6142.93 stddev:716.31 (11.7%) stddev-sans-first:678.72 05:08:39 INFO - PID 1635 | Values: 2838.2 2895.6 3418.6 3471.9 3497.9 5036.3 5619.9 5915.3 5994.5 5998.4 5556.6 5798.3 5798.8 5814.8 5845.9 5078.8 5112.2 5121.4 5148.4 5169.9 5188.2 5196.6 5205.5 5211.8 5213.1 4287.5 5194.9 5197.7 5199.4 5238.8 4316.3 5213.4 5230.2 5300.9 5320.3 5156.8 5195.3 5206.4 5211.7 5272.3 5613.3 5749.2 5996.6 6001.6 6069.8 6276.4 6303.1 6336.8 6351.3 6353.9 6402.5 6403.0 6404.7 6424.8 6431.9 6109.0 6113.5 6131.9 6132.5 6142.2 6279.5 6319.7 6342.4 6426.4 6446.1 6384.7 6389.4 6391.1 6393.3 6411.6 6330.0 6330.7 6383.8 6387.2 6403.6 6202.7 6265.3 6295.8 6382.4 6395.4 6158.8 6247.2 6326.5 6345.1 6375.7 5013.8 5035.1 5043.4 5076.7 5089.9 4618.0 4623.5 4658.5 4674.6 4722.9 6019.6 6025.3 6031.0 6046.8 6076.2 6251.4 6367.3 6412.5 6415.4 6426.3 5062.8 5654.8 5769.9 5816.4 5825.5 5485.6 5496.1 5505.5 5513.0 5519.5 6332.1 6353.5 6381.5 6384.3 6389.9 6302.0 6308.2 6326.5 6350.6 6367.9 6528.1 6536.6 6537.1 6556.0 6560.3 6333.7 6342.7 6356.2 6356.7 6371.3 5008.5 6322.0 6328.3 6333.4 6337.5 6064.8 6142.9 6170.0 6173.8 6184.1 5854.6 6141.1 6171.8 6288.3 6336.8 6233.8 6267.6 6273.8 6276.1 6279.7 6321.7 6324.4 6331.9 6336.5 6350.7 5905.0 5971.3 5981.2 6200.4 6210.3 05:08:39 INFO - PID 1635 | 05:08:39 INFO - PID 1635 | [#1] ext.html Cycles:180 Average:44159.36 Median:310288.45 stddev:77700.69 (25.0%) stddev-sans-first:77850.43 05:08:39 INFO - PID 1635 | Values: 791.1 806.6 1103.4 1127.7 1131.7 36601.3 36976.9 37030.6 37111.8 37196.0 38839.2 39274.0 39323.6 39349.2 39387.0 6065.9 6126.6 8304.0 8418.4 8440.5 6922.3 8101.5 8235.7 8253.5 8260.8 8258.9 8314.5 8319.2 8323.0 8329.2 8237.5 8284.5 8291.4 8291.8 8304.8 8219.0 8260.7 8264.9 8274.5 8288.0 36761.8 37063.9 37146.8 37182.6 37360.9 3022.3 3536.9 3537.0 3537.2 3541.4 30349.5 30356.7 30391.2 30459.8 30572.7 2956.6 3012.9 3016.7 3027.2 3029.2 287302.0 294529.5 294540.0 294927.0 295705.5 38803.2 39372.2 39580.0 48086.3 48225.8 40513.6 41241.0 41272.0 50436.0 50817.0 12063.8 13416.9 13802.9 13882.7 13883.1 11225.6 11232.7 11238.4 11255.0 11263.5 12156.5 12468.8 12509.7 12544.7 12615.6 5567.6 5578.5 5613.4 5618.5 5633.0 970.7 989.8 1009.4 1043.2 1046.9 23582.6 30096.8 30196.7 30705.8 30716.4 1065.7 1071.7 1100.1 1101.5 1108.5 11760.1 12009.0 12347.8 12348.7 12355.5 309226.0 310113.9 310463.0 311451.0 312399.4 51800.5 51973.7 52045.5 52054.7 52132.2 1419.3 1440.2 1485.9 1490.5 1518.4 23583.3 23717.0 23717.6 23770.9 23771.9 38199.4 38244.4 38311.0 38355.6 38369.0 283361.6 283463.0 284246.0 284758.0 285297.0 29286.4 29744.3 33044.8 33661.7 33958.3 42411.0 42945.8 42978.6 43043.0 43100.8 28001.3 29061.6 29824.4 29938.7 30246.0 28873.6 29558.9 29681.5 30144.5 30155.8 35425.8 35635.6 36097.3 36186.5 36423.6 29013.4 29167.4 29690.6 29717.4 29830.6 19333.9 19497.5 22016.3 22615.9 23338.5 05:08:39 INFO - PID 1635 | 05:08:39 INFO - PID 1635 | [#2] jquery.html Cycles:180 Average:36078.67 Median:11840.94 stddev:96978.21 (819.0%) stddev-sans-first:97213.33 05:08:39 INFO - PID 1635 | Values: 433.8 436.3 437.3 446.2 456.8 17368.0 18766.7 20426.3 20988.9 21132.7 20640.6 20941.9 21345.0 21439.5 21527.0 5457.2 6131.3 6145.3 6146.9 6149.9 5880.1 5971.3 5972.9 5978.6 6052.2 5141.0 6034.3 6055.3 6059.3 6062.0 5905.3 5925.5 6017.3 6053.4 6064.9 5257.2 5333.5 5350.2 5368.9 5382.2 25906.3 26196.6 26209.5 26497.6 26591.7 1745.8 2103.6 2142.9 2144.5 2151.1 17772.9 17916.2 18004.8 18217.7 18221.7 2124.5 2133.6 2134.8 2154.9 2163.2 169148.0 170714.0 171375.1 172077.0 172239.0 9862.5 11936.6 12071.1 12127.0 12393.3 15826.4 16239.5 16246.7 16280.7 16282.1 7159.4 8568.2 8749.3 8816.7 8919.0 7100.2 8264.2 8301.5 8462.8 8486.5 6167.8 7291.2 7546.6 7552.3 7574.7 1943.6 2097.5 2106.8 2116.8 2119.7 867.0 900.7 907.2 920.7 946.5 20013.6 20591.8 20591.8 20651.8 20851.4 871.6 919.5 928.8 948.8 988.3 10279.4 10542.8 10543.3 10628.9 10759.1 559182.0 561635.4 561851.0 580096.0 582585.0 133219.3 133669.0 135030.0 136566.3 138192.9 1113.2 1140.1 1158.5 1158.9 1159.6 13909.4 16860.6 17391.4 17751.2 17892.0 41277.6 51383.0 52051.2 53153.0 54307.5 61395.9 67843.0 74631.9 75905.0 76128.2 7261.7 8326.9 8359.5 8558.7 8817.4 10874.5 13643.6 13742.2 14048.0 14134.8 11900.5 12022.9 12312.9 12313.4 12343.3 11519.1 11536.7 11633.9 11814.1 11879.2 11991.4 12088.1 12397.9 12401.8 12552.7 8625.1 8659.6 8735.0 8975.6 9166.2 9848.8 11778.1 11958.3 12112.2 12154.8 05:08:39 INFO - PID 1635 | 05:08:39 INFO - PID 1635 | [#3] mootools.html Cycles:180 Average:7149.06 Median:4101.45 stddev:4576.45 (111.6%) stddev-sans-first:4567.02 05:08:39 INFO - PID 1635 | Values: 1140.5 1324.0 1360.9 1377.2 1391.4 9808.7 11451.3 11621.5 11777.7 11799.2 11521.4 11619.2 11623.5 11623.7 11626.7 2486.4 2527.2 2531.3 2532.2 2535.1 2134.5 2209.0 2484.4 2581.4 2598.4 2494.6 2499.3 2528.7 2529.5 2531.5 2508.9 2516.8 2521.1 2521.2 2522.4 2463.1 2485.5 2486.3 2489.5 2491.7 11725.2 11809.4 11937.0 11944.8 11955.4 6453.9 6717.0 6720.9 6722.3 6732.9 4014.9 4116.4 4328.4 4404.8 4407.3 1127.4 1233.8 1246.2 1286.2 1304.1 16652.8 16683.9 16692.0 16711.9 16779.2 5767.5 5930.6 5965.1 6063.9 6082.7 13913.0 13933.0 13949.1 13954.8 13982.9 6832.5 6834.8 6843.4 6844.6 6866.1 5235.8 6127.1 6195.3 6279.7 6289.7 4160.0 4241.9 4244.1 4252.4 4263.3 1118.3 1231.3 1320.4 1469.1 1500.6 719.8 765.1 770.8 786.0 790.9 5918.4 5960.4 6203.0 6278.4 6309.6 901.8 909.1 915.9 918.7 922.7 4086.5 4287.4 4313.8 4446.0 4509.9 13206.8 13930.0 15239.9 15266.7 15283.8 14672.6 14944.9 15096.4 15137.2 15159.2 8576.2 8613.2 8633.1 8634.6 8638.7 6432.7 6513.6 6683.7 6704.7 6761.0 11362.7 13653.6 13683.2 13703.7 13714.9 13446.3 13752.7 13802.9 13832.5 13854.4 9537.7 9604.7 9639.5 9708.1 9725.2 10477.8 10582.7 10759.3 10777.7 10791.7 6950.5 8997.7 9079.4 9121.0 9243.7 8963.6 8966.9 9037.5 9064.6 9094.6 8138.9 8157.6 8206.5 8225.3 8230.6 5896.8 5950.3 5987.6 6033.5 6149.8 4841.4 5050.1 5402.5 6046.7 6060.0 05:08:39 INFO - PID 1635 | 05:08:39 INFO - PID 1635 | [#4] prototype.html Cycles:180 Average:4995.10 Median:5570.50 stddev:1511.07 (27.1%) stddev-sans-first:1474.42 05:08:39 INFO - PID 1635 | Values: 343.4 372.6 391.9 404.3 405.8 5401.1 5559.9 5731.9 5808.7 5847.6 4448.4 5721.7 5748.3 5753.5 5754.5 4321.7 4385.4 4426.8 4457.6 4463.7 4424.4 4425.8 4433.5 4440.9 4444.6 3595.3 4375.2 4390.7 4409.7 4411.0 4208.8 4372.9 4395.7 4408.4 4425.3 3037.8 3801.7 3928.3 3931.4 3937.0 5562.7 5569.7 5571.3 5577.6 5600.7 5170.7 5207.3 5283.4 5298.7 5316.0 6177.3 6178.5 6182.5 6182.8 6183.8 4452.2 4463.7 4472.0 4490.6 4490.6 5924.6 6010.9 6195.5 6429.3 6512.9 4538.8 4539.8 4564.2 4573.5 4574.9 4381.5 4574.8 4612.4 4638.9 4658.3 4380.3 4740.9 4797.8 5001.6 5307.4 5325.4 5483.3 5653.3 6117.0 6141.0 1454.5 1468.7 1472.3 1472.6 1480.8 942.8 981.8 982.2 983.3 997.3 5035.6 5726.0 5789.9 5796.5 5832.8 6287.0 6294.2 6305.2 6313.7 6338.7 4651.3 5463.7 5721.3 5780.9 5783.0 2751.9 2917.9 3194.6 3224.6 3316.0 5215.7 6306.5 6438.1 6455.0 6456.7 5472.4 5759.3 5911.6 6411.7 6431.6 5360.2 6115.4 6411.5 6427.9 6431.7 5430.4 5591.5 6291.4 6341.7 6381.8 5177.7 6226.9 6272.2 6310.9 6314.8 5105.9 5489.5 6551.2 6598.6 6646.3 3528.9 4209.1 4237.4 4243.0 4249.2 5530.9 6404.8 6410.5 6422.1 6435.1 5376.7 5940.9 6141.2 6187.3 6207.3 6077.0 6098.6 6136.4 6199.7 6216.5 5513.3 6034.6 6066.8 6084.3 6107.8 6152.5 6163.7 6169.9 6179.5 6195.7 5084.7 5653.9 5743.8 5944.7 6015.4 05:08:39 INFO - PID 1635 | 05:08:39 INFO - PID 1635 | [#5] yui.html Cycles:180 Average:22054.67 Median:16163.31 stddev:33315.45 (206.1%) stddev-sans-first:33370.38 05:08:39 INFO - PID 1635 | Values: 714.4 855.3 855.8 855.9 872.4 12955.8 17903.5 18614.6 18632.4 18669.3 16070.0 16082.8 16117.9 16154.5 16172.1 958.7 970.0 991.1 1013.7 1021.0 1021.8 1021.9 1022.6 1022.7 1025.6 1030.5 1032.1 1033.1 1035.0 1072.0 1028.4 1030.5 1032.9 1033.4 1069.0 767.6 769.1 770.8 779.5 806.7 13831.4 15035.7 15917.0 16033.6 17080.1 16824.2 16954.5 17124.4 17252.1 17367.6 12123.3 13936.8 13938.2 13939.4 13987.7 3493.5 3521.6 3521.7 3527.4 3529.1 137308.0 138664.6 138677.0 139293.0 140831.0 10398.7 11006.4 12839.4 13150.3 13166.9 19190.2 25075.2 25124.9 25215.1 25267.0 7815.7 7958.6 7962.5 7967.1 7975.6 3828.0 3873.3 3876.9 3942.7 3945.7 4274.0 4336.9 4356.8 4369.6 4375.5 877.9 909.3 914.7 917.7 918.3 561.5 644.2 649.2 665.7 686.4 10754.9 11007.4 11840.6 11896.0 12108.9 506.7 629.2 647.0 648.6 675.0 5331.0 5516.8 5518.5 5617.4 5657.0 111433.4 112323.0 112987.0 115883.4 117103.5 92494.0 95201.5 95592.0 96065.5 97304.0 85041.1 86766.8 87400.6 87984.0 88119.7 10761.4 11160.3 11184.6 11288.4 11335.4 31880.8 41198.4 41909.6 41956.0 42324.0 54084.0 54532.0 55004.7 55226.0 55726.4 13612.9 13745.2 14151.6 14167.0 14220.8 15310.9 15446.5 15560.0 15602.2 15661.0 12013.5 12152.1 12308.8 12443.7 12455.2 14102.7 14254.1 14513.1 14594.5 14598.2 11711.6 13954.4 14101.9 14127.5 14266.1 10460.9 10545.1 10844.7 10949.1 11063.0 11377.7 11735.9 11768.4 11831.4 11924.3 05:08:39 INFO - PID 1635 | -------- Summary: end -------- 05:08:39 INFO - PID 1635 | 05:08:40 INFO - TEST-INFO | 1635: exit 0 05:08:40 INFO - TEST-OK | dromaeo_css | took 1118444ms 05:08:40 INFO - TEST-START | kraken 05:08:40 INFO - operating with platform_type : mac_ 05:08:40 INFO - Initialising browser for kraken test... 05:08:40 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpdgBnF6/profile http://localhost:49235/getInfo.html) 05:08:42 INFO - PID 1644 | __metrics Screen width/height:1600/1200 05:08:42 INFO - PID 1644 | colorDepth:24 05:08:42 INFO - PID 1644 | Browser inner width/height: 1024/689 05:08:42 INFO - PID 1644 | __metrics 05:08:43 INFO - PID 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:08:43 INFO - PID 1644 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:08:43 INFO - TEST-INFO | 1644: exit 0 05:08:43 INFO - Browser initialized. 05:08:43 INFO - Running cycle 1/1 for kraken test... 05:08:43 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpdgBnF6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:56 INFO - PID 1646 | RSS: Main: 241553408 05:08:56 INFO - PID 1646 | 05:08:58 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 05:08:59 INFO - PID 1646 | RSS: Main: 312332288 05:08:59 INFO - PID 1646 | 05:09:02 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 05:09:03 INFO - PID 1646 | RSS: Main: 293900288 05:09:03 INFO - PID 1646 | 05:09:06 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 05:09:07 INFO - PID 1646 | RSS: Main: 385642496 05:09:07 INFO - PID 1646 | 05:09:09 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 05:09:09 INFO - PID 1646 | RSS: Main: 290111488 05:09:09 INFO - PID 1646 | 05:09:11 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:09:12 INFO - PID 1646 | RSS: Main: 292167680 05:09:12 INFO - PID 1646 | 05:09:15 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 05:09:15 INFO - PID 1646 | RSS: Main: 355917824 05:09:15 INFO - PID 1646 | 05:09:18 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 05:09:19 INFO - PID 1646 | RSS: Main: 372871168 05:09:19 INFO - PID 1646 | 05:09:22 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 05:09:22 INFO - PID 1646 | RSS: Main: 381202432 05:09:22 INFO - PID 1646 | 05:09:24 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:09:24 INFO - PID 1646 | RSS: Main: 333660160 05:09:24 INFO - PID 1646 | 05:09:26 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:09:27 INFO - PID 1646 | RSS: Main: 335536128 05:09:27 INFO - PID 1646 | 05:09:29 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:09:29 INFO - PID 1646 | RSS: Main: 337104896 05:09:29 INFO - PID 1646 | 05:09:32 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:09:33 INFO - PID 1646 | RSS: Main: 351961088 05:09:33 INFO - PID 1646 | 05:09:36 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:09:37 INFO - PID 1646 | RSS: Main: 344100864 05:09:37 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 05:09:39 INFO - PID 1646 | RSS: Main: 387379200 05:09:39 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | __start_tp_report 05:09:39 INFO - PID 1646 | _x_x_mozilla_page_load 05:09:39 INFO - PID 1646 | _x_x_mozilla_page_load_details 05:09:39 INFO - PID 1646 | |i|pagename|runs| 05:09:39 INFO - PID 1646 | |0;ai-astar;111;111;110;111;111;110;111;111;111;110 05:09:39 INFO - PID 1646 | |1;audio-beat-detection;138;104;107;151;123;138;110;107;133;107 05:09:39 INFO - PID 1646 | |2;audio-dft;181;184;184;184;186;183;183;182;181;181 05:09:39 INFO - PID 1646 | |3;audio-fft;81;61;61;87;61;60;77;88;96;58 05:09:39 INFO - PID 1646 | |4;audio-oscillator;87;71;85;69;69;69;90;69;68;97 05:09:39 INFO - PID 1646 | |5;imaging-gaussian-blur;86;87;87;87;88;87;87;87;87;86 05:09:39 INFO - PID 1646 | |6;imaging-darkroom;94;95;95;94;94;94;95;95;93;94 05:09:39 INFO - PID 1646 | |7;imaging-desaturate;86;87;85;84;84;85;83;83;86;84 05:09:39 INFO - PID 1646 | |8;json-parse-financial;49;48;48;46;47;48;50;48;50;47 05:09:39 INFO - PID 1646 | |9;json-stringify-tinderbox;54;60;57;67;62;59;60;57;57;57 05:09:39 INFO - PID 1646 | |10;stanford-crypto-aes;80;83;82;80;83;82;81;82;79;81 05:09:39 INFO - PID 1646 | |11;stanford-crypto-ccm;147;123;134;133;134;136;138;146;176;158 05:09:39 INFO - PID 1646 | |12;stanford-crypto-pbkdf2;181;180;205;227;232;184;183;183;185;199 05:09:39 INFO - PID 1646 | |13;stanford-crypto-sha256-iterative;69;84;96;90;66;57;91;92;94;89 05:09:39 INFO - PID 1646 | __end_tp_report 05:09:39 INFO - PID 1646 | __start_cc_report 05:09:39 INFO - PID 1646 | _x_x_mozilla_cycle_collect,2190 05:09:39 INFO - PID 1646 | __end_cc_report 05:09:39 INFO - PID 1646 | __startTimestamp1493122179529__endTimestamp 05:09:39 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | ------- Summary: start ------- 05:09:39 INFO - PID 1646 | Number of tests: 14 05:09:39 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:09:39 INFO - PID 1646 | Values: 111.0 111.0 110.0 111.0 111.0 110.0 111.0 111.0 111.0 110.0 05:09:39 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | [#1] audio-beat-detection Cycles:10 Average:121.80 Median:128.00 stddev:17.05 (13.3%) stddev-sans-first:17.05 05:09:39 INFO - PID 1646 | Values: 138.0 104.0 107.0 151.0 123.0 138.0 110.0 107.0 133.0 107.0 05:09:39 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.50 stddev:1.66 (0.9%) stddev-sans-first:1.62 05:09:39 INFO - PID 1646 | Values: 181.0 184.0 184.0 184.0 186.0 183.0 183.0 182.0 181.0 181.0 05:09:39 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | [#3] audio-fft Cycles:10 Average:73.00 Median:79.00 stddev:14.36 (18.2%) stddev-sans-first:14.94 05:09:39 INFO - PID 1646 | Values: 81.0 61.0 61.0 87.0 61.0 60.0 77.0 88.0 96.0 58.0 05:09:39 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:78.00 stddev:11.08 (14.2%) stddev-sans-first:11.19 05:09:39 INFO - PID 1646 | Values: 87.0 71.0 85.0 69.0 69.0 69.0 90.0 69.0 68.0 97.0 05:09:39 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:87.00 stddev:0.57 (0.7%) stddev-sans-first:0.50 05:09:39 INFO - PID 1646 | Values: 86.0 87.0 87.0 87.0 88.0 87.0 87.0 87.0 87.0 86.0 05:09:39 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:09:39 INFO - PID 1646 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 93.0 94.0 05:09:39 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.34 (1.6%) stddev-sans-first:1.33 05:09:39 INFO - PID 1646 | Values: 86.0 87.0 85.0 84.0 84.0 85.0 83.0 83.0 86.0 84.0 05:09:39 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | [#8] json-parse-financial Cycles:10 Average:48.10 Median:48.00 stddev:1.29 (2.7%) stddev-sans-first:1.32 05:09:39 INFO - PID 1646 | Values: 49.0 48.0 48.0 46.0 47.0 48.0 50.0 48.0 50.0 47.0 05:09:39 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.50 stddev:3.59 (6.0%) stddev-sans-first:3.32 05:09:39 INFO - PID 1646 | Values: 54.0 60.0 57.0 67.0 62.0 59.0 60.0 57.0 57.0 57.0 05:09:39 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:82.00 stddev:1.34 (1.6%) stddev-sans-first:1.33 05:09:39 INFO - PID 1646 | Values: 80.0 83.0 82.0 80.0 83.0 82.0 81.0 82.0 79.0 81.0 05:09:39 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:142.00 stddev:15.17 (10.7%) stddev-sans-first:16.01 05:09:39 INFO - PID 1646 | Values: 147.0 123.0 134.0 133.0 134.0 136.0 138.0 146.0 176.0 158.0 05:09:39 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.90 Median:192.00 stddev:19.52 (10.2%) stddev-sans-first:19.95 05:09:39 INFO - PID 1646 | Values: 181.0 180.0 205.0 227.0 232.0 184.0 183.0 183.0 185.0 199.0 05:09:39 INFO - PID 1646 | 05:09:39 INFO - PID 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.80 Median:90.50 stddev:13.67 (15.1%) stddev-sans-first:13.56 05:09:39 INFO - PID 1646 | Values: 69.0 84.0 96.0 90.0 66.0 57.0 91.0 92.0 94.0 89.0 05:09:39 INFO - PID 1646 | -------- Summary: end -------- 05:09:39 INFO - PID 1646 | 05:09:40 INFO - TEST-INFO | 1646: exit 0 05:09:40 INFO - TEST-OK | kraken | took 60062ms 05:09:40 INFO - SUITE-END | took 1178s 05:09:40 INFO - Completed test suite (00:19:38) 05:09:40 INFO - javascript benchmark 05:09:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7629.028693659311, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2838.1911155320736, 2895.6235689360387, 3418.5555877735906, 3471.8784842530517, 3497.947530787037, 5036.269740887578, 5619.915701264485, 5915.319738230105, 5994.490468310199, 5998.4301491358365, 5556.583256255777, 5798.275215598051, 5798.797042103527, 5814.796482123126, 5845.941540584593, 5078.771455284521, 5112.156494178456, 5121.411037730652, 5148.433672296063, 5169.948300517003, 5188.221766734982, 5196.558292545138, 5205.531502164805, 5211.843644690665, 5213.087709650796, 4287.528371879091, 5194.896102077956, 5197.688138711689, 5199.350081239845, 5238.816641417532, 4316.309390497537, 5213.400458947212, 5230.189320655304, 5300.867478313035, 5320.334958130234, 5156.767945442464, 5195.298634684307, 5206.401263854667, 5211.687298762086, 5272.340957380327, 5613.326400831886, 5749.223854779593, 5996.610220335664, 6001.609895356832, 6069.787557435468, 6276.403741644536, 6303.117563541108, 6336.841578960517, 6351.269603995507, 6353.904691429632, 6402.48780097591, 6403.0, 6404.743810247584, 6424.775132870373, 6431.871362572769, 6108.992016317302, 6113.541484388688, 6131.908021379683, 6132.50939924805, 6142.232220972379, 6279.529035322369, 6319.684015799192, 6342.365763423713, 6426.4216220540375, 6446.065320528591, 6384.680765961683, 6389.393007664265, 6391.1371964785085, 6393.328700486475, 6411.5832470889245, 6329.9872020476505, 6330.746770129143, 6383.840403989844, 6387.169667943138, 6403.615783053032, 6202.689865506707, 6265.342139075331, 6295.779647712308, 6382.361763823674, 6395.360463953661, 6158.846028849225, 6247.156633854463, 6326.5255105867245, 6345.079963405373, 6375.681215939185, 5013.849584512471, 5035.144025515671, 5043.445221025684, 5076.670016448919, 5089.898202035939, 4617.976910115428, 4623.491415944243, 4658.487566367697, 4674.555917187861, 4722.905541889143, 6019.578629495893, 6025.3372129065765, 6031.0, 6046.848828779316, 6076.21009268801, 6251.374862513712, 6367.329888755773, 6412.4549413299455, 6415.358464153547, 6426.2931077581425, 5062.784931616386, 5654.8303550892715, 5769.88460230793, 5816.447437493432, 5825.50483208932, 5485.561155107582, 5496.120620700749, 5505.504504594605, 5513.007658621486, 5519.530839878656, 6332.145160403286, 6353.5234857385885, 6381.489480841615, 6384.265809431789, 6389.904151437732, 6301.96849015752, 6308.211473565804, 6326.4622507087415, 6350.618962862243, 6367.90448143269, 6528.086067950586, 6536.640484773383, 6537.117489139096, 6556.016597510412, 6560.343965603402, 6333.683315834282, 6342.682865856781, 6356.2054743157105, 6356.745730170742, 6371.331010243857, 5008.524190201925, 6321.96839015802, 6328.303886572381, 6333.36666333363, 6337.493000560036, 6064.818055458167, 6142.928535732134, 6170.0, 6173.783917562864, 6184.134221209124, 5854.590178687451, 6141.117811340085, 6171.753129874754, 6288.339724328879, 6336.8098957029515, 6233.846738353419, 6267.561270711007, 6273.843153921189, 6276.089966954674, 6279.71741271653, 6321.683915804283, 6324.3991820776955, 6331.873362532631, 6336.493080553637, 6350.745970161327, 5905.0, 5971.28344598651, 5981.222441082631, 6200.3799620037635, 6210.3168651449205], "value": 5789.195073978896, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.0902462168506, 806.57251656622, 1103.3931337764232, 1127.6617014895535, 1131.700099473639, 36601.26797464049, 36976.89069327918, 37030.62969370306, 37111.76320617481, 37196.0, 38839.22321553567, 39274.0, 39323.60676393235, 39349.21301573967, 39387.0, 6065.939340606604, 6126.632402055869, 8303.95848020759, 8418.410711250215, 8440.451370660887, 6922.307769223088, 8101.473404228706, 8235.670573177065, 8253.463524870864, 8260.793480162984, 8258.876116858251, 8314.501129932192, 8319.209675080889, 8323.04285007226, 8329.167083291653, 8237.546934918577, 8284.46151000183, 8291.378146639026, 8291.83416331676, 8304.83390332196, 8219.0, 8260.710875119343, 8264.917350826536, 8274.544900030496, 8287.95856020722, 36761.81619091914, 37063.888083357546, 37146.81426592877, 37182.628173718185, 37360.87917362483, 3022.335086281015, 3536.8585256589704, 3536.9646303536892, 3537.221811201557, 3541.4333706607076, 30349.544756828665, 30356.69643303561, 30391.24021899448, 30459.847700761577, 30572.69427305721, 2956.615639966812, 3012.9397412051635, 3016.7284944355115, 3027.2129246395875, 3029.166979080748, 287302.0, 294529.52735236404, 294540.0, 294927.0, 295705.5214723934, 38803.223935521135, 39372.2125557493, 39580.0, 48086.27870581944, 48225.7943551414, 40513.569185848944, 41241.0, 41272.0, 50436.0, 50816.98366032659, 12063.819042714365, 13416.932915335556, 13802.93098534521, 13882.652933676738, 13883.097598656055, 11225.576199259305, 11232.66302010941, 11238.38188899602, 11255.0, 11263.493142808593, 12156.513739450324, 12468.820450785173, 12509.74980500403, 12544.74910501803, 12615.621531354074, 5567.610267281332, 5578.497935185853, 5613.354464236583, 5618.52242559387, 5633.014222511044, 970.6651205334149, 989.7525618595351, 1009.369144284822, 1043.1758910460803, 1046.884842667306, 23582.56697321051, 30096.849515752718, 30196.698033019828, 30705.846470767505, 30716.38567228643, 1065.717584840018, 1071.737424331044, 1100.1308965916835, 1101.5043230546287, 1108.5177947592822, 11760.117991150699, 12009.0, 12347.75304493923, 12348.691282717824, 12355.505779768888, 309226.0, 310113.898861013, 310463.0, 311451.0, 312399.43800280854, 51800.48199518032, 51973.740131299855, 52045.47954520482, 52054.73972630112, 52132.21801672978, 1419.3471003338373, 1440.1978776031285, 1485.8811295096366, 1490.478332583587, 1518.4078209498305, 23583.29250122499, 23717.0, 23717.644235336138, 23770.881145594853, 23771.930263138547, 38199.42700859545, 38244.426333605574, 38311.04222394463, 38355.61644383632, 38369.0, 283361.5831920827, 283463.0, 284246.0, 284758.0, 285297.0, 29286.41427171402, 29744.256393590334, 33044.83477582597, 33661.663383365856, 33958.32083358269, 42411.0, 42945.785271073444, 42978.57021429871, 43043.0, 43100.78449607732, 28001.299967500974, 29061.564076538445, 29824.403511929206, 29938.70061299359, 30246.0, 28873.56689649699, 29558.852205738833, 29681.54076088391, 30144.54783178298, 30155.849220753757, 35425.82287088651, 35635.643643563235, 36097.27805443929, 36186.45720314145, 36423.63576364202, 29013.41973160567, 29167.416651666423, 29690.554641680825, 29717.405651887275, 29830.55254171146, 19333.90333048326, 19497.512562186057, 22016.33950981473, 22615.88692056529, 23338.53322933566], "value": 17047.54240934541, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.80695590462255, 436.2605383874333, 437.33961717806125, 446.2079808340197, 456.8035744629808, 17368.0, 18766.718499222523, 20426.2850800222, 20988.89505552474, 21132.683009754866, 20640.587188256224, 20941.895290523564, 21345.0, 21439.464013399673, 21527.0, 5457.181422786584, 6131.325554189036, 6145.324014358417, 6146.907796383058, 6149.938500614981, 5880.147378630118, 5971.34315225327, 5972.940270597303, 5978.611390259641, 6052.182955301044, 5140.995011945344, 6034.336223015487, 6055.333913269536, 6059.303180134297, 6062.0, 5905.320888097859, 5925.525957923356, 6017.2779266488305, 6053.364396738367, 6064.878702425926, 5257.211418287249, 5333.546648534879, 5350.197470379435, 5368.91946620801, 5382.1926710993275, 25906.336859365307, 26196.60705089425, 26209.475810483684, 26497.602535961974, 26591.73408265912, 1745.7905051393786, 2103.63186442372, 2142.8928553572414, 2144.4960434297927, 2151.0965394534333, 17772.91113544437, 17916.193771280323, 18004.819951800444, 18217.726734098866, 18221.7266740999, 2124.458263142889, 2133.562619662981, 2134.8185404240658, 2154.881481518516, 2163.1888041984257, 169148.0, 170714.0, 171375.14312428483, 172077.0, 172239.0, 9862.50687465624, 11936.641900742992, 12071.05086914361, 12127.0, 12393.318367489876, 15826.44607438734, 16239.51281461558, 16246.675066498603, 16280.674386512203, 16282.127555331052, 7159.355657990805, 8568.186022327869, 8749.300055995505, 8816.691415800544, 8918.974317953389, 7100.218975912646, 8264.21489958453, 8301.46040507365, 8462.83074338522, 8486.490810551386, 6167.753289868445, 7291.197968223491, 7546.622668866535, 7552.320291173821, 7574.697012119454, 1943.6200297788446, 2097.5070858348276, 2106.8314534837177, 2116.7565729940948, 2119.6714509250783, 866.994286627509, 900.7342833864026, 907.1744712311764, 920.742192186189, 946.5030858799186, 20013.59972800536, 20591.794082058987, 20591.79408205929, 20651.760894346386, 20851.374458766262, 871.6382701179067, 919.5126582911067, 928.767808047988, 948.8339540580508, 988.2736188901152, 10279.434631095362, 10542.789144217226, 10543.31468454548, 10628.89371106279, 10759.085477734323, 559182.0, 561635.4119276336, 561851.0, 580096.0, 582585.0, 133219.33390332985, 133669.0, 135030.0, 136566.31716841352, 138192.9271060935, 1113.194749231931, 1140.1391949078559, 1158.478684591937, 1158.8551431071116, 1159.5999380213814, 13909.37407816671, 16860.57848553796, 17391.391301304393, 17751.201195946473, 17892.015939123474, 41277.587224127376, 51382.97234055373, 52051.21923171231, 53153.0, 54307.45692543182, 61395.860413958246, 67842.98235526372, 74631.8805217933, 75905.0, 76128.23871761211, 7261.673224704795, 8326.875096873673, 8359.456635318928, 8558.657653693783, 8817.426867253607, 10874.510647020745, 13643.590692279247, 13742.175469471864, 14048.035152543984, 14134.78797818054, 11900.523979040741, 12022.879771202175, 12312.876871231172, 12313.44589493457, 12343.321117338633, 11519.136064795006, 11536.653900383002, 11633.941830290794, 11814.113941454598, 11879.168458207843, 11991.400429978292, 12088.093392995737, 12397.93801030989, 12401.751964960831, 12552.748945020865, 8625.094365091825, 8659.6103175356, 8735.0, 8975.596098175729, 9166.22087122602, 9848.753781155528, 11778.057755379721, 11958.342291174069, 12112.15214934946, 12154.806591725841], "value": 10141.882642496908, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1140.5152810055736, 1323.9536616218431, 1360.870477503672, 1377.249399077502, 1391.3738817532112, 9808.705738827837, 11451.282307653846, 11621.535138594467, 11777.70555736107, 11799.174057815957, 11521.36632485213, 11619.244749091304, 11623.47694353754, 11623.6512904613, 11626.709332266697, 2486.4156923123005, 2527.153403609793, 2531.2659328794625, 2532.240327901631, 2535.0746977353224, 2134.5304033112766, 2208.967749670307, 2484.35406794233, 2581.4062765563835, 2598.414577495395, 2494.5759220932487, 2499.3251822008046, 2528.734482879299, 2529.544681957247, 2531.4683916377585, 2508.8871000804916, 2516.848989060644, 2521.1176088369198, 2521.168014555211, 2522.382016405974, 2463.1132792194794, 2485.5401750676183, 2486.3038349262238, 2489.5269898719184, 2491.7134529528976, 11725.179237453382, 11809.350485723282, 11937.0, 11944.820827687592, 11955.402229888557, 6453.935460645427, 6717.0, 6720.865582688368, 6722.327767223239, 6732.93267067328, 4014.9397759033636, 4116.403121547389, 4328.437303150602, 4404.779761011937, 4407.316865885793, 1127.4419162514525, 1233.8210959410835, 1246.1712960881002, 1286.1768468180371, 1304.0545604436802, 16652.75020874688, 16683.91658041702, 16692.0, 16711.91644041784, 16779.244933978, 5767.509761670305, 5930.584859059911, 5965.075413310944, 6063.878722425527, 6082.726277317532, 13913.0, 13933.0, 13949.093308934887, 13954.790678139836, 13982.860171398359, 6832.521723479309, 6834.829129271808, 6843.3575941773615, 6844.623545704934, 6866.141732283465, 5235.816746413857, 6127.142200091991, 6195.287541932736, 6279.654618995908, 6289.7484100635465, 4159.961618806823, 4241.936370954438, 4244.129953359616, 4252.4046633471335, 4263.253930562139, 1118.2842980492492, 1231.335079057299, 1320.392619395089, 1469.1258701072845, 1500.6173425776358, 719.7768691705588, 765.1430397954216, 770.816796217803, 786.0488808541728, 790.9446338756347, 5918.437748413894, 5960.403959604092, 6203.0, 6278.434940855345, 6309.558330916791, 901.8376692195468, 909.0999910088964, 915.9267258619294, 918.6784625381063, 922.6770630279349, 4086.4891888513935, 4287.421198138274, 4313.8490152845125, 4445.977770111193, 4509.887252818706, 13206.811386975027, 13930.0, 15239.923800380928, 15266.694666106838, 15283.847161528241, 14672.633184170267, 14944.850551494563, 15096.39614415433, 15137.243137843065, 15159.24203789806, 8576.185262400062, 8613.22480976715, 8633.093525179891, 8634.568271586395, 8638.697645582375, 6432.748538011659, 6513.576617519846, 6683.699233534599, 6704.6982885769285, 6761.0, 11362.659120226406, 13653.590392288248, 13683.179009259477, 13703.657408564866, 13714.93142534281, 13446.260455675032, 13752.65618359549, 13802.930985345009, 13832.515861944783, 13854.376553054935, 9537.666181683608, 9604.66383676568, 9639.469829159463, 9708.077732615391, 9725.173360264456, 10477.842832357674, 10582.682519524427, 10759.30064545802, 10777.676669699922, 10791.730206744895, 6950.51346405767, 8997.685081022133, 9079.409838360485, 9121.042290559395, 9243.722688319362, 8963.596638151168, 8966.910330896868, 9037.548122593975, 9064.592093355946, 9094.636214551343, 8138.9186108138165, 8157.632906519102, 8206.548639824867, 8225.341972642294, 8230.588470576567, 5896.823095307148, 5950.3454619992635, 5987.5808693391045, 6033.487153591994, 6149.7847575334645, 4841.370621819141, 5050.065737838511, 5402.541843461137, 6046.667433291212, 6060.0], "value": 5380.274339103157, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.42133505044, 372.63667923774324, 391.9059425737824, 404.2965240481563, 405.81332587009973, 5401.135818269077, 5559.8888022239635, 5731.856703582407, 5808.738606762695, 5847.64914105154, 4448.3523510721225, 5721.684012677077, 5748.281464816898, 5753.482186603205, 5754.453326933945, 4321.697481176319, 4385.407969924067, 4426.800793964279, 4457.576530229631, 4463.70985885918, 4424.40270563473, 4425.8229670813125, 4433.467983841927, 4440.86677399677, 4444.599986001259, 3595.3168897909445, 4375.190589740892, 4390.692651514395, 4409.669274804386, 4410.955890441102, 4208.789560521992, 4372.868813935587, 4395.736255824629, 4408.40486534317, 4425.291953287475, 3037.787354885159, 3801.733878628497, 3928.332183528807, 3931.410288456726, 3936.976386139596, 5562.6611243230345, 5569.66582005081, 5571.331440227199, 5577.637453565505, 5600.691961942091, 5170.663906846043, 5207.297014903015, 5283.418823929364, 5298.735063246822, 5315.973420132875, 6177.25872895251, 6178.474829639486, 6182.536309776785, 6182.783602573888, 6183.846238418394, 4452.1986042512335, 4463.709858859163, 4471.955280447187, 4490.550944905516, 4490.57339552742, 5924.644521328691, 6010.909836352502, 6195.504359651217, 6429.292777794439, 6512.93487065128, 4538.773061346919, 4539.818407263672, 4564.1556312082375, 4573.49691533931, 4574.908501830011, 4381.452318460192, 4574.771261436915, 4612.377329060534, 4638.930416043762, 4658.301254811805, 4380.255356589388, 4740.857774266778, 4797.832075877328, 5001.574551252876, 5307.363116426053, 5325.3609566851455, 5483.341998960151, 5653.265075540236, 6117.021276595723, 6140.969295153495, 1454.4691187716408, 1468.728285267229, 1472.263868065967, 1472.580314610331, 1480.8074950256614, 942.7595963029383, 981.764376549623, 982.2044144243043, 983.311681822727, 997.2769741937183, 5035.571976381975, 5725.971370143206, 5789.8552536186935, 5796.478316951495, 5832.766689332464, 6286.968565157145, 6294.213223347082, 6305.243370795534, 6313.652749098844, 6338.651374174372, 4651.279051746985, 5463.672179669233, 5721.284839395075, 5780.88438231233, 5783.045797443375, 2751.9449611007667, 2917.8912013435183, 3194.568733221032, 3224.5976747323393, 3315.950260746091, 5215.6609820361555, 6306.540449224806, 6438.130852334969, 6454.997377032837, 6456.741730330828, 5472.398036216013, 5759.2512973313205, 5911.556633252523, 6411.711472983634, 6431.614103153825, 5360.222767698662, 6115.3578874217565, 6411.531560349205, 6427.865069772549, 6431.710573024132, 5430.429804870431, 5591.496765290981, 6291.370862913672, 6341.685284870897, 6381.840453988688, 5177.689338639693, 6226.875462490815, 6272.240214305691, 6310.873782524232, 6314.778982735582, 5105.948940510547, 5489.505944465017, 6551.246606640107, 6598.637074960923, 6646.268910419946, 3528.8764893228613, 4209.052963083282, 4237.4067630531135, 4243.0, 4249.194092510609, 5530.917036244379, 6404.783091212655, 6410.487161027013, 6422.133012043314, 6435.131257280207, 5376.677399356051, 5940.851478712894, 6141.201643786279, 6187.319394866651, 6207.286162091236, 6077.0, 6098.603590766586, 6136.447719705248, 6199.659018754011, 6216.533759968111, 5513.338399392099, 6034.63792172471, 6066.787662431793, 6084.330723620486, 6107.755689772359, 6152.538559607958, 6163.722632481638, 6169.907451388322, 6179.536534760001, 6195.721192546436, 5084.720340381315, 5653.915191272216, 5743.798967036134, 5944.732487038007, 6015.368386319374], "value": 4525.401713217585, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.3963350968436, 855.2601999270632, 855.824555966027, 855.8887344645198, 872.4198408058639, 12955.805662915052, 17903.46289611312, 18614.62770744584, 18632.441026769186, 18669.346572869952, 16070.035797852137, 16082.758758618631, 16117.919410402961, 16154.515364539053, 16172.11053392063, 958.650092716157, 970.0445061614304, 991.0584944302905, 1013.7262939006464, 1020.9994205678439, 1021.8211812932744, 1021.887592364843, 1022.616518805448, 1022.667633019268, 1025.5538840604324, 1030.5414090729628, 1032.0814475117152, 1033.1115240892825, 1035.0063938618935, 1071.9892801072006, 1028.4035259549444, 1030.5465595138114, 1032.9431881246528, 1033.4316126130598, 1069.0058245831374, 767.6161919040479, 769.0732667136087, 770.818857568471, 779.5128044971892, 806.7418426103649, 13831.377588008563, 15035.699286014327, 15917.044977301282, 16033.599160020976, 17080.06059666718, 16824.15879206035, 16954.491365259062, 17124.40064597733, 17252.05113718745, 17367.565810854703, 12123.272603643722, 13936.790948135786, 13938.163710177421, 13939.372728227254, 13987.65030874226, 3493.510908472816, 3521.6126226115107, 3521.7358698097487, 3527.3650742866275, 3529.135361836341, 137308.0, 138664.61335386618, 138677.0, 139293.0, 140831.0, 10398.740031499274, 11006.394648294261, 12839.422225999853, 13150.342482875818, 13166.946644268628, 19190.232390704496, 25075.247742567753, 25124.87437562837, 25215.117470888432, 25267.0, 7815.726449574237, 7958.602069896598, 7962.482438641586, 7967.123616402191, 7975.641096150687, 3827.9808600956817, 3873.32216862048, 3876.8517686076193, 3942.743721658083, 3945.7237993340764, 4273.957260427356, 4336.913261734748, 4356.825726970949, 4369.628581570602, 4375.518692943773, 877.9017065384479, 909.2587694564967, 914.7392992996964, 917.7384445433153, 918.3296193778446, 561.4638020690231, 644.2076246217179, 649.1560970738021, 665.6904539389208, 686.4131167851515, 10754.946225268823, 11007.449627518592, 11840.644780656594, 11896.014695311958, 12108.939455302843, 506.6959824105581, 629.2417636747708, 646.9906945165557, 648.6367634124905, 674.9673000309534, 5330.951157068953, 5516.806911758069, 5518.530924871431, 5617.43825617435, 5656.981743286248, 111433.44283278694, 112323.0, 112987.0, 115883.42058289655, 117103.53309369361, 92494.0, 95201.52399238099, 95592.0, 96065.51967240119, 97304.02695973091, 85041.14958850456, 86766.83082922851, 87400.56299718587, 87984.0, 88119.67820482698, 10761.408122553335, 11160.330380177214, 11184.552617895193, 11288.43557822122, 11335.433228338716, 31880.84059579687, 41198.38202426906, 41909.58090419057, 41955.95110122149, 42324.0, 54084.0, 54532.0, 55004.72497637646, 55226.0, 55726.44273557213, 13612.86387136116, 13745.24401157906, 14151.575452736435, 14167.008309418241, 14220.786688199893, 15310.923445382701, 15446.459373921858, 15559.988600740915, 15602.219889005277, 15661.0, 12013.519459221534, 12152.088593355356, 12308.815367769312, 12443.688907777378, 12455.190412623151, 14102.717945641234, 14254.144751314954, 14513.129212247299, 14594.489192878198, 14598.197099159648, 11711.590094346657, 13954.441822327399, 14101.929490352482, 14127.505537306144, 14266.144031358152, 10460.947695261475, 10545.050945414949, 10844.728881778019, 10949.069329107115, 11063.0, 11377.715557111138, 11735.941320293345, 11768.352740599006, 11831.40842957866, 11924.344161070878], "value": 8089.529563065602, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1441.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 110.0, 111.0, 111.0, 110.0, 111.0, 111.0, 111.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 104.0, 107.0, 151.0, 123.0, 138.0, 110.0, 107.0, 133.0, 107.0], "value": 121.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 184.0, 184.0, 186.0, 183.0, 183.0, 182.0, 181.0, 181.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 61.0, 87.0, 61.0, 60.0, 77.0, 88.0, 96.0, 58.0], "value": 73.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 85.0, 69.0, 69.0, 69.0, 90.0, 69.0, 68.0, 97.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 87.0, 87.0, 88.0, 87.0, 87.0, 87.0, 87.0, 86.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 93.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 85.0, 84.0, 84.0, 85.0, 83.0, 83.0, 86.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 48.0, 46.0, 47.0, 48.0, 50.0, 48.0, 50.0, 47.0], "value": 48.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 60.0, 57.0, 67.0, 62.0, 59.0, 60.0, 57.0, 57.0, 57.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 82.0, 80.0, 83.0, 82.0, 81.0, 82.0, 79.0, 81.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 134.0, 133.0, 134.0, 136.0, 138.0, 146.0, 176.0, 158.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 180.0, 205.0, 227.0, 232.0, 184.0, 183.0, 183.0, 185.0, 199.0], "value": 195.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 84.0, 96.0, 90.0, 66.0, 57.0, 91.0, 92.0, 94.0, 89.0], "value": 82.8, "unit": "score"}]}]} 05:09:40 INFO - Return code: 0 05:09:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:09:40 ERROR - # TBPL SUCCESS # 05:09:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:09:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:09:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:09:40 INFO - 2017-04-25 05:09:40.823 screenresolution[1650:9791] starting screenresolution argv=screenresolution get 05:09:40 INFO - 2017-04-25 05:09:40.825 screenresolution[1650:9791] Display 0: 1600x1200x32@60 05:09:40 INFO - 2017-04-25 05:09:40.832 screenresolution[1651:9794] starting screenresolution argv=screenresolution list 05:09:40 INFO - Available Modes on Display 0 05:09:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:09:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:09:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:09:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:09:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:09:41 INFO - Intel Iris: 05:09:41 INFO - Chipset Model: Intel Iris 05:09:41 INFO - Type: GPU 05:09:41 INFO - Bus: Built-In 05:09:41 INFO - VRAM (Dynamic, Max): 1536 MB 05:09:41 INFO - Vendor: Intel (0x8086) 05:09:41 INFO - Device ID: 0x0a2e 05:09:41 INFO - Revision ID: 0x0009 05:09:41 INFO - Displays: 05:09:41 INFO - Display: 05:09:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:09:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:09:41 INFO - Display Serial Number: 1600x1200 60 05:09:41 INFO - Main Display: Yes 05:09:41 INFO - Mirror: Off 05:09:41 INFO - Online: Yes 05:09:41 INFO - Rotation: Supported 05:09:41 INFO - Return code: 0 05:09:41 INFO - Running post-action listener: _resource_record_post_action 05:09:41 INFO - [mozharness: 2017-04-25 12:09:41.078010Z] Finished run-tests step (success) 05:09:41 INFO - Running post-run listener: _resource_record_post_run 05:09:41 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 37798912; Write bytes: 512993280; Read time: 245; Write time: 1588 05:09:41 INFO - TinderboxPrint: CPU usage
53.4% 05:09:41 INFO - TinderboxPrint: I/O read bytes / time
37,798,912 / 245 05:09:41 INFO - TinderboxPrint: I/O write bytes / time
512,993,280 / 1,588 05:09:41 INFO - TinderboxPrint: CPU idle
2,236.4 (46.6%) 05:09:41 INFO - TinderboxPrint: CPU system
957.1 (20.0%) 05:09:41 INFO - TinderboxPrint: CPU user
1,604.1 (33.4%) 05:09:41 INFO - TinderboxPrint: Swap in / out
246,280,192 / 0 05:09:41 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208146944; Write bytes: 206694400; Read time: 15776; Write time: 437 05:09:41 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 33940480; Write bytes: 299008000; Read time: 219; Write time: 1121 05:09:41 INFO - Running post-run listener: _upload_blobber_files 05:09:41 INFO - Blob upload gear active. 05:09:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:09:41 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 05:09:41 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'] 05:09:41 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 05:09:41 INFO - (blobuploader) - INFO - Open directory for files ... 05:09:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:09:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:09:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:43 INFO - (blobuploader) - INFO - Done attempting. 05:09:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:09:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:09:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:44 INFO - (blobuploader) - INFO - Done attempting. 05:09:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:09:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:09:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:45 INFO - (blobuploader) - INFO - Done attempting. 05:09:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:09:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:09:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:47 INFO - (blobuploader) - INFO - Done attempting. 05:09:47 INFO - (blobuploader) - INFO - Iteration through files over. 05:09:47 INFO - Return code: 0 05:09:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:09:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:09:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c6e4516a258ce2d456d5c23681d63d7a450d22b892d3f0682dfa93992108bd4e4aae59134767e63f8d8da97514569b89515a917f835d8fb9876cf99d421c459", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71a20a7fb2dce38a6f5ad7183081edec30b0204b94870d8bddcfe5113928a76def9926a2f255ac1cf887399a770855058372e66db67d00ad4ae542fd5d44a16f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69aad4d69f2f54192cfa4950583e0d5747157a5e2932e35f87e5cb2c85fd6d305500ae988e2fa3e355a4c3323faf42110939dda2f2bc4998ce87f613ec94680e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9afa9d77ca9b1849fbb4bae0857ce2b58d53419117218b28d1995a42f2e05669b9226893c77b60b5e460769fa8d4949425b930ae34d3a5820f2d39159678466c"} 05:09:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:09:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:09:47 INFO - Contents: 05:09:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c6e4516a258ce2d456d5c23681d63d7a450d22b892d3f0682dfa93992108bd4e4aae59134767e63f8d8da97514569b89515a917f835d8fb9876cf99d421c459", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71a20a7fb2dce38a6f5ad7183081edec30b0204b94870d8bddcfe5113928a76def9926a2f255ac1cf887399a770855058372e66db67d00ad4ae542fd5d44a16f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69aad4d69f2f54192cfa4950583e0d5747157a5e2932e35f87e5cb2c85fd6d305500ae988e2fa3e355a4c3323faf42110939dda2f2bc4998ce87f613ec94680e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9afa9d77ca9b1849fbb4bae0857ce2b58d53419117218b28d1995a42f2e05669b9226893c77b60b5e460769fa8d4949425b930ae34d3a5820f2d39159678466c"} 05:09:47 INFO - Running post-run listener: copy_logs_to_upload_dir 05:09:47 INFO - Copying logs to upload dir... 05:09:47 INFO - mkdir: /builds/slave/test/build/upload/logs 05:09:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.573605 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-25 05:09:47.913557) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 05:09:47.917313) ========= 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.CanPpGoivq/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.cy0yw0TnnV/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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/9c6e4516a258ce2d456d5c23681d63d7a450d22b892d3f0682dfa93992108bd4e4aae59134767e63f8d8da97514569b89515a917f835d8fb9876cf99d421c459", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71a20a7fb2dce38a6f5ad7183081edec30b0204b94870d8bddcfe5113928a76def9926a2f255ac1cf887399a770855058372e66db67d00ad4ae542fd5d44a16f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69aad4d69f2f54192cfa4950583e0d5747157a5e2932e35f87e5cb2c85fd6d305500ae988e2fa3e355a4c3323faf42110939dda2f2bc4998ce87f613ec94680e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9afa9d77ca9b1849fbb4bae0857ce2b58d53419117218b28d1995a42f2e05669b9226893c77b60b5e460769fa8d4949425b930ae34d3a5820f2d39159678466c"} build_url:https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010844 build_url: 'https://queue.taskcluster.net/v1/task/aVs99-NZQhCOqZGTsuMEBw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c6e4516a258ce2d456d5c23681d63d7a450d22b892d3f0682dfa93992108bd4e4aae59134767e63f8d8da97514569b89515a917f835d8fb9876cf99d421c459", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71a20a7fb2dce38a6f5ad7183081edec30b0204b94870d8bddcfe5113928a76def9926a2f255ac1cf887399a770855058372e66db67d00ad4ae542fd5d44a16f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69aad4d69f2f54192cfa4950583e0d5747157a5e2932e35f87e5cb2c85fd6d305500ae988e2fa3e355a4c3323faf42110939dda2f2bc4998ce87f613ec94680e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9afa9d77ca9b1849fbb4bae0857ce2b58d53419117218b28d1995a42f2e05669b9226893c77b60b5e460769fa8d4949425b930ae34d3a5820f2d39159678466c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 05:09:47.958968) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 05:09:47.959534) ========= 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.CanPpGoivq/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.cy0yw0TnnV/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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.005164 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 05:09:48.011543) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 05:09:48.012059) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 05:09:48.012574) ========= ========= Total master_lag: 0.21 =========