builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0081 starttime: 1493722473.66 results: success (0) buildid: 20170502020521 builduid: 49c1ac31e280463b96c8898c098a62a7 revision: 48c0fd9c9ec5d68061ea7b59358874ae8da72572 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:33.663939) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:33.664444) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:33.664716) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:33.693601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:33.694046) ========= 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.lyEgk1BY6z/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.8ZUUZpHz7K/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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-05-02 03:54:33-- 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% 14.0M=0.001s 2017-05-02 03:54:33 (14.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135440 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:33.854823) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:33.855166) ========= 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.lyEgk1BY6z/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.8ZUUZpHz7K/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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.028697 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:33.907047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:33.907398) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 48c0fd9c9ec5d68061ea7b59358874ae8da72572 --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 48c0fd9c9ec5d68061ea7b59358874ae8da72572 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lyEgk1BY6z/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.8ZUUZpHz7K/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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-05-02 03:54:34,001 truncating revision to first 12 chars 2017-05-02 03:54:34,001 Setting DEBUG logging. 2017-05-02 03:54:34,001 attempt 1/10 2017-05-02 03:54:34,001 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/48c0fd9c9ec5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-02 03:54:34,337 unpacking tar archive at: mozilla-central-48c0fd9c9ec5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600182 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:34.532170) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:34.532564) ========= script_repo_revision: 48c0fd9c9ec5d68061ea7b59358874ae8da72572 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:34.533021) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:34.533391) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 03:54:34.554463) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-05-02 03:54:34.554851) ========= /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.lyEgk1BY6z/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.8ZUUZpHz7K/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 03:54:34 INFO - MultiFileLogger online at 20170502 03:54:34 in /builds/slave/test 03:54:34 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 03:54:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:54:34 INFO - {'append_to_log': False, 03:54:34 INFO - 'base_work_dir': '/builds/slave/test', 03:54:34 INFO - 'blob_upload_branch': 'Firefox', 03:54:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:54:34 INFO - 'branch': 'Firefox', 03:54:34 INFO - 'buildbot_json_path': 'buildprops.json', 03:54:34 INFO - 'config_files': ('talos/mac_config.py',), 03:54:34 INFO - 'default_actions': ('clobber', 03:54:34 INFO - 'read-buildbot-config', 03:54:34 INFO - 'download-and-extract', 03:54:34 INFO - 'populate-webroot', 03:54:34 INFO - 'create-virtualenv', 03:54:34 INFO - 'install', 03:54:34 INFO - 'run-tests'), 03:54:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:54:34 INFO - 'download_minidump_stackwalk': True, 03:54:34 INFO - 'download_symbols': 'ondemand', 03:54:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:54:34 INFO - 'tooltool.py': '/tools/tooltool.py', 03:54:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:54:34 INFO - '/tools/misc-python/virtualenv.py')}, 03:54:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:54:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:54:34 INFO - 'gecko_profile': False, 03:54:34 INFO - 'gecko_profile_interval': 0, 03:54:34 INFO - 'installer_path': 'installer.exe', 03:54:34 INFO - 'log_level': 'info', 03:54:34 INFO - 'log_name': 'talos', 03:54:34 INFO - 'log_to_console': True, 03:54:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:54:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:54:34 INFO - 'opt_config_files': (), 03:54:34 INFO - 'pip_index': False, 03:54:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:54:34 INFO - 'cmd': ('bash', 03:54:34 INFO - '-c', 03:54:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:54:34 INFO - 'enabled': True, 03:54:34 INFO - 'halt_on_failure': False, 03:54:34 INFO - 'name': 'check_screen_resolution'},), 03:54:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:54:34 INFO - 'cmd': ('bash', 03:54:34 INFO - '-c', 03:54:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:54:34 INFO - 'enabled': True, 03:54:34 INFO - 'halt_on_failure': False, 03:54:34 INFO - 'name': 'check_screen_resolution'},), 03:54:34 INFO - 'run_cmd_checks_enabled': True, 03:54:34 INFO - 'suite': 'dromaeojs', 03:54:34 INFO - 'system_bits': '32', 03:54:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:54:34 INFO - 'title': 't-yosemite-r7-0081', 03:54:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:54:34 INFO - 'use_talos_json': True, 03:54:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:54:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:54:34 INFO - 'work_dir': 'build'} 03:54:34 INFO - [mozharness: 2017-05-02 10:54:34.758004Z] Running clobber step. 03:54:34 INFO - Running pre-action listener: _resource_record_pre_action 03:54:34 INFO - Running main action method: clobber 03:54:34 INFO - rmtree: /builds/slave/test/build 03:54:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:54:37 INFO - Running post-action listener: _resource_record_post_action 03:54:37 INFO - [mozharness: 2017-05-02 10:54:37.435903Z] Finished clobber step (success) 03:54:37 INFO - [mozharness: 2017-05-02 10:54:37.436032Z] Running read-buildbot-config step. 03:54:37 INFO - Running pre-action listener: _resource_record_pre_action 03:54:37 INFO - Running main action method: read_buildbot_config 03:54:37 INFO - Using buildbot properties: 03:54:37 INFO - { 03:54:37 INFO - "project": "", 03:54:37 INFO - "product": "firefox", 03:54:37 INFO - "script_repo_revision": "production", 03:54:37 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:54:37 INFO - "repository": "", 03:54:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:54:37 INFO - "buildid": "20170502020521", 03:54:37 INFO - "pgo_build": "False", 03:54:37 INFO - "basedir": "/builds/slave/test", 03:54:37 INFO - "buildnumber": 30, 03:54:37 INFO - "slavename": "t-yosemite-r7-0081", 03:54:37 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:54:37 INFO - "platform": "yosemite_r7", 03:54:37 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:54:37 INFO - "branch": "mozilla-central", 03:54:37 INFO - "repo_path": "mozilla-central", 03:54:37 INFO - "revision": "48c0fd9c9ec5d68061ea7b59358874ae8da72572", 03:54:37 INFO - "stage_platform": "macosx64", 03:54:37 INFO - "builduid": "49c1ac31e280463b96c8898c098a62a7", 03:54:37 INFO - "slavebuilddir": "test" 03:54:37 INFO - } 03:54:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:54:37 INFO - Running post-action listener: _resource_record_post_action 03:54:37 INFO - [mozharness: 2017-05-02 10:54:37.439452Z] Finished read-buildbot-config step (success) 03:54:37 INFO - [mozharness: 2017-05-02 10:54:37.439553Z] Running download-and-extract step. 03:54:37 INFO - Running pre-action listener: _resource_record_pre_action 03:54:37 INFO - Running main action method: download_and_extract 03:54:37 INFO - mkdir: /builds/slave/test/build/tests 03:54:37 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')]} 03:54:37 INFO - trying https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:54:37 INFO - Downloading https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/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 03:54:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/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 03:54:38 INFO - Downloaded 1325 bytes. 03:54:38 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:54:38 INFO - Using the following test package requirements: 03:54:38 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:38 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:54:38 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:54:38 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:38 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:54:38 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:38 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:54:38 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:38 INFO - u'jsshell-mac.zip'], 03:54:38 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:38 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:54:38 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:54:38 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:38 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:54:38 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:38 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:54:38 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:38 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:54:38 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:54:38 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:54:38 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:54:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:54:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:54:38 INFO - Fetch https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:54:39 INFO - Content-Length response header: 52702499 03:54:39 INFO - Bytes received: 52702499 03:54:56 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 03:54:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:54:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:54:56 INFO - Fetch https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:54:58 INFO - Content-Length response header: 52702499 03:54:58 INFO - Bytes received: 52702499 03:55:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:55:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:55:14 INFO - Fetch https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:55:15 INFO - Content-Length response header: 14408811 03:55:15 INFO - Bytes received: 14408811 03:55:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:15 INFO - trying https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:55:15 INFO - Downloading https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:55:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/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 03:55:17 INFO - Downloaded 71249407 bytes. 03:55:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:55:17 INFO - mkdir: /builds/slave/test/properties 03:55:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:55:17 INFO - Writing to file /builds/slave/test/properties/build_url 03:55:17 INFO - Contents: 03:55:17 INFO - build_url:https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:55:18 INFO - Running post-action listener: _resource_record_post_action 03:55:18 INFO - Running post-action listener: set_extra_try_arguments 03:55:18 INFO - [mozharness: 2017-05-02 10:55:18.218084Z] Finished download-and-extract step (success) 03:55:18 INFO - [mozharness: 2017-05-02 10:55:18.218215Z] Running populate-webroot step. 03:55:18 INFO - Running pre-action listener: _resource_record_pre_action 03:55:18 INFO - Running main action method: populate_webroot 03:55:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:55:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:55:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:55:18 INFO - '--tppagecycles', 03:55:18 INFO - '7'], 03:55:18 INFO - 'tests': ['tsvgm']}}, 03:55:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:55:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:55:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:55:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:55:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:55:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:55:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:55:18 INFO - 'talos_options': ['--disable-e10s'], 03:55:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:55:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:55:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:55:18 INFO - 'talos_options': ['--disable-e10s'], 03:55:18 INFO - 'tests': ['damp', 'tps']}, 03:55:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:55:18 INFO - 'tests': ['damp', 'tps']}, 03:55:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:55:18 INFO - 'tests': ['dromaeo_dom']}, 03:55:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:55:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:55:18 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:55:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:55:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:55:18 INFO - 'tests': ['a11yr', 03:55:18 INFO - 'ts_paint', 03:55:18 INFO - 'tpaint', 03:55:18 INFO - 'sessionrestore', 03:55:18 INFO - 'sessionrestore_no_auto_restore', 03:55:18 INFO - 'tabpaint']}, 03:55:18 INFO - 'other-e10s': {'tests': ['a11yr', 03:55:18 INFO - 'ts_paint', 03:55:18 INFO - 'tpaint', 03:55:18 INFO - 'sessionrestore', 03:55:18 INFO - 'sessionrestore_no_auto_restore', 03:55:18 INFO - 'tabpaint']}, 03:55:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:55:18 INFO - 'ts_paint', 03:55:18 INFO - 'tpaint', 03:55:18 INFO - 'sessionrestore', 03:55:18 INFO - 'sessionrestore_no_auto_restore', 03:55:18 INFO - 'tabpaint']}, 03:55:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:55:18 INFO - 'ts_paint', 03:55:18 INFO - 'tpaint', 03:55:18 INFO - 'sessionrestore', 03:55:18 INFO - 'sessionrestore_no_auto_restore', 03:55:18 INFO - 'tabpaint']}, 03:55:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:55:18 INFO - 'tests': ['a11yr', 03:55:18 INFO - 'ts_paint', 03:55:18 INFO - 'tpaint', 03:55:18 INFO - 'sessionrestore', 03:55:18 INFO - 'sessionrestore_no_auto_restore', 03:55:18 INFO - 'tabpaint']}, 03:55:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:55:18 INFO - 'tests': ['a11yr', 03:55:18 INFO - 'ts_paint', 03:55:18 INFO - 'tpaint', 03:55:18 INFO - 'sessionrestore', 03:55:18 INFO - 'sessionrestore_no_auto_restore', 03:55:18 INFO - 'tabpaint']}, 03:55:18 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:55:18 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:55:18 INFO - 'bloom_basic_ref']}, 03:55:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:55:18 INFO - 'tests': ['tsvgx', 03:55:18 INFO - 'tsvgr_opacity', 03:55:18 INFO - 'tart', 03:55:18 INFO - 'tscrollx', 03:55:18 INFO - 'cart', 03:55:18 INFO - 'tsvg_static']}, 03:55:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:55:18 INFO - 'tsvgr_opacity', 03:55:18 INFO - 'tart', 03:55:18 INFO - 'tscrollx', 03:55:18 INFO - 'cart', 03:55:18 INFO - 'tsvg_static']}, 03:55:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:55:18 INFO - 'talos_options': ['--disable-e10s'], 03:55:18 INFO - 'tests': ['tp5o']}, 03:55:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:55:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:55:18 INFO - 'talos_options': ['--disable-e10s', 03:55:18 INFO - '--xperf_path', 03:55:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:18 INFO - 'tests': ['tp5n']}, 03:55:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:55:18 INFO - 'talos_options': ['--xperf_path', 03:55:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:55:18 INFO - 'tests': ['tp5n']}}, 03:55:18 INFO - 'talos.zip': {'path': '', 03:55:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:55:18 INFO - Running post-action listener: _resource_record_post_action 03:55:18 INFO - [mozharness: 2017-05-02 10:55:18.237237Z] Finished populate-webroot step (success) 03:55:18 INFO - [mozharness: 2017-05-02 10:55:18.237366Z] Running create-virtualenv step. 03:55:18 INFO - Running pre-action listener: _resource_record_pre_action 03:55:18 INFO - Running main action method: create_virtualenv 03:55:18 INFO - Creating virtualenv /builds/slave/test/build/venv 03:55:18 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 03:55:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:55:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:55:18 INFO - Using real prefix '/tools/python27' 03:55:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:55:19 INFO - Installing distribute.............................................................................................................................................................................................done. 03:55:21 INFO - Installing pip.................done. 03:55:21 INFO - Return code: 0 03:55:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:55:22 INFO - Reading from file tmpfile_stdout 03:55:22 INFO - Output received: 03:55:22 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) 03:55:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:55:22 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')]} 03:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:22 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')]} 03:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:22 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 0x10381db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103820768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc79946b1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035fbd30>, '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 0x103521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f0be8>, '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.lyEgk1BY6z/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.8ZUUZpHz7K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 03:55:22 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 03:55:22 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 03:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyEgk1BY6z/Render', 03:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:22 INFO - 'HOME': '/Users/cltbld', 03:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:22 INFO - 'LOGNAME': 'cltbld', 03:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:22 INFO - 'MOZ_NO_REMOTE': '1', 03:55:22 INFO - 'NO_EM_RESTART': '1', 03:55:22 INFO - 'PAGER': '/bin/cat', 03:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:22 INFO - 'PWD': '/builds/slave/test', 03:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:22 INFO - 'SHELL': '/bin/bash', 03:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ZUUZpHz7K/Listeners', 03:55:22 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 03:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:22 INFO - 'USER': 'cltbld', 03:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:22 INFO - 'XPC_FLAGS': '0x0', 03:55:22 INFO - 'XPC_SERVICE_NAME': '0', 03:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:22 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 03:55:22 INFO - Cleaning up... 03:55:22 INFO - Return code: 0 03:55:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:55:22 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')]} 03:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:22 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')]} 03:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:22 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 0x10381db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103820768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc79946b1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035fbd30>, '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 0x103521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f0be8>, '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.lyEgk1BY6z/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.8ZUUZpHz7K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 03:55:22 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 03:55:22 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 03:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyEgk1BY6z/Render', 03:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:22 INFO - 'HOME': '/Users/cltbld', 03:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:22 INFO - 'LOGNAME': 'cltbld', 03:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:22 INFO - 'MOZ_NO_REMOTE': '1', 03:55:22 INFO - 'NO_EM_RESTART': '1', 03:55:22 INFO - 'PAGER': '/bin/cat', 03:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:22 INFO - 'PWD': '/builds/slave/test', 03:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:22 INFO - 'SHELL': '/bin/bash', 03:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ZUUZpHz7K/Listeners', 03:55:22 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 03:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:22 INFO - 'USER': 'cltbld', 03:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:22 INFO - 'XPC_FLAGS': '0x0', 03:55:22 INFO - 'XPC_SERVICE_NAME': '0', 03:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:22 INFO - Downloading/unpacking psutil>=3.1.1 03:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:55:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:55:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:55:26 INFO - Installing collected packages: psutil 03:55:26 INFO - Running setup.py install for psutil 03:55:26 INFO - building 'psutil._psutil_osx' extension 03:55:26 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 03:55:27 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 03:55:27 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 03:55:27 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 03:55:27 INFO - building 'psutil._psutil_posix' extension 03:55:27 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 03:55:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:55:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:55:27 INFO - ^ 03:55:27 INFO - 1 warning generated. 03:55:27 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 03:55:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:55:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:55:27 INFO - Successfully installed psutil 03:55:27 INFO - Cleaning up... 03:55:27 INFO - Return code: 0 03:55:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:55: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')]} 03:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55: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')]} 03:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:27 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 0x10381db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103820768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc79946b1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035fbd30>, '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 0x103521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f0be8>, '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.lyEgk1BY6z/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.8ZUUZpHz7K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 03:55:27 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 03:55:27 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 03:55:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyEgk1BY6z/Render', 03:55:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:27 INFO - 'HOME': '/Users/cltbld', 03:55:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:27 INFO - 'LOGNAME': 'cltbld', 03:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:27 INFO - 'MOZ_NO_REMOTE': '1', 03:55:27 INFO - 'NO_EM_RESTART': '1', 03:55:27 INFO - 'PAGER': '/bin/cat', 03:55:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:27 INFO - 'PWD': '/builds/slave/test', 03:55:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:27 INFO - 'SHELL': '/bin/bash', 03:55:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ZUUZpHz7K/Listeners', 03:55:27 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 03:55:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:27 INFO - 'USER': 'cltbld', 03:55:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:27 INFO - 'XPC_FLAGS': '0x0', 03:55:27 INFO - 'XPC_SERVICE_NAME': '0', 03:55:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:55:27 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 03:55:27 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 03:55:27 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 03:55:27 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 03:55:27 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 03:55:27 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 03:55:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:55:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:55:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:55:30 INFO - Installing collected packages: mozsystemmonitor 03:55:30 INFO - Running setup.py install for mozsystemmonitor 03:55:30 INFO - Successfully installed mozsystemmonitor 03:55:30 INFO - Cleaning up... 03:55:30 INFO - Return code: 0 03:55:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:55: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')]} 03:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10381db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103820768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc79946b1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035fbd30>, '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 0x103521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f0be8>, '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.lyEgk1BY6z/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.8ZUUZpHz7K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 03:55:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:55:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyEgk1BY6z/Render', 03:55:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:31 INFO - 'HOME': '/Users/cltbld', 03:55:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:31 INFO - 'LOGNAME': 'cltbld', 03:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:31 INFO - 'MOZ_NO_REMOTE': '1', 03:55:31 INFO - 'NO_EM_RESTART': '1', 03:55:31 INFO - 'PAGER': '/bin/cat', 03:55:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:31 INFO - 'PWD': '/builds/slave/test', 03:55:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:31 INFO - 'SHELL': '/bin/bash', 03:55:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ZUUZpHz7K/Listeners', 03:55:31 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 03:55:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:31 INFO - 'USER': 'cltbld', 03:55:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:31 INFO - 'XPC_FLAGS': '0x0', 03:55:31 INFO - 'XPC_SERVICE_NAME': '0', 03:55:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:31 INFO - Downloading/unpacking jsonschema==2.5.1 03:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:55:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:55:35 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 03:55:35 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 03:55:35 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 03:55:35 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 03:55:35 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 03:55:35 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 03:55:35 INFO - Downloading functools32-3.2.3-2.tar.gz 03:55:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:55:36 INFO - warning: no files found matching '*.txt' 03:55:36 INFO - no previously-included directories found matching 'build' 03:55:36 INFO - no previously-included directories found matching 'dist' 03:55:36 INFO - no previously-included directories found matching '.git*' 03:55:36 INFO - Installing collected packages: jsonschema, functools32 03:55:36 INFO - Running setup.py install for functools32 03:55:36 INFO - warning: no files found matching '*.txt' 03:55:36 INFO - no previously-included directories found matching 'build' 03:55:36 INFO - no previously-included directories found matching 'dist' 03:55:36 INFO - no previously-included directories found matching '.git*' 03:55:36 INFO - Successfully installed jsonschema functools32 03:55:36 INFO - Cleaning up... 03:55:36 INFO - Return code: 0 03:55:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10381db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103820768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc79946b1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035fbd30>, '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 0x103521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f0be8>, '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.lyEgk1BY6z/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.8ZUUZpHz7K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 03:55:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:55:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:55:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyEgk1BY6z/Render', 03:55:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:36 INFO - 'HOME': '/Users/cltbld', 03:55:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:36 INFO - 'LOGNAME': 'cltbld', 03:55:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:36 INFO - 'MOZ_NO_REMOTE': '1', 03:55:36 INFO - 'NO_EM_RESTART': '1', 03:55:36 INFO - 'PAGER': '/bin/cat', 03:55:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:36 INFO - 'PWD': '/builds/slave/test', 03:55:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:36 INFO - 'SHELL': '/bin/bash', 03:55:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ZUUZpHz7K/Listeners', 03:55:36 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 03:55:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:36 INFO - 'USER': 'cltbld', 03:55:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:36 INFO - 'XPC_FLAGS': '0x0', 03:55:36 INFO - 'XPC_SERVICE_NAME': '0', 03:55:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:55:36 INFO - Cleaning up... 03:55:36 INFO - Return code: 0 03:55:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10381db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103820768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc79946b1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035fbd30>, '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 0x103521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f0be8>, '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.lyEgk1BY6z/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.8ZUUZpHz7K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 03:55:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:55:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:55:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyEgk1BY6z/Render', 03:55:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:36 INFO - 'HOME': '/Users/cltbld', 03:55:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:36 INFO - 'LOGNAME': 'cltbld', 03:55:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:36 INFO - 'MOZ_NO_REMOTE': '1', 03:55:36 INFO - 'NO_EM_RESTART': '1', 03:55:36 INFO - 'PAGER': '/bin/cat', 03:55:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:36 INFO - 'PWD': '/builds/slave/test', 03:55:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:36 INFO - 'SHELL': '/bin/bash', 03:55:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ZUUZpHz7K/Listeners', 03:55:36 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 03:55:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:36 INFO - 'USER': 'cltbld', 03:55:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:36 INFO - 'XPC_FLAGS': '0x0', 03:55:36 INFO - 'XPC_SERVICE_NAME': '0', 03:55:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:36 INFO - Downloading/unpacking blobuploader==1.2.4 03:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:39 INFO - Downloading blobuploader-1.2.4.tar.gz 03:55:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:55:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:55:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:55:40 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 03:55:40 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 03:55:40 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 03:55:40 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 03:55:40 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 03:55:40 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 03:55:40 INFO - Downloading docopt-0.6.1.tar.gz 03:55:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:55:40 INFO - Installing collected packages: blobuploader, requests, docopt 03:55:40 INFO - Running setup.py install for blobuploader 03:55:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:55:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:55:40 INFO - Running setup.py install for requests 03:55:41 INFO - Running setup.py install for docopt 03:55:41 INFO - Successfully installed blobuploader requests docopt 03:55:41 INFO - Cleaning up... 03:55:41 INFO - Return code: 0 03:55:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55: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')]} 03:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55: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')]} 03:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:41 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 0x10381db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103820768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc79946b1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035fbd30>, '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 0x103521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f0be8>, '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.lyEgk1BY6z/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.8ZUUZpHz7K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 03:55:41 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 03:55:41 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 03:55:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyEgk1BY6z/Render', 03:55:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:41 INFO - 'HOME': '/Users/cltbld', 03:55:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:41 INFO - 'LOGNAME': 'cltbld', 03:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:41 INFO - 'MOZ_NO_REMOTE': '1', 03:55:41 INFO - 'NO_EM_RESTART': '1', 03:55:41 INFO - 'PAGER': '/bin/cat', 03:55:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:41 INFO - 'PWD': '/builds/slave/test', 03:55:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:41 INFO - 'SHELL': '/bin/bash', 03:55:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ZUUZpHz7K/Listeners', 03:55:41 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 03:55:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:41 INFO - 'USER': 'cltbld', 03:55:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:41 INFO - 'XPC_FLAGS': '0x0', 03:55:41 INFO - 'XPC_SERVICE_NAME': '0', 03:55:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:55:41 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-VAPur3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:55:42 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-tdJCZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:55:42 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-hcQEpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:55:42 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-MAdfKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:55:42 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-6Gkvyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:55:42 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-HB3VL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:55:42 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-3XqOrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:55:42 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-D828AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:55:42 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-esIyCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:55:42 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-FOQpXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:55:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:55:42 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-_FVrS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:55:43 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-vvJ21E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:55:43 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-8KpBFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:55:43 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-2drZkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:43 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-tAJ_Xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:55:43 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-uzCZLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:55:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:55:43 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-f1vzZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:55:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:55:43 INFO - Running setup.py install for manifestparser 03:55:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:55:43 INFO - Running setup.py install for mozcrash 03:55:43 INFO - Running setup.py install for mozdebug 03:55:44 INFO - Running setup.py install for mozdevice 03:55:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:55:44 INFO - Running setup.py install for mozfile 03:55:44 INFO - Running setup.py install for mozhttpd 03:55:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:55:44 INFO - Running setup.py install for mozinfo 03:55:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:55:44 INFO - Running setup.py install for mozInstall 03:55:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:55:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:55:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:55:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:55:44 INFO - Running setup.py install for mozleak 03:55:44 INFO - Running setup.py install for mozlog 03:55:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:55:45 INFO - Running setup.py install for moznetwork 03:55:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:55:45 INFO - Running setup.py install for mozprocess 03:55:45 INFO - Running setup.py install for mozprofile 03:55:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:55:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:55:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:55:45 INFO - Running setup.py install for mozrunner 03:55:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:55:45 INFO - Running setup.py install for mozscreenshot 03:55:45 INFO - Running setup.py install for moztest 03:55:46 INFO - Running setup.py install for mozversion 03:55:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:55:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:55:46 INFO - Cleaning up... 03:55:46 INFO - Return code: 0 03:55:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55:46 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')]} 03:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:46 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')]} 03:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:46 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 0x10381db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103820768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc79946b1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035fbd30>, '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 0x103521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f0be8>, '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.lyEgk1BY6z/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.8ZUUZpHz7K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 03:55:46 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 03:55:46 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 03:55:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyEgk1BY6z/Render', 03:55:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:46 INFO - 'HOME': '/Users/cltbld', 03:55:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:46 INFO - 'LOGNAME': 'cltbld', 03:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:46 INFO - 'MOZ_NO_REMOTE': '1', 03:55:46 INFO - 'NO_EM_RESTART': '1', 03:55:46 INFO - 'PAGER': '/bin/cat', 03:55:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:46 INFO - 'PWD': '/builds/slave/test', 03:55:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:46 INFO - 'SHELL': '/bin/bash', 03:55:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ZUUZpHz7K/Listeners', 03:55:46 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 03:55:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:46 INFO - 'USER': 'cltbld', 03:55:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:46 INFO - 'XPC_FLAGS': '0x0', 03:55:46 INFO - 'XPC_SERVICE_NAME': '0', 03:55:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:55:46 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-cDIOBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:55:46 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)) 03:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:55:46 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-D_ROyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:55:46 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)) 03:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:55:46 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-exysbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:55:46 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)) 03:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:55:46 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-W0_0nL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:55:46 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)) 03:55:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:55:46 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-g3knyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:55:47 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)) 03:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:55:47 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-_KEgh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:55:47 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)) 03:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:55:47 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-EU9myp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:55:47 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)) 03:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:55:47 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-skRM_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:55:47 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)) 03:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:55:47 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-sMQQMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:55:47 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)) 03:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:55:47 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-G9XAIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:55:47 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)) 03:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:55:47 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-jkmIX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:55:47 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)) 03:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:55:47 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-EePN2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:55:47 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)) 03:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:55:47 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-AZijAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:55:47 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)) 03:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:55:47 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-Knjm_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:55:47 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)) 03:55:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:47 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-dIKL5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:55:48 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)) 03:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:55:48 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-gXLnPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:55:48 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)) 03:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:55:48 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-8ai5WX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:55:48 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)) 03:55:48 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)) 03:55:48 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)) 03:55:48 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)) 03:55:48 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)) 03:55:48 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)) 03:55:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:55:50 INFO - Downloading blessings-1.6.tar.gz 03:55:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:55:50 INFO - Installing collected packages: blessings 03:55:50 INFO - Running setup.py install for blessings 03:55:51 INFO - Successfully installed blessings 03:55:51 INFO - Cleaning up... 03:55:51 INFO - Return code: 0 03:55:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:55:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:55:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:55:51 INFO - Reading from file tmpfile_stdout 03:55:51 INFO - Current package versions: 03:55:51 INFO - blessings == 1.6 03:55:51 INFO - blobuploader == 1.2.4 03:55:51 INFO - docopt == 0.6.1 03:55:51 INFO - functools32 == 3.2.3-2 03:55:51 INFO - jsonschema == 2.5.1 03:55:51 INFO - manifestparser == 1.1 03:55:51 INFO - mozInstall == 1.12 03:55:51 INFO - mozcrash == 1.0 03:55:51 INFO - mozdebug == 0.1 03:55:51 INFO - mozdevice == 0.50 03:55:51 INFO - mozfile == 1.2 03:55:51 INFO - mozhttpd == 0.7 03:55:51 INFO - mozinfo == 0.9 03:55:51 INFO - mozleak == 0.1 03:55:51 INFO - mozlog == 3.4 03:55:51 INFO - moznetwork == 0.27 03:55:51 INFO - mozprocess == 0.25 03:55:51 INFO - mozprofile == 0.28 03:55:51 INFO - mozrunner == 6.13 03:55:51 INFO - mozscreenshot == 0.1 03:55:51 INFO - mozsystemmonitor == 0.3 03:55:51 INFO - moztest == 0.8 03:55:51 INFO - mozversion == 1.4 03:55:51 INFO - psutil == 3.1.1 03:55:51 INFO - requests == 1.2.3 03:55:51 INFO - wsgiref == 0.1.2 03:55:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:51 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 0x10381db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103820768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc79946b1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035fbd30>, '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 0x103521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f0be8>, '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.lyEgk1BY6z/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.8ZUUZpHz7K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 03:55:51 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 03:55:51 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 03:55:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyEgk1BY6z/Render', 03:55:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:51 INFO - 'HOME': '/Users/cltbld', 03:55:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:51 INFO - 'LOGNAME': 'cltbld', 03:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:51 INFO - 'MOZ_NO_REMOTE': '1', 03:55:51 INFO - 'NO_EM_RESTART': '1', 03:55:51 INFO - 'PAGER': '/bin/cat', 03:55:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:51 INFO - 'PWD': '/builds/slave/test', 03:55:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:51 INFO - 'SHELL': '/bin/bash', 03:55:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ZUUZpHz7K/Listeners', 03:55:51 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 03:55:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:51 INFO - 'USER': 'cltbld', 03:55:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:51 INFO - 'XPC_FLAGS': '0x0', 03:55:51 INFO - 'XPC_SERVICE_NAME': '0', 03:55:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:51 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)) 03:55:51 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)) 03:55:51 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)) 03:55:51 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)) 03:55:51 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)) 03:55:51 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)) 03:55:51 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)) 03:55:51 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)) 03:55:51 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)) 03:55:51 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)) 03:55:51 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)) 03:55:51 INFO - Cleaning up... 03:55:51 INFO - Return code: 0 03:55:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:55:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10381db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103820768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc79946b1f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035fbd30>, '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 0x103521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f0be8>, '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.lyEgk1BY6z/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.8ZUUZpHz7K/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 03:55:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:55:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:55:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyEgk1BY6z/Render', 03:55:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:55:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:55:51 INFO - 'HOME': '/Users/cltbld', 03:55:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:55:51 INFO - 'LOGNAME': 'cltbld', 03:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:55:51 INFO - 'MOZ_NO_REMOTE': '1', 03:55:51 INFO - 'NO_EM_RESTART': '1', 03:55:51 INFO - 'PAGER': '/bin/cat', 03:55:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:55:51 INFO - 'PWD': '/builds/slave/test', 03:55:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:55:51 INFO - 'SHELL': '/bin/bash', 03:55:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ZUUZpHz7K/Listeners', 03:55:51 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 03:55:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:55:51 INFO - 'USER': 'cltbld', 03:55:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:55:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:55:51 INFO - 'XPC_FLAGS': '0x0', 03:55:51 INFO - 'XPC_SERVICE_NAME': '0', 03:55:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:55:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:55:52 INFO - Cleaning up... 03:55:52 INFO - Return code: 0 03:55:52 INFO - Running post-action listener: _resource_record_post_action 03:55:52 INFO - Running post-action listener: _start_resource_monitoring 03:55:52 INFO - Starting resource monitoring. 03:55:52 INFO - [mozharness: 2017-05-02 10:55:52.096654Z] Finished create-virtualenv step (success) 03:55:52 INFO - [mozharness: 2017-05-02 10:55:52.097661Z] Running install step. 03:55:52 INFO - Running pre-action listener: _resource_record_pre_action 03:55:52 INFO - Running main action method: install 03:55:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:55:52 INFO - Reading from file tmpfile_stdout 03:55:52 INFO - Detecting whether we're running mozinstall >=1.0... 03:55:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:55:52 INFO - Reading from file tmpfile_stdout 03:55:52 INFO - Output received: 03:55:52 INFO - Usage: mozinstall [options] installer 03:55:52 INFO - Options: 03:55:52 INFO - -h, --help show this help message and exit 03:55:52 INFO - -d DEST, --destination=DEST 03:55:52 INFO - Directory to install application into. [default: 03:55:52 INFO - "/builds/slave/test"] 03:55:52 INFO - --app=APP Application being installed. [default: firefox] 03:55:52 INFO - mkdir: /builds/slave/test/build/application 03:55:52 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'] 03:55:52 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 03:56:12 INFO - Reading from file tmpfile_stdout 03:56:12 INFO - Output received: 03:56:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:56:12 INFO - Running post-action listener: _resource_record_post_action 03:56:12 INFO - [mozharness: 2017-05-02 10:56:12.352416Z] Finished install step (success) 03:56:12 INFO - [mozharness: 2017-05-02 10:56:12.352545Z] Running run-tests step. 03:56:12 INFO - Running pre-action listener: _resource_record_pre_action 03:56:12 INFO - Running main action method: run_tests 03:56:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:56:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:56:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:56:12 INFO - 2017-05-02 03:56:12.367 screenresolution[1626:7448] starting screenresolution argv=screenresolution get 03:56:12 INFO - 2017-05-02 03:56:12.369 screenresolution[1626:7448] Display 0: 1600x1200x32@60 03:56:12 INFO - 2017-05-02 03:56:12.375 screenresolution[1627:7451] starting screenresolution argv=screenresolution list 03:56:12 INFO - Available Modes on Display 0 03:56:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:56:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:56:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:56:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:56:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:56:12 INFO - Intel Iris: 03:56:12 INFO - Chipset Model: Intel Iris 03:56:12 INFO - Type: GPU 03:56:12 INFO - Bus: Built-In 03:56:12 INFO - VRAM (Dynamic, Max): 1536 MB 03:56:12 INFO - Vendor: Intel (0x8086) 03:56:12 INFO - Device ID: 0x0a2e 03:56:12 INFO - Revision ID: 0x0009 03:56:12 INFO - Displays: 03:56:12 INFO - Display: 03:56:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:56:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:56:12 INFO - Display Serial Number: 1600x1200 60 03:56:12 INFO - Main Display: Yes 03:56:12 INFO - Mirror: Off 03:56:12 INFO - Online: Yes 03:56:12 INFO - Rotation: Supported 03:56:12 INFO - Return code: 0 03:56:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:56:12 INFO - Python 2.7.3 03:56:12 INFO - Return code: 0 03:56:12 INFO - grabbing minidump binary from tooltool 03:56: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')]} 03:56:12 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 0x1035fbd30>, '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 0x103521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035f0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:56:12 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 03:56:12 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 03:56:12 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 03:56:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:56:12 INFO - Return code: 0 03:56:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:56:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:56:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:56:12 INFO - ENV: RUST_BACKTRACE is now 1 03:56:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:56:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:56:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0081', '--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 03:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0081 --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 03:56:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lyEgk1BY6z/Render', 03:56:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:56:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:56:12 INFO - 'HOME': '/Users/cltbld', 03:56:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:56:12 INFO - 'LOGNAME': 'cltbld', 03:56:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:56:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:56:12 INFO - 'MOZ_NO_REMOTE': '1', 03:56:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:56:12 INFO - 'NO_EM_RESTART': '1', 03:56:12 INFO - 'PAGER': '/bin/cat', 03:56:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:56:12 INFO - 'PWD': '/builds/slave/test', 03:56:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:56:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:56:12 INFO - 'RUST_BACKTRACE': '1', 03:56:12 INFO - 'SHELL': '/bin/bash', 03:56:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8ZUUZpHz7K/Listeners', 03:56:12 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 03:56:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:56:12 INFO - 'USER': 'cltbld', 03:56:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:56:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:56:12 INFO - 'XPC_FLAGS': '0x0', 03:56:12 INFO - 'XPC_SERVICE_NAME': '0', 03:56:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:56:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0081', '--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 03:56:12 INFO - mozversion application_buildid: 20170502020521 03:56:12 INFO - mozversion application_changeset: 48c0fd9c9ec5d68061ea7b59358874ae8da72572 03:56:12 INFO - mozversion application_display_name: Nightly 03:56:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:56:12 INFO - mozversion application_name: Firefox 03:56:12 INFO - mozversion application_remotingname: firefox 03:56:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:56:12 INFO - mozversion application_vendor: Mozilla 03:56:12 INFO - mozversion application_version: 55.0a1 03:56:12 INFO - mozversion platform_buildid: 20170502020521 03:56:12 INFO - mozversion platform_changeset: 48c0fd9c9ec5d68061ea7b59358874ae8da72572 03:56:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:56:12 INFO - mozversion platform_version: 55.0a1 03:56:12 INFO - using testdate: 1493722572 03:56:12 INFO - actual date: 1493722572 03:56:12 INFO - starting webserver on 'localhost:49237' 03:56:12 INFO - SUITE-START | Running 2 tests 03:56:12 INFO - TEST-START | dromaeo_css 03:56:12 INFO - operating with platform_type : mac_ 03:56:12 INFO - Initialising browser for dromaeo_css test... 03:56:12 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpRyZpZj/profile http://localhost:49237/getInfo.html) 03:56:15 INFO - PID 1637 | __metrics Screen width/height:1600/1200 03:56:15 INFO - PID 1637 | colorDepth:24 03:56:15 INFO - PID 1637 | Browser inner width/height: 1024/689 03:56:15 INFO - PID 1637 | __metrics 03:56:15 INFO - PID 1637 | 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" 03:56:15 INFO - PID 1637 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:56:16 INFO - TEST-INFO | 1637: exit 0 03:56:16 INFO - Browser initialized. 03:56:16 INFO - Running cycle 1/1 for dromaeo_css test... 03:56:16 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpRyZpZj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:28 INFO - PID 1639 | RSS: Main: 240840704 03:56:28 INFO - PID 1639 | 03:59:33 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 03:59:35 INFO - PID 1639 | RSS: Main: 429604864 03:59:35 INFO - PID 1639 | 04:01:18 INFO - PID 1639 | ************************* 04:01:18 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:01:18 INFO - PID 1639 | 04:01:18 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:01:18 INFO - PID 1639 | Full stack: 04:01:18 INFO - PID 1639 | ************************* 04:01:18 INFO - PID 1639 | ************************* 04:01:18 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:01:18 INFO - PID 1639 | 04:01:18 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:01:18 INFO - PID 1639 | Full stack: 04:01:18 INFO - PID 1639 | ************************* 04:01:18 INFO - PID 1639 | ************************* 04:01:18 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:01:18 INFO - PID 1639 | 04:01:18 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:01:18 INFO - PID 1639 | Full stack: 04:01:18 INFO - PID 1639 | ************************* 04:01:18 INFO - PID 1639 | ************************* 04:01:18 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:01:18 INFO - PID 1639 | 04:01:18 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:01:18 INFO - PID 1639 | Full stack: 04:01:18 INFO - PID 1639 | ************************* 04:02:38 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 04:02:39 INFO - PID 1639 | RSS: Main: 365715456 04:02:39 INFO - PID 1639 | 04:05:41 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 04:05:42 INFO - PID 1639 | RSS: Main: 327446528 04:05:42 INFO - PID 1639 | 04:08:44 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 04:08:44 INFO - PID 1639 | RSS: Main: 349564928 04:08:44 INFO - PID 1639 | 04:11:48 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 04:11:49 INFO - PID 1639 | RSS: Main: 336900096 04:11:49 INFO - PID 1639 | 04:14:51 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 04:14:51 INFO - PID 1639 | RSS: Main: 377606144 04:14:51 INFO - PID 1639 | 04:14:51 INFO - PID 1639 | __start_tp_report 04:14:51 INFO - PID 1639 | _x_x_mozilla_page_load 04:14:51 INFO - PID 1639 | _x_x_mozilla_page_load_details 04:14:51 INFO - PID 1639 | |i|pagename|runs| 04:14:51 INFO - PID 1639 | |0;dojo.html;3160.889368872089;3512.4380099184136;3532.275883443894;3581.6239294874044;3594.658507441792;6013.338532761392;6144.402455361605;6215.3784621537825;6229.159063526423;6239.344868788774;6160.075988601712;6198.628082315065;6256;6265.5614107012525;6289.5597308188335;4848.5151484851585;5159.22611608258;5288.391834938973;5347.652402593839;5413.133898576229;4496.797644106006;5365.007473617393;5456.48163424474;5458;5461.69960652164;5259.658122222062;5322.33470816148;5337.279467271907;5339.893202135974;5353.839384818461;5299.152135658314;5314.043472175007;5322.361316641989;5325.281087053276;5330.173823057432;5260.473952604747;5302.310699609026;5308.230306605559;5311.415744268127;5323.680579165262;6144.279601711528;6221.973374393265;6237.376262373772;6239.844003899939;6254.937450625481;6584.11114499546;6606.6036037837885;6617.305182955816;6618.238902526223;6621.867562648768;6457.4188323050685;6592.769253076167;6738.494612904052;6738.696758645824;6743.696533655997;5589.245451863987;5905.527557795366;6243.406876346739;6280.811575652738;6316.30520642729;6802.8639427212165;6815.522913396114;6829.248782633907;6829.248782633907;6837.658117094125;6322.841928951813;6342.8414289642205;6353.078803573456;6375.330590288046;6460.676966151674;6429.45349645276;6584.967075164689;6665.233498147678;6671.032700258435;6671.232808227019;6167.784127555514;6540.117084193668;6544.934550654432;6556.606603603799;6566.4418524425955;6378.585391949601;6527.967360163168;6560.573562718408;6615.536912416181;6630.834229144213;5250.7637156328055;5256.26412302278;5261.289725886956;5272.446393128666;5300.310959575308;4693.7653117344;4699.835505757282;4706.082313948816;4709.152352576569;4752.928706069411;6121.401995308023;6141.854248382324;6233.812985610348;6289.937100629027;6334.809955701337;6649.833754156185;6680.098186744727;6683.4987375947;6689.966550167315;6702.0282059101155;6278.152449419361;6329.145565348619;6339.683015849189;6343.207099112611;6344.587601805868;5641.915371269352;5765.538756899438;5809;5810.970945145247;5821.53427725781;6708.295628959084;6727.798166055026;6734.898976515454;6736.461083113437;6744.190697116377;6479.676016199265;6492.513061520499;6493.707783149675;6498.512611554058;6499.902501462577;6832.145981752281;6863.450923926173;6904.3095690432565;6908.1019467468905;6922.61925594077;6553.5084868634085;6561.737530498726;6563.704633291418;6582.17722784652;6583.407493325623;6540.934590654033;6654.168228971379;6711.362420570038;6716.261211266855;6728.697208625722;6284.717187726472;6341.270753863365;6360.427561519486;6395.552311338161;6483.935160648333;5372.811951581676;6470.838229044123;6481.449076828522;6496.935030649633;6501.9674901625185;6370.55406121567;6373.107764913008;6378.808635740936;6379.393957574023;6381.425671689571;6455.741770329134;6465.967670161619;6486;6500.739970401131;6517.087607735016;6243.656598887105;6278.246610406781;6283.49732021428;6312.242530896322;6358.364163583605 04:14:51 INFO - PID 1639 | |1;ext.html;666.3436515032691;691.5539477037311;754.7320701151091;1074.6883403812894;1122.9719257018578;26364.736352636468;32554.348913021724;33086;33203.50194747081;33356.33287334258;35278.061071450014;35543.466847997304;35686.46470302947;35700.821495892545;35762.64237357626;6050.062240352752;8192.443435747204;8372.58137093143;8379.83240335193;8384.622691978846;6038.75844966203;7612.847743045136;8574.056853746082;8593.613287402051;8635.093315201908;8655;8684.43551169172;8689.348298877578;8692.565371731389;8696.956515217415;8584.442011269248;8646.481211127353;8652.740417787476;8653.307735381155;8694.869576956382;5961.314448838352;6056.878862422771;6827.863442731117;8352.457090289172;8374.330053595697;37168.628313716785;37335.626643733485;37348.87953361403;37362.62637373619;37403;3454.9481757773656;3492.388831954398;3493.6855682988653;3499.61504234534;3511.087117349482;30536.08391748229;30658.92693755708;30660.693393066005;30687.386252275053;30843.38313233745;3098.7366073883745;3144.9685503144906;3164.889228877001;3181.125190572588;3191.2181515528846;284267;292835;293263.5336823324;293495.53252233815;294932;48832.75583622059;48943.510564894605;49078;49090.754546227756;49107.75446122818;51025.744871275405;51046.74476627667;51093;51143;51153;14054.71890562183;14065.929670351787;14103.78844317336;14112.71774564503;14121.78817317741;9922.851157232648;11360.375179365048;11492.253003554742;11507.136964727511;11508.251963622337;10352.637657681946;10417.5832966682;11812.468438920268;11942.582009629621;12017.399130043463;5435.7825686972865;5437.265969094122;5444.292242008592;5445.53712934405;5452.809151679672;1002.9398236105857;1003.8895721470633;1004.8392257238806;1024.062982371137;1033.994830025845;23391.41521461977;24106.156284529956;24309.149179778622;24379.756202438104;24418.389540261636;968.970930872075;999.5801763259449;1116.8273313021296;1124.9493772780245;1130.8021096308114;11709.423926736104;12300.384980750927;12318.521777386772;12323.630291091282;12355.32045737493;316341;316731;317023;317293;317769.41115294275;52031.47968520342;52059;52093.739531302104;52176;52310.73844630752;1432.3697573067816;1478.682083352106;1490.69440764643;1493.0444515510083;1524.9542513724384;23774.16790412327;23816.642750358413;23832.40418989539;23845;23863.761362386154;36482.63517364899;36562.45156322711;36596.63403365932;36606.816965915;36616.90149295525;291741.0825891714;291881;292643;292652;292782;32227.838860805547;32487;32545.511817322287;33294.00117996464;33444.66555334415;43406.56593434025;43729;43942.560574395124;43951.34072988844;43998.120037598426;28264.576031359957;28493;29315.413691726473;30374.84812575923;30541.694583054774;23951.640725389483;29302.560461592668;29523.704762952097;30059;30656.846715766278;36383.45424818683;36411.35623978288;36420.81789591035;36426;36450.45324320084;26828.926842926063;29743.55384669275;30416.69583304227;31208.21979450532;31554.36891262116;22245.666315004964;23686.881565592063;24222.63666045046;24256.393590160387;24272.02911883505 04:14:51 INFO - PID 1639 | |2;jquery.html;387.1579314989896;423.6428334578855;436.40866625722134;444.50437761895483;445.38759206091623;17042.82957170428;21156.365309040713;21482.248121315755;22516;22844.428889277777;22226.444338891535;22626.321210363676;22870.65694014587;23266.883665581692;23282;4626.259798432252;5957.553183511243;6179.876402471948;6219.222597175353;6236.282827474854;6042.848928776772;6170.907436388436;6177.567570270083;6179.19670442844;6183.134361189437;5928.703564821763;6050.788222412217;6052.788152414666;6108.297545782225;6123.357047510014;5897.4102589741115;6066.454019138277;6087.512998960073;6133.877322453571;6134.263888333407;5436.782528698847;5494.945050549483;5501.064818980783;5505.256790333294;5533.944660553423;26061.60907586388;26983.190504284903;27333.316667083283;27779.305517362027;27930;2150.1721837092678;2190.167736260227;2203.5813195492965;2203.6584329428965;2204.713387259662;15080.472183473636;18438.078096095276;18539.35112271064;18544.2582296708;18649;1854.2026928420773;1856.0441372693074;1904.7619047619048;1994.112619884152;2072.0365030261;133572;149152.2542387292;164180;167421;170304;11412.885871141349;11541;11723.120765942589;12207.145499815106;12230.510779568718;14131.434742610387;15175;15179;15190.164540950133;15205.239738013055;8788.16512431318;8963.05887881763;8990.955045224731;9119.270458363315;9137.862932056025;8550.33229133953;8557.716342548543;8610.698625548075;8787.209151176425;8803.911960880308;7653.425993050543;7730.982761263061;7766.534007959541;7796.454248202572;7847.176046515034;1858.5446565591517;2193.396815875615;2197.2748992832326;2212.579609874119;2372.8813559321966;848.1171798607082;907.1336873285996;932.5057719408725;952.4618590496348;964.1659964130977;20642.380728578166;21118.465784106007;21135.365939021853;21186.94065296729;21315.46711332229;876.548577482597;952.6094301336558;957.5882370580717;960.2989817433313;995.785906030207;10235.488225588691;10918;10942.069924056545;10951.726206844893;10960.725981850517;491541;515756;516235;520633;528553.3572332191;133801;135615;136352;136708;136874;1113.4265853085506;1147.6098126636984;1168.7428765671539;1169.2516789254885;1170.9473073711704;16706;18085.81914180894;18131.184096715417;18132.818671813115;18172.09139543044;57689.84620307486;57770;58015.12977305259;58330;58979.70510147422;79744.60127699324;80011.59994199991;81905.77141343003;82669.58665206635;82784;8353.955755530558;8652.524111173945;8768.035516093098;8823.867641985504;9188.059820857528;11381;14133.293335333397;14322.113450449144;14475.493357732428;14584.85415145835;10074.848877266993;11850.762984740084;11988.100892433276;12061.457234424648;12217.823365924745;11168.888311116785;11179.385133817394;11286.492107855001;11537.538498459968;11567.595134170264;11779.35213563228;11915.140366312196;12152.817707734568;12239.20445171061;12263.386830658254;8660.696875609323;8707.564621768759;8750.256228220673;9155.313351498531;9280.860787088333;9749.22006239485;10498.842517362093;11306.547738090385;11889.28664280146;12147.57483488109 04:14:51 INFO - PID 1639 | |3;mootools.html;1374.8281464816898;1427.9714405711886;1441.6251774538616;1443.1846007006047;1445.8048163497929;11150.386728729916;11622.128340374475;11624.593139240129;11638.127140464456;11641.767164656701;10910.399928003957;11534.134939879501;11558.65324040278;11573.826392604096;11616.651500454978;2476.2076135636557;2517.332906779705;2520.420303330235;2523.671922650053;2527.431327951215;2069.8758074515576;2357.669926210332;2470.9135180268695;2478.045952308365;2479.119912431088;2039.3474088291753;2065.7521097468325;2435.0868424340874;2543.4785868896925;2559.513692398448;2472.9010839566395;2497.2383423055962;2518.848869067862;2522.205505265835;2533.9873300633562;2511.3596033011463;2528.759767822054;2535.2774459279017;2538.746125387465;2540.5173017126685;11024.228304018721;11288.54845806175;11306.265092768943;11318.094552435785;11319;5523.392426833045;6354.459870910978;6609.173853268341;6619.106420633201;6630.370114839131;3769.754965927206;3950.9012274693077;4119.258533463975;4135.503739551243;4227.7463352198965;1242;1247.1830950727287;1278.7058976435378;1300.4408104515055;1301.290796515901;15754.188268349057;16182.676346473123;16186.271617777229;16188.028718276822;16210.837891621051;5700.812260842613;5801.245838041028;5914.378990206053;6094.481969032593;6150.077488376779;13679.521216757366;13714.862851371558;13732.244726540137;13732.725345493034;13742.587722368346;6734.393904548614;6738.191417029988;6738.764143254963;6744.6627668616375;6749.021391898147;5736.971315143398;6107.4197951194565;6193;6201.069839524017;6208.627482350983;3975.483187185705;4475.142815731435;4610.956768532752;4625.444946606429;4684.086603112429;1404.487362112842;1445.8843292536571;1446.7323545144181;1467.5744034229954;1469.882409407245;675.9560628559128;723.2008630463367;803.61426515273;810.1938571121772;827.5200383777394;6443.677816109176;6552.679529740678;6839.487038472134;6894.24163342032;6960.164780226405;584.4155844155844;597.8176656119838;605.7122866638312;605.742559412248;693.7017082654406;4234.047339348684;4249.128928569636;4250.3836943643;4382.737035777864;4387.627051700578;14241.64395890111;14814.037087589271;14917.925410372878;14918.179500127597;14959.952803303664;14075.648108797157;14592.562223133324;14598.635034124232;14603.342849571794;14608.561743147722;8052.597370131587;8291.709790157316;8295.253427191461;8300.626471808782;8314.459560128573;6511.153550038464;6815.2162501311;6965.721371145098;6965.79102626922;7008.439324853897;12834.037447191311;12846.807297890353;13243.337833108113;13267.137636053625;13279.203247805162;13360.599182024554;13391.522568324892;13391.933040334736;13516.459341626225;13721.725565488434;8983.550822458721;9250.4912229828;9252.259819214582;9253.259739220712;9277.62889484413;10210.846837297595;10433.895661043292;10598.9930956559;10686;10787.244892857425;8983.236424903695;9020.05289444599;9106.726798196065;9149.496777677292;9209.723708288762;8711.607977641148;8913.50975696317;8949.105089490999;8960.775980600276;9166.17504424605;8091.271785539329;8200.097989221062;8201.917980820353;8202.630881610223;8205.79485512867;5295.867603309948;5846.94153058464;5989.131575921554;6056.728087101758;6120;5852.356240813592;5934.643921364559;5955.880882382415;6151.784687535915;6302.71637776292 04:14:51 INFO - PID 1639 | |4;prototype.html;340.3482331335493;369.56391458079463;386.8123959879458;408.8058172368126;413.2891426745996;4938.580220681242;5958.64248145111;5972.970135149319;6021.638701677897;6029.246344206974;4293.656507479402;5319.654222475537;5588.960029589201;5837.620554663944;5950.404959504048;4289.313709806432;4290.313549832027;4299.097189590189;4312.878651550588;4322.459692538433;3930.4693866327966;3992.141689536749;4303.053328267776;4320.805563749639;4325.697201195918;3743.9438408423894;4001.339778936472;4124.525679546846;4214.536400995903;4223.746575205498;4210.873673789792;4213.220554197453;4217.641500472463;4224.239636865363;4225.070484493406;3379.4761811919193;3636.5090712753704;3645.6172101929183;3661.5972243053243;3669.6880765134997;5579.6652200868075;5669.6314739541795;5718.79984200551;5730.828075157752;5732.828015159552;4108.952217184598;4186.874393768192;4551.52209018055;4993.725345106018;5007.69953802773;5422.891542169174;6214.968925155391;6219.937800622027;6236.729963181105;6258.49932005443;3451.8446669899913;3574.3923532999193;3794.772313661189;4173.812178451977;4192.392103145057;5482.479164479368;5982.581219314649;6327.746890124389;6510.218773747086;6663.600183988928;4103.712740108163;4112.958870411318;4115.382692596075;4120.711550191518;4135.731177473514;3634.7819130852236;3835.76985380878;4244.214820258262;4263.104748002892;4283.250431174532;4166.479190101238;5043.697378157322;5048.16705243638;5050.949490505048;5061.772220250097;5991;6049.001914684028;6075.210222671113;6292.402221788922;6303.604630240571;1282.7242142939313;1420.2117824607235;1459.3360021190333;1459.8321193062934;1471.5732437593192;778.8130848596296;805.8589746794288;923.3905622289257;953.5137080089066;954.8949615542285;5923.99422487997;5949.315828679671;5969.134475501028;5972.343042265347;6015.669138197353;6509.544331896722;6553;6561.212654481397;6580.177477815273;6614.768483103068;5095.26118712792;5542.196381524656;5999.820005399845;6022.879542409128;6034.728437220336;2897.391547774991;3136.2002689314536;3405.1657343950396;3430.089697744573;3431.9485207721405;6417.422431981144;6645.900311495331;6690.431313338323;6743.932560674429;6799.32006799326;6092.299385570627;6620.371064748938;6683.966580167068;6697;6707.798766037026;5206.973965130226;6274;6481.319461456574;6642.767503137367;6678.699458524281;6173.660448675366;6320.146780184617;6341.302456729663;6344.238691357066;6520.347965203442;6265.404786545271;6293.3008087815115;6310.5898116622275;6347.650879201688;6373.808785736435;5945.449279415205;6387.5209359297305;6688.130543029375;6803.897941530782;6832.316768323128;4747.928781068218;4800.73595952226;4804.42346918372;4804.95195048059;4836.419629644465;6071.144823037314;6305.464035557029;6604.933950660624;6679.532432729857;6702.798916032527;6369.808905732835;6378;6396.648184349905;6404.295527491879;6434.613923164625;5587.860303492445;6171.290301615192;6397.776077837253;6424.807255782334;6425.325340839145;5691;6096.22621707131;6213.782517611862;6236.376362363727;6244.469220116341;5324.4675532446445;6390.392912673288;6403.8719225614295;6412.61524308543;6434.324395938359;6094.238220222473;6133.264008318852;6179.598326108789;6243.37566243372;6309.589876658002 04:14:51 INFO - PID 1639 | |5;yui.html;704.3801454719846;730.7990302666766;857.2970164465141;859.5573279760924;874.1782724239216;13186;18243.361482348122;18263.452096437093;18780.718289225657;18841;15606.297716602752;15869.285882135302;15883.36466541337;15887.84112158878;15900.840991590081;926.745145085102;929.0570071377557;930.1489137439235;930.3487558708897;932.822763674903;650.2749434380679;665.8801415745164;860.561113831944;922.3866129024191;959.3236768078488;1013.7921726046143;1014.2899970021015;1014.7919676466307;1015.3704703084098;1015.7511409704633;1010.8837483689397;1014.4268488304084;1015.9746006349826;1017.8269694152012;1018.623109449501;744.2966396755069;746.6229554075157;746.9103707555074;748.5920173505452;752.3567349915853;15938.760918586231;16199.352025919066;16503.009819410752;17324.566885827957;17444.651106977915;16516.50450486487;16677.666446671;16917.661646766996;16943;17317.653646927116;13941.302934853216;14063.578092657237;14076;14247.78628320576;14257.572272831832;3518.472229165646;3545.6454354564594;3547.255076433952;3548.361294966905;3551.2187318789825;124765.37617311947;124947;125117;125510;127743;13001.674958126123;13128.277944713132;13245.403956821967;13364.5322413717;13418.530351437652;24623.876880615484;24724.505509890063;25212.873935630203;25608.359791005;25686.871565642425;7860.528368297806;7869.527828330319;7946.284834364935;8027.6788928443375;8079.111297757242;3749.512563366745;3925.9018524537114;3992.580779018161;3996.540397854226;3997.3804060370107;4254.617084462413;4317.568243175658;4347.108842687305;4379.671524635602;4400.867973960786;917.4311926605548;941.4022095969109;943.551812888886;946.4983558713893;948.7485816258697;553.4963183502992;640.4876099120685;646.0761111610442;651.9641419721866;661.5798967655477;11278.54885804575;11295.604653837076;11593.130515211393;11604.73333962863;12091.697707557381;627.6662093052264;661.5336187987457;670.2660586657602;687.8074139241021;691.4364792694039;5304.549113325411;5379.273798037215;5535.33575970878;5588.704849331487;5604.775808967595;115118;116114;116869;117089;117761;77029;83371.5831420839;97229;97268.51365743126;99474.50262748639;60490;75693.62153189199;78708.03229919184;79073.60463197647;81405.99999999882;9952;12121.787821217808;12135.817962730389;12278.754424911273;13056.020798439966;35909.46135807913;36616;36731.63268367282;36880;38225.4266186013;65400;69135.3086469149;69911;70121;71317.64341178261;16244.756328654843;16434.589135271715;16984.065876376422;16990.065546395068;17032.82967170362;17774.022428766024;18131.36540221086;18400.539986500444;18420.907895460972;18555.35056273024;16574.08842513673;17224.569385765455;17466.476005719847;17502.299908004046;17616.73574896403;16700.83299166993;16707.66584668324;17449.865758725642;17463.214155363294;17607.383741568985;13506.459741610226;16604.920680155752;17237.827621723623;17241.568960775578;17341.65316693634;10417.791644166922;10785.298955567863;11775.823362649397;11841.763164736829;12111.636650900487;12175.878241217475;12326.568570100362;13586.048976571545;13754.793678094637;13867.583972480841 04:14:51 INFO - PID 1639 | __end_tp_report 04:14:51 INFO - PID 1639 | __start_cc_report 04:14:51 INFO - PID 1639 | _x_x_mozilla_cycle_collect,1928 04:14:51 INFO - PID 1639 | __end_cc_report 04:14:51 INFO - PID 1639 | __startTimestamp1493723691884__endTimestamp 04:14:51 INFO - PID 1639 | 04:14:51 INFO - PID 1639 | ------- Summary: start ------- 04:14:51 INFO - PID 1639 | Number of tests: 6 04:14:51 INFO - PID 1639 | 04:14:51 INFO - PID 1639 | [#0] dojo.html Cycles:165 Average:6084.02 Median:6342.84 stddev:737.24 (11.6%) stddev-sans-first:702.93 04:14:51 INFO - PID 1639 | Values: 3160.9 3512.4 3532.3 3581.6 3594.7 6013.3 6144.4 6215.4 6229.2 6239.3 6160.1 6198.6 6256.0 6265.6 6289.6 4848.5 5159.2 5288.4 5347.7 5413.1 4496.8 5365.0 5456.5 5458.0 5461.7 5259.7 5322.3 5337.3 5339.9 5353.8 5299.2 5314.0 5322.4 5325.3 5330.2 5260.5 5302.3 5308.2 5311.4 5323.7 6144.3 6222.0 6237.4 6239.8 6254.9 6584.1 6606.6 6617.3 6618.2 6621.9 6457.4 6592.8 6738.5 6738.7 6743.7 5589.2 5905.5 6243.4 6280.8 6316.3 6802.9 6815.5 6829.2 6829.2 6837.7 6322.8 6342.8 6353.1 6375.3 6460.7 6429.5 6585.0 6665.2 6671.0 6671.2 6167.8 6540.1 6544.9 6556.6 6566.4 6378.6 6528.0 6560.6 6615.5 6630.8 5250.8 5256.3 5261.3 5272.4 5300.3 4693.8 4699.8 4706.1 4709.2 4752.9 6121.4 6141.9 6233.8 6289.9 6334.8 6649.8 6680.1 6683.5 6690.0 6702.0 6278.2 6329.1 6339.7 6343.2 6344.6 5641.9 5765.5 5809.0 5811.0 5821.5 6708.3 6727.8 6734.9 6736.5 6744.2 6479.7 6492.5 6493.7 6498.5 6499.9 6832.1 6863.5 6904.3 6908.1 6922.6 6553.5 6561.7 6563.7 6582.2 6583.4 6540.9 6654.2 6711.4 6716.3 6728.7 6284.7 6341.3 6360.4 6395.6 6483.9 5372.8 6470.8 6481.4 6496.9 6502.0 6370.6 6373.1 6378.8 6379.4 6381.4 6455.7 6466.0 6486.0 6500.7 6517.1 6243.7 6278.2 6283.5 6312.2 6358.4 04:14:51 INFO - PID 1639 | 04:14:51 INFO - PID 1639 | [#1] ext.html Cycles:180 Average:44541.46 Median:32357.42 stddev:78921.70 (243.9%) stddev-sans-first:79074.35 04:14:51 INFO - PID 1639 | Values: 666.3 691.6 754.7 1074.7 1123.0 26364.7 32554.3 33086.0 33203.5 33356.3 35278.1 35543.5 35686.5 35700.8 35762.6 6050.1 8192.4 8372.6 8379.8 8384.6 6038.8 7612.8 8574.1 8593.6 8635.1 8655.0 8684.4 8689.3 8692.6 8697.0 8584.4 8646.5 8652.7 8653.3 8694.9 5961.3 6056.9 6827.9 8352.5 8374.3 37168.6 37335.6 37348.9 37362.6 37403.0 3454.9 3492.4 3493.7 3499.6 3511.1 30536.1 30658.9 30660.7 30687.4 30843.4 3098.7 3145.0 3164.9 3181.1 3191.2 284267.0 292835.0 293263.5 293495.5 294932.0 48832.8 48943.5 49078.0 49090.8 49107.8 51025.7 51046.7 51093.0 51143.0 51153.0 14054.7 14065.9 14103.8 14112.7 14121.8 9922.9 11360.4 11492.3 11507.1 11508.3 10352.6 10417.6 11812.5 11942.6 12017.4 5435.8 5437.3 5444.3 5445.5 5452.8 1002.9 1003.9 1004.8 1024.1 1034.0 23391.4 24106.2 24309.1 24379.8 24418.4 969.0 999.6 1116.8 1124.9 1130.8 11709.4 12300.4 12318.5 12323.6 12355.3 316341.0 316731.0 317023.0 317293.0 317769.4 52031.5 52059.0 52093.7 52176.0 52310.7 1432.4 1478.7 1490.7 1493.0 1525.0 23774.2 23816.6 23832.4 23845.0 23863.8 36482.6 36562.5 36596.6 36606.8 36616.9 291741.1 291881.0 292643.0 292652.0 292782.0 32227.8 32487.0 32545.5 33294.0 33444.7 43406.6 43729.0 43942.6 43951.3 43998.1 28264.6 28493.0 29315.4 30374.8 30541.7 23951.6 29302.6 29523.7 30059.0 30656.8 36383.5 36411.4 36420.8 36426.0 36450.5 26828.9 29743.6 30416.7 31208.2 31554.4 22245.7 23686.9 24222.6 24256.4 24272.0 04:14:51 INFO - PID 1639 | 04:14:51 INFO - PID 1639 | [#2] jquery.html Cycles:180 Average:34854.71 Median:23068.77 stddev:88284.48 (382.7%) stddev-sans-first:88494.21 04:14:51 INFO - PID 1639 | Values: 387.2 423.6 436.4 444.5 445.4 17042.8 21156.4 21482.2 22516.0 22844.4 22226.4 22626.3 22870.7 23266.9 23282.0 4626.3 5957.6 6179.9 6219.2 6236.3 6042.8 6170.9 6177.6 6179.2 6183.1 5928.7 6050.8 6052.8 6108.3 6123.4 5897.4 6066.5 6087.5 6133.9 6134.3 5436.8 5494.9 5501.1 5505.3 5533.9 26061.6 26983.2 27333.3 27779.3 27930.0 2150.2 2190.2 2203.6 2203.7 2204.7 15080.5 18438.1 18539.4 18544.3 18649.0 1854.2 1856.0 1904.8 1994.1 2072.0 133572.0 149152.3 164180.0 167421.0 170304.0 11412.9 11541.0 11723.1 12207.1 12230.5 14131.4 15175.0 15179.0 15190.2 15205.2 8788.2 8963.1 8991.0 9119.3 9137.9 8550.3 8557.7 8610.7 8787.2 8803.9 7653.4 7731.0 7766.5 7796.5 7847.2 1858.5 2193.4 2197.3 2212.6 2372.9 848.1 907.1 932.5 952.5 964.2 20642.4 21118.5 21135.4 21186.9 21315.5 876.5 952.6 957.6 960.3 995.8 10235.5 10918.0 10942.1 10951.7 10960.7 491541.0 515756.0 516235.0 520633.0 528553.4 133801.0 135615.0 136352.0 136708.0 136874.0 1113.4 1147.6 1168.7 1169.3 1170.9 16706.0 18085.8 18131.2 18132.8 18172.1 57689.8 57770.0 58015.1 58330.0 58979.7 79744.6 80011.6 81905.8 82669.6 82784.0 8354.0 8652.5 8768.0 8823.9 9188.1 11381.0 14133.3 14322.1 14475.5 14584.9 10074.8 11850.8 11988.1 12061.5 12217.8 11168.9 11179.4 11286.5 11537.5 11567.6 11779.4 11915.1 12152.8 12239.2 12263.4 8660.7 8707.6 8750.3 9155.3 9280.9 9749.2 10498.8 11306.5 11889.3 12147.6 04:14:51 INFO - PID 1639 | 04:14:51 INFO - PID 1639 | [#3] mootools.html Cycles:180 Average:7091.75 Median:3860.33 stddev:4472.99 (115.9%) stddev-sans-first:4464.91 04:14:51 INFO - PID 1639 | Values: 1374.8 1428.0 1441.6 1443.2 1445.8 11150.4 11622.1 11624.6 11638.1 11641.8 10910.4 11534.1 11558.7 11573.8 11616.7 2476.2 2517.3 2520.4 2523.7 2527.4 2069.9 2357.7 2470.9 2478.0 2479.1 2039.3 2065.8 2435.1 2543.5 2559.5 2472.9 2497.2 2518.8 2522.2 2534.0 2511.4 2528.8 2535.3 2538.7 2540.5 11024.2 11288.5 11306.3 11318.1 11319.0 5523.4 6354.5 6609.2 6619.1 6630.4 3769.8 3950.9 4119.3 4135.5 4227.7 1242.0 1247.2 1278.7 1300.4 1301.3 15754.2 16182.7 16186.3 16188.0 16210.8 5700.8 5801.2 5914.4 6094.5 6150.1 13679.5 13714.9 13732.2 13732.7 13742.6 6734.4 6738.2 6738.8 6744.7 6749.0 5737.0 6107.4 6193.0 6201.1 6208.6 3975.5 4475.1 4611.0 4625.4 4684.1 1404.5 1445.9 1446.7 1467.6 1469.9 676.0 723.2 803.6 810.2 827.5 6443.7 6552.7 6839.5 6894.2 6960.2 584.4 597.8 605.7 605.7 693.7 4234.0 4249.1 4250.4 4382.7 4387.6 14241.6 14814.0 14917.9 14918.2 14960.0 14075.6 14592.6 14598.6 14603.3 14608.6 8052.6 8291.7 8295.3 8300.6 8314.5 6511.2 6815.2 6965.7 6965.8 7008.4 12834.0 12846.8 13243.3 13267.1 13279.2 13360.6 13391.5 13391.9 13516.5 13721.7 8983.6 9250.5 9252.3 9253.3 9277.6 10210.8 10433.9 10599.0 10686.0 10787.2 8983.2 9020.1 9106.7 9149.5 9209.7 8711.6 8913.5 8949.1 8960.8 9166.2 8091.3 8200.1 8201.9 8202.6 8205.8 5295.9 5846.9 5989.1 6056.7 6120.0 5852.4 5934.6 5955.9 6151.8 6302.7 04:14:51 INFO - PID 1639 | 04:14:51 INFO - PID 1639 | [#4] prototype.html Cycles:180 Average:5064.27 Median:5949.86 stddev:1634.06 (27.5%) stddev-sans-first:1599.71 04:14:51 INFO - PID 1639 | Values: 340.3 369.6 386.8 408.8 413.3 4938.6 5958.6 5973.0 6021.6 6029.2 4293.7 5319.7 5589.0 5837.6 5950.4 4289.3 4290.3 4299.1 4312.9 4322.5 3930.5 3992.1 4303.1 4320.8 4325.7 3743.9 4001.3 4124.5 4214.5 4223.7 4210.9 4213.2 4217.6 4224.2 4225.1 3379.5 3636.5 3645.6 3661.6 3669.7 5579.7 5669.6 5718.8 5730.8 5732.8 4109.0 4186.9 4551.5 4993.7 5007.7 5422.9 6215.0 6219.9 6236.7 6258.5 3451.8 3574.4 3794.8 4173.8 4192.4 5482.5 5982.6 6327.7 6510.2 6663.6 4103.7 4113.0 4115.4 4120.7 4135.7 3634.8 3835.8 4244.2 4263.1 4283.3 4166.5 5043.7 5048.2 5050.9 5061.8 5991.0 6049.0 6075.2 6292.4 6303.6 1282.7 1420.2 1459.3 1459.8 1471.6 778.8 805.9 923.4 953.5 954.9 5924.0 5949.3 5969.1 5972.3 6015.7 6509.5 6553.0 6561.2 6580.2 6614.8 5095.3 5542.2 5999.8 6022.9 6034.7 2897.4 3136.2 3405.2 3430.1 3431.9 6417.4 6645.9 6690.4 6743.9 6799.3 6092.3 6620.4 6684.0 6697.0 6707.8 5207.0 6274.0 6481.3 6642.8 6678.7 6173.7 6320.1 6341.3 6344.2 6520.3 6265.4 6293.3 6310.6 6347.7 6373.8 5945.4 6387.5 6688.1 6803.9 6832.3 4747.9 4800.7 4804.4 4805.0 4836.4 6071.1 6305.5 6604.9 6679.5 6702.8 6369.8 6378.0 6396.6 6404.3 6434.6 5587.9 6171.3 6397.8 6424.8 6425.3 5691.0 6096.2 6213.8 6236.4 6244.5 5324.5 6390.4 6403.9 6412.6 6434.3 6094.2 6133.3 6179.6 6243.4 6309.6 04:14:51 INFO - PID 1639 | 04:14:51 INFO - PID 1639 | [#5] yui.html Cycles:180 Average:22228.99 Median:18488.13 stddev:31757.01 (171.8%) stddev-sans-first:31804.97 04:14:51 INFO - PID 1639 | Values: 704.4 730.8 857.3 859.6 874.2 13186.0 18243.4 18263.5 18780.7 18841.0 15606.3 15869.3 15883.4 15887.8 15900.8 926.7 929.1 930.1 930.3 932.8 650.3 665.9 860.6 922.4 959.3 1013.8 1014.3 1014.8 1015.4 1015.8 1010.9 1014.4 1016.0 1017.8 1018.6 744.3 746.6 746.9 748.6 752.4 15938.8 16199.4 16503.0 17324.6 17444.7 16516.5 16677.7 16917.7 16943.0 17317.7 13941.3 14063.6 14076.0 14247.8 14257.6 3518.5 3545.6 3547.3 3548.4 3551.2 124765.4 124947.0 125117.0 125510.0 127743.0 13001.7 13128.3 13245.4 13364.5 13418.5 24623.9 24724.5 25212.9 25608.4 25686.9 7860.5 7869.5 7946.3 8027.7 8079.1 3749.5 3925.9 3992.6 3996.5 3997.4 4254.6 4317.6 4347.1 4379.7 4400.9 917.4 941.4 943.6 946.5 948.7 553.5 640.5 646.1 652.0 661.6 11278.5 11295.6 11593.1 11604.7 12091.7 627.7 661.5 670.3 687.8 691.4 5304.5 5379.3 5535.3 5588.7 5604.8 115118.0 116114.0 116869.0 117089.0 117761.0 77029.0 83371.6 97229.0 97268.5 99474.5 60490.0 75693.6 78708.0 79073.6 81406.0 9952.0 12121.8 12135.8 12278.8 13056.0 35909.5 36616.0 36731.6 36880.0 38225.4 65400.0 69135.3 69911.0 70121.0 71317.6 16244.8 16434.6 16984.1 16990.1 17032.8 17774.0 18131.4 18400.5 18420.9 18555.4 16574.1 17224.6 17466.5 17502.3 17616.7 16700.8 16707.7 17449.9 17463.2 17607.4 13506.5 16604.9 17237.8 17241.6 17341.7 10417.8 10785.3 11775.8 11841.8 12111.6 12175.9 12326.6 13586.0 13754.8 13867.6 04:14:51 INFO - PID 1639 | -------- Summary: end -------- 04:14:51 INFO - PID 1639 | 04:14:52 INFO - TEST-INFO | 1639: exit 0 04:14:52 INFO - TEST-OK | dromaeo_css | took 1119615ms 04:14:52 INFO - TEST-START | kraken 04:14:52 INFO - operating with platform_type : mac_ 04:14:52 INFO - Initialising browser for kraken test... 04:14:52 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpLjkzYm/profile http://localhost:49237/getInfo.html) 04:14:55 INFO - PID 1650 | __metrics Screen width/height:1600/1200 04:14:55 INFO - PID 1650 | colorDepth:24 04:14:55 INFO - PID 1650 | Browser inner width/height: 1024/689 04:14:55 INFO - PID 1650 | __metrics 04:14:55 INFO - PID 1650 | 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:14:55 INFO - PID 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:14:56 INFO - TEST-INFO | 1650: exit 0 04:14:56 INFO - Browser initialized. 04:14:56 INFO - Running cycle 1/1 for kraken test... 04:14:56 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpLjkzYm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:08 INFO - PID 1651 | RSS: Main: 240857088 04:15:08 INFO - PID 1651 | 04:15:11 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 04:15:12 INFO - PID 1651 | RSS: Main: 310407168 04:15:12 INFO - PID 1651 | 04:15:14 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 04:15:15 INFO - PID 1651 | RSS: Main: 293945344 04:15:15 INFO - PID 1651 | 04:15:18 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 04:15:19 INFO - PID 1651 | RSS: Main: 384536576 04:15:19 INFO - PID 1651 | 04:15:21 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 04:15:21 INFO - PID 1651 | RSS: Main: 290287616 04:15:21 INFO - PID 1651 | 04:15:23 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:15:24 INFO - PID 1651 | RSS: Main: 291368960 04:15:24 INFO - PID 1651 | 04:15:27 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 04:15:27 INFO - PID 1651 | RSS: Main: 355094528 04:15:27 INFO - PID 1651 | 04:15:30 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 04:15:31 INFO - PID 1651 | RSS: Main: 372744192 04:15:31 INFO - PID 1651 | 04:15:34 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 04:15:35 INFO - PID 1651 | RSS: Main: 382849024 04:15:35 INFO - PID 1651 | 04:15:36 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:15:37 INFO - PID 1651 | RSS: Main: 333275136 04:15:37 INFO - PID 1651 | 04:15:38 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:15:39 INFO - PID 1651 | RSS: Main: 334815232 04:15:39 INFO - PID 1651 | 04:15:41 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:15:42 INFO - PID 1651 | RSS: Main: 319586304 04:15:42 INFO - PID 1651 | 04:15:45 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:15:46 INFO - PID 1651 | RSS: Main: 351498240 04:15:46 INFO - PID 1651 | 04:15:49 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:15:49 INFO - PID 1651 | RSS: Main: 343789568 04:15:49 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 04:15:51 INFO - PID 1651 | RSS: Main: 386502656 04:15:51 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | __start_tp_report 04:15:51 INFO - PID 1651 | _x_x_mozilla_page_load 04:15:51 INFO - PID 1651 | _x_x_mozilla_page_load_details 04:15:51 INFO - PID 1651 | |i|pagename|runs| 04:15:51 INFO - PID 1651 | |0;ai-astar;111;108;110;110;110;111;108;112;109;110 04:15:51 INFO - PID 1651 | |1;audio-beat-detection;133;108;104;146;106;106;119;105;136;125 04:15:51 INFO - PID 1651 | |2;audio-dft;185;184;187;185;187;187;186;184;185;181 04:15:51 INFO - PID 1651 | |3;audio-fft;83;58;58;89;58;64;85;80;92;59 04:15:51 INFO - PID 1651 | |4;audio-oscillator;86;70;87;54;68;78;108;103;101;99 04:15:51 INFO - PID 1651 | |5;imaging-gaussian-blur;90;90;89;89;90;90;89;89;91;95 04:15:51 INFO - PID 1651 | |6;imaging-darkroom;97;98;97;97;97;97;97;97;97;97 04:15:51 INFO - PID 1651 | |7;imaging-desaturate;85;108;127;84;85;84;81;85;84;81 04:15:51 INFO - PID 1651 | |8;json-parse-financial;49;50;49;49;49;48;51;49;48;50 04:15:51 INFO - PID 1651 | |9;json-stringify-tinderbox;54;54;59;67;68;62;56;58;56;57 04:15:51 INFO - PID 1651 | |10;stanford-crypto-aes;83;83;83;81;83;71;98;95;103;89 04:15:51 INFO - PID 1651 | |11;stanford-crypto-ccm;136;137;136;135;146;131;138;140;191;160 04:15:51 INFO - PID 1651 | |12;stanford-crypto-pbkdf2;177;183;185;182;186;184;185;181;178;184 04:15:51 INFO - PID 1651 | |13;stanford-crypto-sha256-iterative;68;68;66;66;68;67;68;69;68;67 04:15:51 INFO - PID 1651 | __end_tp_report 04:15:51 INFO - PID 1651 | __start_cc_report 04:15:51 INFO - PID 1651 | _x_x_mozilla_cycle_collect,2189 04:15:51 INFO - PID 1651 | __end_cc_report 04:15:51 INFO - PID 1651 | __startTimestamp1493723751659__endTimestamp 04:15:51 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | ------- Summary: start ------- 04:15:51 INFO - PID 1651 | Number of tests: 14 04:15:51 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:1.29 (1.2%) stddev-sans-first:1.30 04:15:51 INFO - PID 1651 | Values: 111.0 108.0 110.0 110.0 110.0 111.0 108.0 112.0 109.0 110.0 04:15:51 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | [#1] audio-beat-detection Cycles:10 Average:118.80 Median:122.00 stddev:15.38 (12.6%) stddev-sans-first:15.43 04:15:51 INFO - PID 1651 | Values: 133.0 108.0 104.0 146.0 106.0 106.0 119.0 105.0 136.0 125.0 04:15:51 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | [#2] audio-dft Cycles:10 Average:185.10 Median:185.50 stddev:1.85 (1.0%) stddev-sans-first:1.96 04:15:51 INFO - PID 1651 | Values: 185.0 184.0 187.0 185.0 187.0 187.0 186.0 184.0 185.0 181.0 04:15:51 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | [#3] audio-fft Cycles:10 Average:72.60 Median:81.50 stddev:14.38 (17.6%) stddev-sans-first:14.75 04:15:51 INFO - PID 1651 | Values: 83.0 58.0 58.0 89.0 58.0 64.0 85.0 80.0 92.0 59.0 04:15:51 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | [#4] audio-oscillator Cycles:10 Average:85.40 Median:74.00 stddev:17.74 (24.0%) stddev-sans-first:18.81 04:15:51 INFO - PID 1651 | Values: 86.0 70.0 87.0 54.0 68.0 78.0 108.0 103.0 101.0 99.0 04:15:51 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:90.20 Median:90.00 stddev:1.81 (2.0%) stddev-sans-first:1.92 04:15:51 INFO - PID 1651 | Values: 90.0 90.0 89.0 89.0 90.0 90.0 89.0 89.0 91.0 95.0 04:15:51 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | [#6] imaging-darkroom Cycles:10 Average:97.10 Median:97.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:15:51 INFO - PID 1651 | Values: 97.0 98.0 97.0 97.0 97.0 97.0 97.0 97.0 97.0 97.0 04:15:51 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | [#7] imaging-desaturate Cycles:10 Average:90.40 Median:84.00 stddev:15.04 (17.9%) stddev-sans-first:15.83 04:15:51 INFO - PID 1651 | Values: 85.0 108.0 127.0 84.0 85.0 84.0 81.0 85.0 84.0 81.0 04:15:51 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | [#8] json-parse-financial Cycles:10 Average:49.20 Median:49.00 stddev:0.92 (1.9%) stddev-sans-first:0.97 04:15:51 INFO - PID 1651 | Values: 49.0 50.0 49.0 49.0 49.0 48.0 51.0 49.0 48.0 50.0 04:15:51 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:58.50 stddev:5.02 (8.6%) stddev-sans-first:4.97 04:15:51 INFO - PID 1651 | Values: 54.0 54.0 59.0 67.0 68.0 62.0 56.0 58.0 56.0 57.0 04:15:51 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:83.00 stddev:9.43 (11.4%) stddev-sans-first:9.90 04:15:51 INFO - PID 1651 | Values: 83.0 83.0 83.0 81.0 83.0 71.0 98.0 95.0 103.0 89.0 04:15:51 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:139.00 stddev:18.07 (13.0%) stddev-sans-first:18.87 04:15:51 INFO - PID 1651 | Values: 136.0 137.0 136.0 135.0 146.0 131.0 138.0 140.0 191.0 160.0 04:15:51 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.50 Median:184.00 stddev:3.03 (1.6%) stddev-sans-first:2.47 04:15:51 INFO - PID 1651 | Values: 177.0 183.0 185.0 182.0 186.0 184.0 185.0 181.0 178.0 184.0 04:15:51 INFO - PID 1651 | 04:15:51 INFO - PID 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 04:15:51 INFO - PID 1651 | Values: 68.0 68.0 66.0 66.0 68.0 67.0 68.0 69.0 68.0 67.0 04:15:51 INFO - PID 1651 | -------- Summary: end -------- 04:15:51 INFO - PID 1651 | 04:15:52 INFO - TEST-INFO | 1651: exit 0 04:15:52 INFO - TEST-OK | kraken | took 60249ms 04:15:52 INFO - SUITE-END | took 1179s 04:15:53 INFO - Completed test suite (00:19:40) 04:15:53 INFO - javascript benchmark 04:15:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7725.966300868247, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3160.889368872089, 3512.4380099184136, 3532.275883443894, 3581.6239294874044, 3594.658507441792, 6013.338532761392, 6144.402455361605, 6215.3784621537825, 6229.159063526423, 6239.344868788774, 6160.075988601712, 6198.628082315065, 6256.0, 6265.5614107012525, 6289.5597308188335, 4848.5151484851585, 5159.22611608258, 5288.391834938973, 5347.652402593839, 5413.133898576229, 4496.797644106006, 5365.007473617393, 5456.48163424474, 5458.0, 5461.69960652164, 5259.658122222062, 5322.33470816148, 5337.279467271907, 5339.893202135974, 5353.839384818461, 5299.152135658314, 5314.043472175007, 5322.361316641989, 5325.281087053276, 5330.173823057432, 5260.473952604747, 5302.310699609026, 5308.230306605559, 5311.415744268127, 5323.680579165262, 6144.279601711528, 6221.973374393265, 6237.376262373772, 6239.844003899939, 6254.937450625481, 6584.11114499546, 6606.6036037837885, 6617.305182955816, 6618.238902526223, 6621.867562648768, 6457.4188323050685, 6592.769253076167, 6738.494612904052, 6738.696758645824, 6743.696533655997, 5589.245451863987, 5905.527557795366, 6243.406876346739, 6280.811575652738, 6316.30520642729, 6802.8639427212165, 6815.522913396114, 6829.248782633907, 6829.248782633907, 6837.658117094125, 6322.841928951813, 6342.8414289642205, 6353.078803573456, 6375.330590288046, 6460.676966151674, 6429.45349645276, 6584.967075164689, 6665.233498147678, 6671.032700258435, 6671.232808227019, 6167.784127555514, 6540.117084193668, 6544.934550654432, 6556.606603603799, 6566.4418524425955, 6378.585391949601, 6527.967360163168, 6560.573562718408, 6615.536912416181, 6630.834229144213, 5250.7637156328055, 5256.26412302278, 5261.289725886956, 5272.446393128666, 5300.310959575308, 4693.7653117344, 4699.835505757282, 4706.082313948816, 4709.152352576569, 4752.928706069411, 6121.401995308023, 6141.854248382324, 6233.812985610348, 6289.937100629027, 6334.809955701337, 6649.833754156185, 6680.098186744727, 6683.4987375947, 6689.966550167315, 6702.0282059101155, 6278.152449419361, 6329.145565348619, 6339.683015849189, 6343.207099112611, 6344.587601805868, 5641.915371269352, 5765.538756899438, 5809.0, 5810.970945145247, 5821.53427725781, 6708.295628959084, 6727.798166055026, 6734.898976515454, 6736.461083113437, 6744.190697116377, 6479.676016199265, 6492.513061520499, 6493.707783149675, 6498.512611554058, 6499.902501462577, 6832.145981752281, 6863.450923926173, 6904.3095690432565, 6908.1019467468905, 6922.61925594077, 6553.5084868634085, 6561.737530498726, 6563.704633291418, 6582.17722784652, 6583.407493325623, 6540.934590654033, 6654.168228971379, 6711.362420570038, 6716.261211266855, 6728.697208625722, 6284.717187726472, 6341.270753863365, 6360.427561519486, 6395.552311338161, 6483.935160648333, 5372.811951581676, 6470.838229044123, 6481.449076828522, 6496.935030649633, 6501.9674901625185, 6370.55406121567, 6373.107764913008, 6378.808635740936, 6379.393957574023, 6381.425671689571, 6455.741770329134, 6465.967670161619, 6486.0, 6500.739970401131, 6517.087607735016, 6243.656598887105, 6278.246610406781, 6283.49732021428, 6312.242530896322, 6358.364163583605], "value": 6032.900303997283, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.3436515032691, 691.5539477037311, 754.7320701151091, 1074.6883403812894, 1122.9719257018578, 26364.736352636468, 32554.348913021724, 33086.0, 33203.50194747081, 33356.33287334258, 35278.061071450014, 35543.466847997304, 35686.46470302947, 35700.821495892545, 35762.64237357626, 6050.062240352752, 8192.443435747204, 8372.58137093143, 8379.83240335193, 8384.622691978846, 6038.75844966203, 7612.847743045136, 8574.056853746082, 8593.613287402051, 8635.093315201908, 8655.0, 8684.43551169172, 8689.348298877578, 8692.565371731389, 8696.956515217415, 8584.442011269248, 8646.481211127353, 8652.740417787476, 8653.307735381155, 8694.869576956382, 5961.314448838352, 6056.878862422771, 6827.863442731117, 8352.457090289172, 8374.330053595697, 37168.628313716785, 37335.626643733485, 37348.87953361403, 37362.62637373619, 37403.0, 3454.9481757773656, 3492.388831954398, 3493.6855682988653, 3499.61504234534, 3511.087117349482, 30536.08391748229, 30658.92693755708, 30660.693393066005, 30687.386252275053, 30843.38313233745, 3098.7366073883745, 3144.9685503144906, 3164.889228877001, 3181.125190572588, 3191.2181515528846, 284267.0, 292835.0, 293263.5336823324, 293495.53252233815, 294932.0, 48832.75583622059, 48943.510564894605, 49078.0, 49090.754546227756, 49107.75446122818, 51025.744871275405, 51046.74476627667, 51093.0, 51143.0, 51153.0, 14054.71890562183, 14065.929670351787, 14103.78844317336, 14112.71774564503, 14121.78817317741, 9922.851157232648, 11360.375179365048, 11492.253003554742, 11507.136964727511, 11508.251963622337, 10352.637657681946, 10417.5832966682, 11812.468438920268, 11942.582009629621, 12017.399130043463, 5435.7825686972865, 5437.265969094122, 5444.292242008592, 5445.53712934405, 5452.809151679672, 1002.9398236105857, 1003.8895721470633, 1004.8392257238806, 1024.062982371137, 1033.994830025845, 23391.41521461977, 24106.156284529956, 24309.149179778622, 24379.756202438104, 24418.389540261636, 968.970930872075, 999.5801763259449, 1116.8273313021296, 1124.9493772780245, 1130.8021096308114, 11709.423926736104, 12300.384980750927, 12318.521777386772, 12323.630291091282, 12355.32045737493, 316341.0, 316731.0, 317023.0, 317293.0, 317769.41115294275, 52031.47968520342, 52059.0, 52093.739531302104, 52176.0, 52310.73844630752, 1432.3697573067816, 1478.682083352106, 1490.69440764643, 1493.0444515510083, 1524.9542513724384, 23774.16790412327, 23816.642750358413, 23832.40418989539, 23845.0, 23863.761362386154, 36482.63517364899, 36562.45156322711, 36596.63403365932, 36606.816965915, 36616.90149295525, 291741.0825891714, 291881.0, 292643.0, 292652.0, 292782.0, 32227.838860805547, 32487.0, 32545.511817322287, 33294.00117996464, 33444.66555334415, 43406.56593434025, 43729.0, 43942.560574395124, 43951.34072988844, 43998.120037598426, 28264.576031359957, 28493.0, 29315.413691726473, 30374.84812575923, 30541.694583054774, 23951.640725389483, 29302.560461592668, 29523.704762952097, 30059.0, 30656.846715766278, 36383.45424818683, 36411.35623978288, 36420.81789591035, 36426.0, 36450.45324320084, 26828.926842926063, 29743.55384669275, 30416.69583304227, 31208.21979450532, 31554.36891262116, 22245.666315004964, 23686.881565592063, 24222.63666045046, 24256.393590160387, 24272.02911883505], "value": 16957.726340657522, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.1579314989896, 423.6428334578855, 436.40866625722134, 444.50437761895483, 445.38759206091623, 17042.82957170428, 21156.365309040713, 21482.248121315755, 22516.0, 22844.428889277777, 22226.444338891535, 22626.321210363676, 22870.65694014587, 23266.883665581692, 23282.0, 4626.259798432252, 5957.553183511243, 6179.876402471948, 6219.222597175353, 6236.282827474854, 6042.848928776772, 6170.907436388436, 6177.567570270083, 6179.19670442844, 6183.134361189437, 5928.703564821763, 6050.788222412217, 6052.788152414666, 6108.297545782225, 6123.357047510014, 5897.4102589741115, 6066.454019138277, 6087.512998960073, 6133.877322453571, 6134.263888333407, 5436.782528698847, 5494.945050549483, 5501.064818980783, 5505.256790333294, 5533.944660553423, 26061.60907586388, 26983.190504284903, 27333.316667083283, 27779.305517362027, 27930.0, 2150.1721837092678, 2190.167736260227, 2203.5813195492965, 2203.6584329428965, 2204.713387259662, 15080.472183473636, 18438.078096095276, 18539.35112271064, 18544.2582296708, 18649.0, 1854.2026928420773, 1856.0441372693074, 1904.7619047619048, 1994.112619884152, 2072.0365030261, 133572.0, 149152.2542387292, 164180.0, 167421.0, 170304.0, 11412.885871141349, 11541.0, 11723.120765942589, 12207.145499815106, 12230.510779568718, 14131.434742610387, 15175.0, 15179.0, 15190.164540950133, 15205.239738013055, 8788.16512431318, 8963.05887881763, 8990.955045224731, 9119.270458363315, 9137.862932056025, 8550.33229133953, 8557.716342548543, 8610.698625548075, 8787.209151176425, 8803.911960880308, 7653.425993050543, 7730.982761263061, 7766.534007959541, 7796.454248202572, 7847.176046515034, 1858.5446565591517, 2193.396815875615, 2197.2748992832326, 2212.579609874119, 2372.8813559321966, 848.1171798607082, 907.1336873285996, 932.5057719408725, 952.4618590496348, 964.1659964130977, 20642.380728578166, 21118.465784106007, 21135.365939021853, 21186.94065296729, 21315.46711332229, 876.548577482597, 952.6094301336558, 957.5882370580717, 960.2989817433313, 995.785906030207, 10235.488225588691, 10918.0, 10942.069924056545, 10951.726206844893, 10960.725981850517, 491541.0, 515756.0, 516235.0, 520633.0, 528553.3572332191, 133801.0, 135615.0, 136352.0, 136708.0, 136874.0, 1113.4265853085506, 1147.6098126636984, 1168.7428765671539, 1169.2516789254885, 1170.9473073711704, 16706.0, 18085.81914180894, 18131.184096715417, 18132.818671813115, 18172.09139543044, 57689.84620307486, 57770.0, 58015.12977305259, 58330.0, 58979.70510147422, 79744.60127699324, 80011.59994199991, 81905.77141343003, 82669.58665206635, 82784.0, 8353.955755530558, 8652.524111173945, 8768.035516093098, 8823.867641985504, 9188.059820857528, 11381.0, 14133.293335333397, 14322.113450449144, 14475.493357732428, 14584.85415145835, 10074.848877266993, 11850.762984740084, 11988.100892433276, 12061.457234424648, 12217.823365924745, 11168.888311116785, 11179.385133817394, 11286.492107855001, 11537.538498459968, 11567.595134170264, 11779.35213563228, 11915.140366312196, 12152.817707734568, 12239.20445171061, 12263.386830658254, 8660.696875609323, 8707.564621768759, 8750.256228220673, 9155.313351498531, 9280.860787088333, 9749.22006239485, 10498.842517362093, 11306.547738090385, 11889.28664280146, 12147.57483488109], "value": 10300.297327750466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.8281464816898, 1427.9714405711886, 1441.6251774538616, 1443.1846007006047, 1445.8048163497929, 11150.386728729916, 11622.128340374475, 11624.593139240129, 11638.127140464456, 11641.767164656701, 10910.399928003957, 11534.134939879501, 11558.65324040278, 11573.826392604096, 11616.651500454978, 2476.2076135636557, 2517.332906779705, 2520.420303330235, 2523.671922650053, 2527.431327951215, 2069.8758074515576, 2357.669926210332, 2470.9135180268695, 2478.045952308365, 2479.119912431088, 2039.3474088291753, 2065.7521097468325, 2435.0868424340874, 2543.4785868896925, 2559.513692398448, 2472.9010839566395, 2497.2383423055962, 2518.848869067862, 2522.205505265835, 2533.9873300633562, 2511.3596033011463, 2528.759767822054, 2535.2774459279017, 2538.746125387465, 2540.5173017126685, 11024.228304018721, 11288.54845806175, 11306.265092768943, 11318.094552435785, 11319.0, 5523.392426833045, 6354.459870910978, 6609.173853268341, 6619.106420633201, 6630.370114839131, 3769.754965927206, 3950.9012274693077, 4119.258533463975, 4135.503739551243, 4227.7463352198965, 1242.0, 1247.1830950727287, 1278.7058976435378, 1300.4408104515055, 1301.290796515901, 15754.188268349057, 16182.676346473123, 16186.271617777229, 16188.028718276822, 16210.837891621051, 5700.812260842613, 5801.245838041028, 5914.378990206053, 6094.481969032593, 6150.077488376779, 13679.521216757366, 13714.862851371558, 13732.244726540137, 13732.725345493034, 13742.587722368346, 6734.393904548614, 6738.191417029988, 6738.764143254963, 6744.6627668616375, 6749.021391898147, 5736.971315143398, 6107.4197951194565, 6193.0, 6201.069839524017, 6208.627482350983, 3975.483187185705, 4475.142815731435, 4610.956768532752, 4625.444946606429, 4684.086603112429, 1404.487362112842, 1445.8843292536571, 1446.7323545144181, 1467.5744034229954, 1469.882409407245, 675.9560628559128, 723.2008630463367, 803.61426515273, 810.1938571121772, 827.5200383777394, 6443.677816109176, 6552.679529740678, 6839.487038472134, 6894.24163342032, 6960.164780226405, 584.4155844155844, 597.8176656119838, 605.7122866638312, 605.742559412248, 693.7017082654406, 4234.047339348684, 4249.128928569636, 4250.3836943643, 4382.737035777864, 4387.627051700578, 14241.64395890111, 14814.037087589271, 14917.925410372878, 14918.179500127597, 14959.952803303664, 14075.648108797157, 14592.562223133324, 14598.635034124232, 14603.342849571794, 14608.561743147722, 8052.597370131587, 8291.709790157316, 8295.253427191461, 8300.626471808782, 8314.459560128573, 6511.153550038464, 6815.2162501311, 6965.721371145098, 6965.79102626922, 7008.439324853897, 12834.037447191311, 12846.807297890353, 13243.337833108113, 13267.137636053625, 13279.203247805162, 13360.599182024554, 13391.522568324892, 13391.933040334736, 13516.459341626225, 13721.725565488434, 8983.550822458721, 9250.4912229828, 9252.259819214582, 9253.259739220712, 9277.62889484413, 10210.846837297595, 10433.895661043292, 10598.9930956559, 10686.0, 10787.244892857425, 8983.236424903695, 9020.05289444599, 9106.726798196065, 9149.496777677292, 9209.723708288762, 8711.607977641148, 8913.50975696317, 8949.105089490999, 8960.775980600276, 9166.17504424605, 8091.271785539329, 8200.097989221062, 8201.917980820353, 8202.630881610223, 8205.79485512867, 5295.867603309948, 5846.94153058464, 5989.131575921554, 6056.728087101758, 6120.0, 5852.356240813592, 5934.643921364559, 5955.880882382415, 6151.784687535915, 6302.71637776292], "value": 5327.683137057749, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.3482331335493, 369.56391458079463, 386.8123959879458, 408.8058172368126, 413.2891426745996, 4938.580220681242, 5958.64248145111, 5972.970135149319, 6021.638701677897, 6029.246344206974, 4293.656507479402, 5319.654222475537, 5588.960029589201, 5837.620554663944, 5950.404959504048, 4289.313709806432, 4290.313549832027, 4299.097189590189, 4312.878651550588, 4322.459692538433, 3930.4693866327966, 3992.141689536749, 4303.053328267776, 4320.805563749639, 4325.697201195918, 3743.9438408423894, 4001.339778936472, 4124.525679546846, 4214.536400995903, 4223.746575205498, 4210.873673789792, 4213.220554197453, 4217.641500472463, 4224.239636865363, 4225.070484493406, 3379.4761811919193, 3636.5090712753704, 3645.6172101929183, 3661.5972243053243, 3669.6880765134997, 5579.6652200868075, 5669.6314739541795, 5718.79984200551, 5730.828075157752, 5732.828015159552, 4108.952217184598, 4186.874393768192, 4551.52209018055, 4993.725345106018, 5007.69953802773, 5422.891542169174, 6214.968925155391, 6219.937800622027, 6236.729963181105, 6258.49932005443, 3451.8446669899913, 3574.3923532999193, 3794.772313661189, 4173.812178451977, 4192.392103145057, 5482.479164479368, 5982.581219314649, 6327.746890124389, 6510.218773747086, 6663.600183988928, 4103.712740108163, 4112.958870411318, 4115.382692596075, 4120.711550191518, 4135.731177473514, 3634.7819130852236, 3835.76985380878, 4244.214820258262, 4263.104748002892, 4283.250431174532, 4166.479190101238, 5043.697378157322, 5048.16705243638, 5050.949490505048, 5061.772220250097, 5991.0, 6049.001914684028, 6075.210222671113, 6292.402221788922, 6303.604630240571, 1282.7242142939313, 1420.2117824607235, 1459.3360021190333, 1459.8321193062934, 1471.5732437593192, 778.8130848596296, 805.8589746794288, 923.3905622289257, 953.5137080089066, 954.8949615542285, 5923.99422487997, 5949.315828679671, 5969.134475501028, 5972.343042265347, 6015.669138197353, 6509.544331896722, 6553.0, 6561.212654481397, 6580.177477815273, 6614.768483103068, 5095.26118712792, 5542.196381524656, 5999.820005399845, 6022.879542409128, 6034.728437220336, 2897.391547774991, 3136.2002689314536, 3405.1657343950396, 3430.089697744573, 3431.9485207721405, 6417.422431981144, 6645.900311495331, 6690.431313338323, 6743.932560674429, 6799.32006799326, 6092.299385570627, 6620.371064748938, 6683.966580167068, 6697.0, 6707.798766037026, 5206.973965130226, 6274.0, 6481.319461456574, 6642.767503137367, 6678.699458524281, 6173.660448675366, 6320.146780184617, 6341.302456729663, 6344.238691357066, 6520.347965203442, 6265.404786545271, 6293.3008087815115, 6310.5898116622275, 6347.650879201688, 6373.808785736435, 5945.449279415205, 6387.5209359297305, 6688.130543029375, 6803.897941530782, 6832.316768323128, 4747.928781068218, 4800.73595952226, 4804.42346918372, 4804.95195048059, 4836.419629644465, 6071.144823037314, 6305.464035557029, 6604.933950660624, 6679.532432729857, 6702.798916032527, 6369.808905732835, 6378.0, 6396.648184349905, 6404.295527491879, 6434.613923164625, 5587.860303492445, 6171.290301615192, 6397.776077837253, 6424.807255782334, 6425.325340839145, 5691.0, 6096.22621707131, 6213.782517611862, 6236.376362363727, 6244.469220116341, 5324.4675532446445, 6390.392912673288, 6403.8719225614295, 6412.61524308543, 6434.324395938359, 6094.238220222473, 6133.264008318852, 6179.598326108789, 6243.37566243372, 6309.589876658002], "value": 4545.633704709374, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.3801454719846, 730.7990302666766, 857.2970164465141, 859.5573279760924, 874.1782724239216, 13186.0, 18243.361482348122, 18263.452096437093, 18780.718289225657, 18841.0, 15606.297716602752, 15869.285882135302, 15883.36466541337, 15887.84112158878, 15900.840991590081, 926.745145085102, 929.0570071377557, 930.1489137439235, 930.3487558708897, 932.822763674903, 650.2749434380679, 665.8801415745164, 860.561113831944, 922.3866129024191, 959.3236768078488, 1013.7921726046143, 1014.2899970021015, 1014.7919676466307, 1015.3704703084098, 1015.7511409704633, 1010.8837483689397, 1014.4268488304084, 1015.9746006349826, 1017.8269694152012, 1018.623109449501, 744.2966396755069, 746.6229554075157, 746.9103707555074, 748.5920173505452, 752.3567349915853, 15938.760918586231, 16199.352025919066, 16503.009819410752, 17324.566885827957, 17444.651106977915, 16516.50450486487, 16677.666446671, 16917.661646766996, 16943.0, 17317.653646927116, 13941.302934853216, 14063.578092657237, 14076.0, 14247.78628320576, 14257.572272831832, 3518.472229165646, 3545.6454354564594, 3547.255076433952, 3548.361294966905, 3551.2187318789825, 124765.37617311947, 124947.0, 125117.0, 125510.0, 127743.0, 13001.674958126123, 13128.277944713132, 13245.403956821967, 13364.5322413717, 13418.530351437652, 24623.876880615484, 24724.505509890063, 25212.873935630203, 25608.359791005, 25686.871565642425, 7860.528368297806, 7869.527828330319, 7946.284834364935, 8027.6788928443375, 8079.111297757242, 3749.512563366745, 3925.9018524537114, 3992.580779018161, 3996.540397854226, 3997.3804060370107, 4254.617084462413, 4317.568243175658, 4347.108842687305, 4379.671524635602, 4400.867973960786, 917.4311926605548, 941.4022095969109, 943.551812888886, 946.4983558713893, 948.7485816258697, 553.4963183502992, 640.4876099120685, 646.0761111610442, 651.9641419721866, 661.5798967655477, 11278.54885804575, 11295.604653837076, 11593.130515211393, 11604.73333962863, 12091.697707557381, 627.6662093052264, 661.5336187987457, 670.2660586657602, 687.8074139241021, 691.4364792694039, 5304.549113325411, 5379.273798037215, 5535.33575970878, 5588.704849331487, 5604.775808967595, 115118.0, 116114.0, 116869.0, 117089.0, 117761.0, 77029.0, 83371.5831420839, 97229.0, 97268.51365743126, 99474.50262748639, 60490.0, 75693.62153189199, 78708.03229919184, 79073.60463197647, 81405.99999999882, 9952.0, 12121.787821217808, 12135.817962730389, 12278.754424911273, 13056.020798439966, 35909.46135807913, 36616.0, 36731.63268367282, 36880.0, 38225.4266186013, 65400.0, 69135.3086469149, 69911.0, 70121.0, 71317.64341178261, 16244.756328654843, 16434.589135271715, 16984.065876376422, 16990.065546395068, 17032.82967170362, 17774.022428766024, 18131.36540221086, 18400.539986500444, 18420.907895460972, 18555.35056273024, 16574.08842513673, 17224.569385765455, 17466.476005719847, 17502.299908004046, 17616.73574896403, 16700.83299166993, 16707.66584668324, 17449.865758725642, 17463.214155363294, 17607.383741568985, 13506.459741610226, 16604.920680155752, 17237.827621723623, 17241.568960775578, 17341.65316693634, 10417.791644166922, 10785.298955567863, 11775.823362649397, 11841.763164736829, 12111.636650900487, 12175.878241217475, 12326.568570100362, 13586.048976571545, 13754.793678094637, 13867.583972480841], "value": 8333.143250184456, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1439.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 110.0, 110.0, 110.0, 111.0, 108.0, 112.0, 109.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 108.0, 104.0, 146.0, 106.0, 106.0, 119.0, 105.0, 136.0, 125.0], "value": 118.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 187.0, 185.0, 187.0, 187.0, 186.0, 184.0, 185.0, 181.0], "value": 185.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 58.0, 89.0, 58.0, 64.0, 85.0, 80.0, 92.0, 59.0], "value": 72.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 87.0, 54.0, 68.0, 78.0, 108.0, 103.0, 101.0, 99.0], "value": 85.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 89.0, 89.0, 90.0, 90.0, 89.0, 89.0, 91.0, 95.0], "value": 90.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0], "value": 97.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 108.0, 127.0, 84.0, 85.0, 84.0, 81.0, 85.0, 84.0, 81.0], "value": 90.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 49.0, 49.0, 49.0, 48.0, 51.0, 49.0, 48.0, 50.0], "value": 49.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 59.0, 67.0, 68.0, 62.0, 56.0, 58.0, 56.0, 57.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 81.0, 83.0, 71.0, 98.0, 95.0, 103.0, 89.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 136.0, 135.0, 146.0, 131.0, 138.0, 140.0, 191.0, 160.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 183.0, 185.0, 182.0, 186.0, 184.0, 185.0, 181.0, 178.0, 184.0], "value": 182.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 66.0, 68.0, 67.0, 68.0, 69.0, 68.0, 67.0], "value": 67.5, "unit": "score"}]}]} 04:15:53 INFO - Return code: 0 04:15:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:15:53 ERROR - # TBPL SUCCESS # 04:15:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:15:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:15:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:15:53 INFO - 2017-05-02 04:15:53.455 screenresolution[1656:9913] starting screenresolution argv=screenresolution get 04:15:53 INFO - 2017-05-02 04:15:53.457 screenresolution[1656:9913] Display 0: 1600x1200x32@60 04:15:53 INFO - 2017-05-02 04:15:53.463 screenresolution[1657:9916] starting screenresolution argv=screenresolution list 04:15:53 INFO - Available Modes on Display 0 04:15:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:15:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:15:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:15:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:15:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:15:53 INFO - Intel Iris: 04:15:53 INFO - Chipset Model: Intel Iris 04:15:53 INFO - Type: GPU 04:15:53 INFO - Bus: Built-In 04:15:53 INFO - VRAM (Dynamic, Max): 1536 MB 04:15:53 INFO - Vendor: Intel (0x8086) 04:15:53 INFO - Device ID: 0x0a2e 04:15:53 INFO - Revision ID: 0x0009 04:15:53 INFO - Displays: 04:15:53 INFO - Display: 04:15:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:15:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:15:53 INFO - Display Serial Number: 1600x1200 60 04:15:53 INFO - Main Display: Yes 04:15:53 INFO - Mirror: Off 04:15:53 INFO - Online: Yes 04:15:53 INFO - Rotation: Supported 04:15:53 INFO - Return code: 0 04:15:53 INFO - Running post-action listener: _resource_record_post_action 04:15:53 INFO - [mozharness: 2017-05-02 11:15:53.701478Z] Finished run-tests step (success) 04:15:53 INFO - Running post-run listener: _resource_record_post_run 04:15:53 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 40412672; Write bytes: 511580160; Read time: 400; Write time: 2197 04:15:53 INFO - TinderboxPrint: CPU usage
53.5% 04:15:53 INFO - TinderboxPrint: I/O read bytes / time
40,412,672 / 400 04:15:53 INFO - TinderboxPrint: I/O write bytes / time
511,580,160 / 2,197 04:15:53 INFO - TinderboxPrint: CPU idle
2,236.8 (46.5%) 04:15:53 INFO - TinderboxPrint: CPU system
958.5 (19.9%) 04:15:53 INFO - TinderboxPrint: CPU user
1,610.4 (33.5%) 04:15:53 INFO - TinderboxPrint: Swap in / out
247,459,840 / 0 04:15:53 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206029312; Write bytes: 205301760; Read time: 16050; Write time: 432 04:15:53 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 35333632; Write bytes: 299077632; Read time: 366; Write time: 1737 04:15:54 INFO - Running post-run listener: _upload_blobber_files 04:15:54 INFO - Blob upload gear active. 04:15:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:15:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:15:54 INFO - (blobuploader) - INFO - Open directory for files ... 04:15:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:15:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:15:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:15:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:15:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:15:55 INFO - (blobuploader) - INFO - Done attempting. 04:15:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:15:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:15:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:15:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:15:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:15:56 INFO - (blobuploader) - INFO - Done attempting. 04:15:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:15:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:15:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:15:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:15:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:15:57 INFO - (blobuploader) - INFO - Done attempting. 04:15:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:15:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:15:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:15:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:15:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:15:59 INFO - (blobuploader) - INFO - Done attempting. 04:15:59 INFO - (blobuploader) - INFO - Iteration through files over. 04:15:59 INFO - Return code: 0 04:15:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:15:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:15:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01040f1a977a5144139026319d285ceacc7d108058958c40b689aadc0a7ea418b91e4532c5d4fd8a00a8be31bce90bab37d9a416d3c6f043556cd5bb7bbaac96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f82d71f2e07f8c100b9495dbfd03600f35c3ec17240815c693748c799f8d7001ca6eabc21f4a1ab33a204acf0c493006ecd8d4046320611f3f5c459565c3b6f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e699d7ace193756ba1f49e4209dd551ec9f460e76a4b6f6a5d7ca0fdb8aa2bd0d56d123ea169447e4ebb42ed598c2ba3d7f5b47a6a3a08456a13c833d715a5d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5031a7c326202b9a22e9295a5fd20bdaa5fc3a7eeacc7e3e83c01f01c4691b46e97125cc7d7c614b3fe553538c8dfac194b0e761493f011bab42e6f1e185e2ac"} 04:15:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:15:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:15:59 INFO - Contents: 04:15:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01040f1a977a5144139026319d285ceacc7d108058958c40b689aadc0a7ea418b91e4532c5d4fd8a00a8be31bce90bab37d9a416d3c6f043556cd5bb7bbaac96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f82d71f2e07f8c100b9495dbfd03600f35c3ec17240815c693748c799f8d7001ca6eabc21f4a1ab33a204acf0c493006ecd8d4046320611f3f5c459565c3b6f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e699d7ace193756ba1f49e4209dd551ec9f460e76a4b6f6a5d7ca0fdb8aa2bd0d56d123ea169447e4ebb42ed598c2ba3d7f5b47a6a3a08456a13c833d715a5d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5031a7c326202b9a22e9295a5fd20bdaa5fc3a7eeacc7e3e83c01f01c4691b46e97125cc7d7c614b3fe553538c8dfac194b0e761493f011bab42e6f1e185e2ac"} 04:15:59 INFO - Running post-run listener: copy_logs_to_upload_dir 04:15:59 INFO - Copying logs to upload dir... 04:15:59 INFO - mkdir: /builds/slave/test/build/upload/logs 04:15:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.875509 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-05-02 04:15:59.470655) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 04:15:59.474319) ========= 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.lyEgk1BY6z/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.8ZUUZpHz7K/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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/01040f1a977a5144139026319d285ceacc7d108058958c40b689aadc0a7ea418b91e4532c5d4fd8a00a8be31bce90bab37d9a416d3c6f043556cd5bb7bbaac96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f82d71f2e07f8c100b9495dbfd03600f35c3ec17240815c693748c799f8d7001ca6eabc21f4a1ab33a204acf0c493006ecd8d4046320611f3f5c459565c3b6f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e699d7ace193756ba1f49e4209dd551ec9f460e76a4b6f6a5d7ca0fdb8aa2bd0d56d123ea169447e4ebb42ed598c2ba3d7f5b47a6a3a08456a13c833d715a5d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5031a7c326202b9a22e9295a5fd20bdaa5fc3a7eeacc7e3e83c01f01c4691b46e97125cc7d7c614b3fe553538c8dfac194b0e761493f011bab42e6f1e185e2ac"} build_url:https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011414 build_url: 'https://queue.taskcluster.net/v1/task/LFL5y9haRCiRXxpPL1PcKw/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/01040f1a977a5144139026319d285ceacc7d108058958c40b689aadc0a7ea418b91e4532c5d4fd8a00a8be31bce90bab37d9a416d3c6f043556cd5bb7bbaac96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f82d71f2e07f8c100b9495dbfd03600f35c3ec17240815c693748c799f8d7001ca6eabc21f4a1ab33a204acf0c493006ecd8d4046320611f3f5c459565c3b6f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e699d7ace193756ba1f49e4209dd551ec9f460e76a4b6f6a5d7ca0fdb8aa2bd0d56d123ea169447e4ebb42ed598c2ba3d7f5b47a6a3a08456a13c833d715a5d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5031a7c326202b9a22e9295a5fd20bdaa5fc3a7eeacc7e3e83c01f01c4691b46e97125cc7d7c614b3fe553538c8dfac194b0e761493f011bab42e6f1e185e2ac"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 04:15:59.509510) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 04:15:59.509837) ========= 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.lyEgk1BY6z/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.8ZUUZpHz7K/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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.005223 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 04:15:59.558962) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 04:15:59.559274) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 04:15:59.559653) ========= ========= Total master_lag: 0.18 =========