builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0375 starttime: 1484152489.07 results: success (0) buildid: 20170111072206 builduid: 91cfbf4d0a3640fbae73800149b98262 revision: 5493551203ed0b78b47c944c49d9908e446b4b2d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 08:34:49.069353) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 08:34:49.069807) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 08:34:49.070090) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 08:34:49.118455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 08:34:49.118870) ========= 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.V4woBDST4I/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.euA1xGJ4Ao/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-11 08:34:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.1M=0.001s 2017-01-11 08:34:49 (11.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120931 ========= master_lag: 0.56 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 08:34:49.796888) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 08:34:49.797198) ========= 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.V4woBDST4I/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.euA1xGJ4Ao/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.019440 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 08:34:49.844296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-11 08:34:49.847753) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5493551203ed0b78b47c944c49d9908e446b4b2d --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 5493551203ed0b78b47c944c49d9908e446b4b2d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.V4woBDST4I/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.euA1xGJ4Ao/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-11 08:34:49,911 truncating revision to first 12 chars 2017-01-11 08:34:49,911 Setting DEBUG logging. 2017-01-11 08:34:49,911 attempt 1/10 2017-01-11 08:34:49,911 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5493551203ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-11 08:34:51,136 unpacking tar archive at: mozilla-central-5493551203ed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.488935 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-11 08:34:51.360240) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 08:34:51.363722) ========= script_repo_revision: 5493551203ed0b78b47c944c49d9908e446b4b2d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 08:34:51.364257) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 08:34:51.364545) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 08:34:51.384560) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-11 08:34:51.384949) ========= /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.V4woBDST4I/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.euA1xGJ4Ao/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 08:34:51 INFO - MultiFileLogger online at 20170111 08:34:51 in /builds/slave/test 08:34:51 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 08:34:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:34:51 INFO - {'append_to_log': False, 08:34:51 INFO - 'base_work_dir': '/builds/slave/test', 08:34:51 INFO - 'blob_upload_branch': 'Firefox', 08:34:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:34:51 INFO - 'branch': 'Firefox', 08:34:51 INFO - 'buildbot_json_path': 'buildprops.json', 08:34:51 INFO - 'config_files': ('talos/mac_config.py',), 08:34:51 INFO - 'default_actions': ('clobber', 08:34:51 INFO - 'read-buildbot-config', 08:34:51 INFO - 'download-and-extract', 08:34:51 INFO - 'populate-webroot', 08:34:51 INFO - 'create-virtualenv', 08:34:51 INFO - 'install', 08:34:51 INFO - 'run-tests'), 08:34:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:34:51 INFO - 'download_minidump_stackwalk': True, 08:34:51 INFO - 'download_symbols': 'ondemand', 08:34:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:34:51 INFO - 'tooltool.py': '/tools/tooltool.py', 08:34:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:34:51 INFO - '/tools/misc-python/virtualenv.py')}, 08:34:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:34:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:34:51 INFO - 'installer_path': 'installer.exe', 08:34:51 INFO - 'log_level': 'info', 08:34:51 INFO - 'log_name': 'talos', 08:34:51 INFO - 'log_to_console': True, 08:34:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:34:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:34:51 INFO - 'opt_config_files': (), 08:34:51 INFO - 'pip_index': False, 08:34:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:34:51 INFO - 'cmd': ('bash', 08:34:51 INFO - '-c', 08:34:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:34:51 INFO - 'enabled': True, 08:34:51 INFO - 'halt_on_failure': False, 08:34:51 INFO - 'name': 'check_screen_resolution'},), 08:34:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:34:51 INFO - 'cmd': ('bash', 08:34:51 INFO - '-c', 08:34:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:34:51 INFO - 'enabled': True, 08:34:51 INFO - 'halt_on_failure': False, 08:34:51 INFO - 'name': 'check_screen_resolution'},), 08:34:51 INFO - 'run_cmd_checks_enabled': True, 08:34:51 INFO - 'sps_profile': False, 08:34:51 INFO - 'sps_profile_interval': 0, 08:34:51 INFO - 'suite': 'dromaeojs', 08:34:51 INFO - 'system_bits': '32', 08:34:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:34:51 INFO - 'title': 't-yosemite-r7-0375', 08:34:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:34:51 INFO - 'use_talos_json': True, 08:34:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:34:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:34:51 INFO - 'work_dir': 'build'} 08:34:51 INFO - [mozharness: 2017-01-11 16:34:51.576004Z] Running clobber step. 08:34:51 INFO - Running pre-action listener: _resource_record_pre_action 08:34:51 INFO - Running main action method: clobber 08:34:51 INFO - rmtree: /builds/slave/test/build 08:34:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:34:53 INFO - Running post-action listener: _resource_record_post_action 08:34:53 INFO - [mozharness: 2017-01-11 16:34:53.077649Z] Finished clobber step (success) 08:34:53 INFO - [mozharness: 2017-01-11 16:34:53.077772Z] Running read-buildbot-config step. 08:34:53 INFO - Running pre-action listener: _resource_record_pre_action 08:34:53 INFO - Running main action method: read_buildbot_config 08:34:53 INFO - Using buildbot properties: 08:34:53 INFO - { 08:34:53 INFO - "project": "", 08:34:53 INFO - "product": "firefox", 08:34:53 INFO - "script_repo_revision": "production", 08:34:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:34:53 INFO - "repository": "", 08:34:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:34:53 INFO - "buildid": "20170111072206", 08:34:53 INFO - "pgo_build": "False", 08:34:53 INFO - "basedir": "/builds/slave/test", 08:34:53 INFO - "buildnumber": 52, 08:34:53 INFO - "slavename": "t-yosemite-r7-0375", 08:34:53 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:34:53 INFO - "platform": "yosemite_r7", 08:34:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:34:53 INFO - "branch": "mozilla-central", 08:34:53 INFO - "repo_path": "mozilla-central", 08:34:53 INFO - "revision": "5493551203ed0b78b47c944c49d9908e446b4b2d", 08:34:53 INFO - "stage_platform": "macosx64", 08:34:53 INFO - "builduid": "91cfbf4d0a3640fbae73800149b98262", 08:34:53 INFO - "slavebuilddir": "test" 08:34:53 INFO - } 08:34:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:34:53 INFO - Running post-action listener: _resource_record_post_action 08:34:53 INFO - [mozharness: 2017-01-11 16:34:53.081110Z] Finished read-buildbot-config step (success) 08:34:53 INFO - [mozharness: 2017-01-11 16:34:53.081212Z] Running download-and-extract step. 08:34:53 INFO - Running pre-action listener: _resource_record_pre_action 08:34:53 INFO - Running main action method: download_and_extract 08:34:53 INFO - mkdir: /builds/slave/test/build/tests 08:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:53 INFO - trying https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:34:53 INFO - Downloading https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:34:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 08:34:54 INFO - Downloaded 1199 bytes. 08:34:54 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:34:54 INFO - Using the following test package requirements: 08:34:54 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:34:54 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:34:54 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:34:54 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:34:54 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:34:54 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:34:54 INFO - u'jsshell-mac.zip'], 08:34:54 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:34:54 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:34:54 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:34:54 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:34:54 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:34:54 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:34:54 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:34:54 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:34:54 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:34:54 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:34:54 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:34:54 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:34:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:34:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:34:54 INFO - Fetch https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:34:56 INFO - Expected file size: 16311496 08:34:56 INFO - Obtained file size: 16311496 08:35:02 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:35:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:35:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:35:02 INFO - Fetch https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:35:03 INFO - Expected file size: 16311496 08:35:03 INFO - Obtained file size: 16311496 08:35:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:35:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:35:09 INFO - Fetch https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:35:11 INFO - Expected file size: 14403529 08:35:11 INFO - Obtained file size: 14403529 08:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:11 INFO - trying https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:35:11 INFO - Downloading https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:35:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 08:35:14 INFO - Downloaded 69816974 bytes. 08:35:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:35:14 INFO - mkdir: /builds/slave/test/properties 08:35:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:35:14 INFO - Writing to file /builds/slave/test/properties/build_url 08:35:14 INFO - Contents: 08:35:14 INFO - build_url:https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:35:15 INFO - Running post-action listener: _resource_record_post_action 08:35:15 INFO - Running post-action listener: set_extra_try_arguments 08:35:15 INFO - [mozharness: 2017-01-11 16:35:15.421798Z] Finished download-and-extract step (success) 08:35:15 INFO - [mozharness: 2017-01-11 16:35:15.421961Z] Running populate-webroot step. 08:35:15 INFO - Running pre-action listener: _resource_record_pre_action 08:35:15 INFO - Running main action method: populate_webroot 08:35:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:35:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:35:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:35:15 INFO - '--tppagecycles', 08:35:15 INFO - '7'], 08:35:15 INFO - 'tests': ['tsvgm']}}, 08:35:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:35:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:35:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:35:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:35:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:35:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:35:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:35:15 INFO - 'talos_options': ['--disable-e10s'], 08:35:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:35:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:35:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:35:15 INFO - 'talos_options': ['--disable-e10s'], 08:35:15 INFO - 'tests': ['damp', 'tps']}, 08:35:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:35:15 INFO - 'tests': ['damp', 'tps']}, 08:35:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:35:15 INFO - 'tests': ['dromaeo_dom']}, 08:35:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:35:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:35:15 INFO - 'tests': ['basic_compositor_video']}, 08:35:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:35:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:35:15 INFO - 'tests': ['a11yr', 08:35:15 INFO - 'ts_paint', 08:35:15 INFO - 'tpaint', 08:35:15 INFO - 'sessionrestore', 08:35:15 INFO - 'sessionrestore_no_auto_restore', 08:35:15 INFO - 'tabpaint']}, 08:35:15 INFO - 'other-e10s': {'tests': ['a11yr', 08:35:15 INFO - 'ts_paint', 08:35:15 INFO - 'tpaint', 08:35:15 INFO - 'sessionrestore', 08:35:15 INFO - 'sessionrestore_no_auto_restore', 08:35:15 INFO - 'tabpaint']}, 08:35:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:35:15 INFO - 'ts_paint', 08:35:15 INFO - 'tpaint', 08:35:15 INFO - 'sessionrestore', 08:35:15 INFO - 'sessionrestore_no_auto_restore', 08:35:15 INFO - 'tabpaint']}, 08:35:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:35:15 INFO - 'ts_paint', 08:35:15 INFO - 'tpaint', 08:35:15 INFO - 'sessionrestore', 08:35:15 INFO - 'sessionrestore_no_auto_restore', 08:35:15 INFO - 'tabpaint']}, 08:35:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:35:15 INFO - 'tests': ['a11yr', 08:35:15 INFO - 'ts_paint', 08:35:15 INFO - 'tpaint', 08:35:15 INFO - 'sessionrestore', 08:35:15 INFO - 'sessionrestore_no_auto_restore', 08:35:15 INFO - 'tabpaint']}, 08:35:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:35:15 INFO - 'tests': ['a11yr', 08:35:15 INFO - 'ts_paint', 08:35:15 INFO - 'tpaint', 08:35:15 INFO - 'sessionrestore', 08:35:15 INFO - 'sessionrestore_no_auto_restore', 08:35:15 INFO - 'tabpaint']}, 08:35:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:35:15 INFO - 'tests': ['tsvgx', 08:35:15 INFO - 'tsvgr_opacity', 08:35:15 INFO - 'tart', 08:35:15 INFO - 'tscrollx', 08:35:15 INFO - 'cart', 08:35:15 INFO - 'tsvg_static']}, 08:35:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:35:15 INFO - 'tsvgr_opacity', 08:35:15 INFO - 'tart', 08:35:15 INFO - 'tscrollx', 08:35:15 INFO - 'cart', 08:35:15 INFO - 'tsvg_static']}, 08:35:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:35:15 INFO - 'talos_options': ['--disable-e10s'], 08:35:15 INFO - 'tests': ['tp5o']}, 08:35:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:35:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:35:15 INFO - 'talos_options': ['--disable-e10s', 08:35:15 INFO - '--xperf_path', 08:35:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:15 INFO - 'tests': ['tp5n']}, 08:35:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:35:15 INFO - 'talos_options': ['--xperf_path', 08:35:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:35:15 INFO - 'tests': ['tp5n']}}, 08:35:15 INFO - 'talos.zip': {'path': '', 08:35:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:35:15 INFO - Running post-action listener: _resource_record_post_action 08:35:15 INFO - [mozharness: 2017-01-11 16:35:15.440418Z] Finished populate-webroot step (success) 08:35:15 INFO - [mozharness: 2017-01-11 16:35:15.440526Z] Running create-virtualenv step. 08:35:15 INFO - Running pre-action listener: _resource_record_pre_action 08:35:15 INFO - Running main action method: create_virtualenv 08:35:15 INFO - Creating virtualenv /builds/slave/test/build/venv 08:35:15 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 08:35:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:35:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:35:15 INFO - Using real prefix '/tools/python27' 08:35:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:35:16 INFO - Installing distribute.............................................................................................................................................................................................done. 08:35:19 INFO - Installing pip.................done. 08:35:19 INFO - Return code: 0 08:35:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:35:19 INFO - Reading from file tmpfile_stdout 08:35:19 INFO - Output received: 08:35:19 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) 08:35:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba9bcb9df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101795d30>, '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 0x1016bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10178abe8>, '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.V4woBDST4I/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.euA1xGJ4Ao/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 08:35:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:35:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4woBDST4I/Render', 08:35:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:19 INFO - 'HOME': '/Users/cltbld', 08:35:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:19 INFO - 'LOGNAME': 'cltbld', 08:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:19 INFO - 'MOZ_NO_REMOTE': '1', 08:35:19 INFO - 'NO_EM_RESTART': '1', 08:35:19 INFO - 'PAGER': '/bin/cat', 08:35:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:19 INFO - 'PWD': '/builds/slave/test', 08:35:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:19 INFO - 'SHELL': '/bin/bash', 08:35:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euA1xGJ4Ao/Listeners', 08:35:19 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 08:35:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:19 INFO - 'USER': 'cltbld', 08:35:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:19 INFO - 'XPC_FLAGS': '0x0', 08:35:19 INFO - 'XPC_SERVICE_NAME': '0', 08:35:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:19 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 08:35:19 INFO - Cleaning up... 08:35:19 INFO - Return code: 0 08:35:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1019b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba9bcb9df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101795d30>, '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 0x1016bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10178abe8>, '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.V4woBDST4I/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.euA1xGJ4Ao/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 08:35:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:35:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4woBDST4I/Render', 08:35:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:19 INFO - 'HOME': '/Users/cltbld', 08:35:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:19 INFO - 'LOGNAME': 'cltbld', 08:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:19 INFO - 'MOZ_NO_REMOTE': '1', 08:35:19 INFO - 'NO_EM_RESTART': '1', 08:35:19 INFO - 'PAGER': '/bin/cat', 08:35:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:19 INFO - 'PWD': '/builds/slave/test', 08:35:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:19 INFO - 'SHELL': '/bin/bash', 08:35:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euA1xGJ4Ao/Listeners', 08:35:19 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 08:35:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:19 INFO - 'USER': 'cltbld', 08:35:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:19 INFO - 'XPC_FLAGS': '0x0', 08:35:19 INFO - 'XPC_SERVICE_NAME': '0', 08:35:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:19 INFO - Downloading/unpacking psutil>=3.1.1 08:35:19 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 08:35:19 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 08:35:19 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 08:35:19 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 08:35:19 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 08:35:19 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 08:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:35:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:23 INFO - Installing collected packages: psutil 08:35:23 INFO - Running setup.py install for psutil 08:35:23 INFO - building 'psutil._psutil_osx' extension 08:35:23 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 08:35:23 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 08:35:23 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 08:35:24 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 08:35:24 INFO - building 'psutil._psutil_posix' extension 08:35:24 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 08:35:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:35:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:35:24 INFO - ^ 08:35:24 INFO - 1 warning generated. 08:35:24 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 08:35:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:24 INFO - Successfully installed psutil 08:35:24 INFO - Cleaning up... 08:35:24 INFO - Return code: 0 08:35:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:35:24 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')]} 08:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:24 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')]} 08:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:24 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 0x1019b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba9bcb9df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101795d30>, '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 0x1016bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10178abe8>, '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.V4woBDST4I/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.euA1xGJ4Ao/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 08:35:24 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 08:35:24 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 08:35:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4woBDST4I/Render', 08:35:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:24 INFO - 'HOME': '/Users/cltbld', 08:35:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:24 INFO - 'LOGNAME': 'cltbld', 08:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:24 INFO - 'MOZ_NO_REMOTE': '1', 08:35:24 INFO - 'NO_EM_RESTART': '1', 08:35:24 INFO - 'PAGER': '/bin/cat', 08:35:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:24 INFO - 'PWD': '/builds/slave/test', 08:35:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:24 INFO - 'SHELL': '/bin/bash', 08:35:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euA1xGJ4Ao/Listeners', 08:35:24 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 08:35:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:24 INFO - 'USER': 'cltbld', 08:35:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:24 INFO - 'XPC_FLAGS': '0x0', 08:35:24 INFO - 'XPC_SERVICE_NAME': '0', 08:35:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:35:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:35:27 INFO - Installing collected packages: mozsystemmonitor 08:35:27 INFO - Running setup.py install for mozsystemmonitor 08:35:27 INFO - Successfully installed mozsystemmonitor 08:35:27 INFO - Cleaning up... 08:35:27 INFO - Return code: 0 08:35:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:35: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')]} 08:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35: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')]} 08:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35: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', '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 0x1019b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba9bcb9df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101795d30>, '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 0x1016bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10178abe8>, '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.V4woBDST4I/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.euA1xGJ4Ao/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 08:35: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:35: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 jsonschema==2.5.1 08:35:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4woBDST4I/Render', 08:35:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:27 INFO - 'HOME': '/Users/cltbld', 08:35:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:27 INFO - 'LOGNAME': 'cltbld', 08:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:27 INFO - 'MOZ_NO_REMOTE': '1', 08:35:27 INFO - 'NO_EM_RESTART': '1', 08:35:27 INFO - 'PAGER': '/bin/cat', 08:35:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:27 INFO - 'PWD': '/builds/slave/test', 08:35:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:27 INFO - 'SHELL': '/bin/bash', 08:35:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euA1xGJ4Ao/Listeners', 08:35:27 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 08:35:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:27 INFO - 'USER': 'cltbld', 08:35:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:27 INFO - 'XPC_FLAGS': '0x0', 08:35:27 INFO - 'XPC_SERVICE_NAME': '0', 08:35:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:27 INFO - Downloading/unpacking jsonschema==2.5.1 08:35: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 08:35: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 08:35: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 08:35: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 08:35: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 08:35: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 08:35:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:35:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:35:30 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 08:35:30 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 08:35:30 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 08:35:30 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 08:35:30 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 08:35:30 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 08:35:30 INFO - Downloading functools32-3.2.3-2.tar.gz 08:35:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:35:31 INFO - warning: no files found matching '*.txt' 08:35:31 INFO - no previously-included directories found matching 'build' 08:35:31 INFO - no previously-included directories found matching 'dist' 08:35:31 INFO - no previously-included directories found matching '.git*' 08:35:31 INFO - Installing collected packages: jsonschema, functools32 08:35:31 INFO - Running setup.py install for functools32 08:35:31 INFO - warning: no files found matching '*.txt' 08:35:31 INFO - no previously-included directories found matching 'build' 08:35:31 INFO - no previously-included directories found matching 'dist' 08:35:31 INFO - no previously-included directories found matching '.git*' 08:35:31 INFO - Successfully installed jsonschema functools32 08:35:31 INFO - Cleaning up... 08:35:31 INFO - Return code: 0 08:35:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:35: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')]} 08:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35: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')]} 08:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:32 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 0x1019b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba9bcb9df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101795d30>, '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 0x1016bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10178abe8>, '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.V4woBDST4I/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.euA1xGJ4Ao/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 08:35:32 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 08:35:32 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 08:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4woBDST4I/Render', 08:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:32 INFO - 'HOME': '/Users/cltbld', 08:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:32 INFO - 'LOGNAME': 'cltbld', 08:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:32 INFO - 'MOZ_NO_REMOTE': '1', 08:35:32 INFO - 'NO_EM_RESTART': '1', 08:35:32 INFO - 'PAGER': '/bin/cat', 08:35:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:32 INFO - 'PWD': '/builds/slave/test', 08:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:32 INFO - 'SHELL': '/bin/bash', 08:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euA1xGJ4Ao/Listeners', 08:35:32 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 08:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:32 INFO - 'USER': 'cltbld', 08:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:32 INFO - 'XPC_FLAGS': '0x0', 08:35:32 INFO - 'XPC_SERVICE_NAME': '0', 08:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:35:32 INFO - Cleaning up... 08:35:32 INFO - Return code: 0 08:35:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:35:32 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')]} 08:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:32 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')]} 08:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:32 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 0x1019b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba9bcb9df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101795d30>, '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 0x1016bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10178abe8>, '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.V4woBDST4I/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.euA1xGJ4Ao/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 08:35:32 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 08:35:32 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 08:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4woBDST4I/Render', 08:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:32 INFO - 'HOME': '/Users/cltbld', 08:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:32 INFO - 'LOGNAME': 'cltbld', 08:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:32 INFO - 'MOZ_NO_REMOTE': '1', 08:35:32 INFO - 'NO_EM_RESTART': '1', 08:35:32 INFO - 'PAGER': '/bin/cat', 08:35:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:32 INFO - 'PWD': '/builds/slave/test', 08:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:32 INFO - 'SHELL': '/bin/bash', 08:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euA1xGJ4Ao/Listeners', 08:35:32 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 08:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:32 INFO - 'USER': 'cltbld', 08:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:32 INFO - 'XPC_FLAGS': '0x0', 08:35:32 INFO - 'XPC_SERVICE_NAME': '0', 08:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:32 INFO - Downloading/unpacking blobuploader==1.2.4 08:35:32 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 08:35:32 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 08:35:32 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 08:35:32 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 08:35:32 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 08:35:32 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 08:35:35 INFO - Downloading blobuploader-1.2.4.tar.gz 08:35:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:35:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:35: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 08:35: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 08:35: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 08:35: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 08:35: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 08:35: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 08:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:35:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:35: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 08:35: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 08:35: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 08:35: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 08:35: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 08:35: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 08:35:36 INFO - Downloading docopt-0.6.1.tar.gz 08:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:35:36 INFO - Installing collected packages: blobuploader, requests, docopt 08:35:36 INFO - Running setup.py install for blobuploader 08:35:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:35:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:35:37 INFO - Running setup.py install for requests 08:35:37 INFO - Running setup.py install for docopt 08:35:37 INFO - Successfully installed blobuploader requests docopt 08:35:37 INFO - Cleaning up... 08:35:37 INFO - Return code: 0 08:35:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35: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')]} 08:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35: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')]} 08:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:37 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 0x1019b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba9bcb9df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101795d30>, '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 0x1016bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10178abe8>, '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.V4woBDST4I/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.euA1xGJ4Ao/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 08:35:37 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 08:35:37 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 08:35:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4woBDST4I/Render', 08:35:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:37 INFO - 'HOME': '/Users/cltbld', 08:35:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:37 INFO - 'LOGNAME': 'cltbld', 08:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:37 INFO - 'MOZ_NO_REMOTE': '1', 08:35:37 INFO - 'NO_EM_RESTART': '1', 08:35:37 INFO - 'PAGER': '/bin/cat', 08:35:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:37 INFO - 'PWD': '/builds/slave/test', 08:35:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:37 INFO - 'SHELL': '/bin/bash', 08:35:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euA1xGJ4Ao/Listeners', 08:35:37 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 08:35:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:37 INFO - 'USER': 'cltbld', 08:35:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:37 INFO - 'XPC_FLAGS': '0x0', 08:35:37 INFO - 'XPC_SERVICE_NAME': '0', 08:35:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:35:38 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-fqdU2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:35:38 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-sId_9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:35:38 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-QWD6u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:35:38 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-lNvUaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:35:38 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-paj909-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:35:38 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-fL9NCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:35:38 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-VpoCfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:35:38 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-tIcj8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:35:38 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-4jRcVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:35:38 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-6Sq3pV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:35:39 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-hkj96S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:35:39 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-7UtvIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:35:39 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-ctWg3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:35:39 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Sk8ald-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:39 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-juQfHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:35:39 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-d5Lx22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:35:39 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-eC4ODc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:35:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:35:39 INFO - Running setup.py install for manifestparser 08:35:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:35:39 INFO - Running setup.py install for mozcrash 08:35:40 INFO - Running setup.py install for mozdebug 08:35:40 INFO - Running setup.py install for mozdevice 08:35:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:35:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:35:40 INFO - Running setup.py install for mozfile 08:35:40 INFO - Running setup.py install for mozhttpd 08:35:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:35:40 INFO - Running setup.py install for mozinfo 08:35:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:35:40 INFO - Running setup.py install for mozInstall 08:35:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:35:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:35:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:35:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:35:40 INFO - Running setup.py install for mozleak 08:35:41 INFO - Running setup.py install for mozlog 08:35:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:35:41 INFO - Running setup.py install for moznetwork 08:35:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:35:41 INFO - Running setup.py install for mozprocess 08:35:41 INFO - Running setup.py install for mozprofile 08:35:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:35:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:35:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:35:41 INFO - Running setup.py install for mozrunner 08:35:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:35:41 INFO - Running setup.py install for mozscreenshot 08:35:42 INFO - Running setup.py install for moztest 08:35:42 INFO - Running setup.py install for mozversion 08:35:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:35:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:35:42 INFO - Cleaning up... 08:35:42 INFO - Return code: 0 08:35:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:42 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 0x1019b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba9bcb9df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101795d30>, '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 0x1016bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10178abe8>, '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.V4woBDST4I/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.euA1xGJ4Ao/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 08:35:42 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 08:35:42 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 08:35:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4woBDST4I/Render', 08:35:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:42 INFO - 'HOME': '/Users/cltbld', 08:35:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:42 INFO - 'LOGNAME': 'cltbld', 08:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:42 INFO - 'MOZ_NO_REMOTE': '1', 08:35:42 INFO - 'NO_EM_RESTART': '1', 08:35:42 INFO - 'PAGER': '/bin/cat', 08:35:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:42 INFO - 'PWD': '/builds/slave/test', 08:35:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:42 INFO - 'SHELL': '/bin/bash', 08:35:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euA1xGJ4Ao/Listeners', 08:35:42 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 08:35:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:42 INFO - 'USER': 'cltbld', 08:35:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:42 INFO - 'XPC_FLAGS': '0x0', 08:35:42 INFO - 'XPC_SERVICE_NAME': '0', 08:35:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:35:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-XGKLs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:35:42 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)) 08:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:35:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-q7WAj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:35:42 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)) 08:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:35:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Pdo7QN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:35:42 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)) 08:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:35:42 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-6LnH83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:35:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-y8MI37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:35:43 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)) 08:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:35:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-5w8NnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:35:43 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)) 08:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:35:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-9o2jyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:35:43 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)) 08:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:35:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-nQU9GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:35:43 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)) 08:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:35:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-tTySMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:35:43 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)) 08:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:35:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-5p0qG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:35:43 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)) 08:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:35:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-cOGrz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:35:43 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)) 08:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:35:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-OUMJDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:35:43 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-PJbY5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:35:44 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)) 08:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:35:44 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-4r0ndh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:35:44 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)) 08:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:44 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-YGjlrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:44 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)) 08:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:35:44 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Jx5ykZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:35:44 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)) 08:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:35:44 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-WMZUUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:35:44 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)) 08:35:44 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)) 08:35:44 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)) 08:35:44 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)) 08:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:35:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:35:44 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 08:35:44 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 08:35:44 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 08:35:44 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 08:35:44 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 08:35:44 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 08:35:46 INFO - Downloading blessings-1.6.tar.gz 08:35:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:35:47 INFO - Installing collected packages: blessings 08:35:47 INFO - Running setup.py install for blessings 08:35:47 INFO - Successfully installed blessings 08:35:47 INFO - Cleaning up... 08:35:47 INFO - Return code: 0 08:35:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:35:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:35:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:35:47 INFO - Reading from file tmpfile_stdout 08:35:47 INFO - Current package versions: 08:35:47 INFO - blessings == 1.6 08:35:47 INFO - blobuploader == 1.2.4 08:35:47 INFO - docopt == 0.6.1 08:35:47 INFO - functools32 == 3.2.3-2 08:35:47 INFO - jsonschema == 2.5.1 08:35:47 INFO - manifestparser == 1.1 08:35:47 INFO - mozInstall == 1.12 08:35:47 INFO - mozcrash == 1.0 08:35:47 INFO - mozdebug == 0.1 08:35:47 INFO - mozdevice == 0.49 08:35:47 INFO - mozfile == 1.2 08:35:47 INFO - mozhttpd == 0.7 08:35:47 INFO - mozinfo == 0.9 08:35:47 INFO - mozleak == 0.1 08:35:47 INFO - mozlog == 3.4 08:35:47 INFO - moznetwork == 0.27 08:35:47 INFO - mozprocess == 0.24 08:35:47 INFO - mozprofile == 0.28 08:35:47 INFO - mozrunner == 6.13 08:35:47 INFO - mozscreenshot == 0.1 08:35:47 INFO - mozsystemmonitor == 0.3 08:35:47 INFO - moztest == 0.8 08:35:47 INFO - mozversion == 1.4 08:35:47 INFO - psutil == 3.1.1 08:35:47 INFO - requests == 1.2.3 08:35:47 INFO - wsgiref == 0.1.2 08:35:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:47 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')]} 08:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:47 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')]} 08:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:47 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 0x1019b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba9bcb9df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101795d30>, '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 0x1016bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10178abe8>, '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.V4woBDST4I/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.euA1xGJ4Ao/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 08:35:47 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 08:35:47 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 08:35:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4woBDST4I/Render', 08:35:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:47 INFO - 'HOME': '/Users/cltbld', 08:35:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:47 INFO - 'LOGNAME': 'cltbld', 08:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:47 INFO - 'MOZ_NO_REMOTE': '1', 08:35:47 INFO - 'NO_EM_RESTART': '1', 08:35:47 INFO - 'PAGER': '/bin/cat', 08:35:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:47 INFO - 'PWD': '/builds/slave/test', 08:35:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:47 INFO - 'SHELL': '/bin/bash', 08:35:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euA1xGJ4Ao/Listeners', 08:35:47 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 08:35:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:47 INFO - 'USER': 'cltbld', 08:35:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:47 INFO - 'XPC_FLAGS': '0x0', 08:35:47 INFO - 'XPC_SERVICE_NAME': '0', 08:35:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:47 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)) 08:35:47 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)) 08:35:47 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)) 08:35:47 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)) 08:35:47 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)) 08:35:47 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)) 08:35:47 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)) 08:35:47 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)) 08:35:47 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)) 08:35:47 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)) 08:35:47 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)) 08:35:47 INFO - Cleaning up... 08:35:47 INFO - Return code: 0 08:35:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:35:47 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')]} 08:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:47 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')]} 08:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:47 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 0x1019b7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ba768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba9bcb9df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101795d30>, '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 0x1016bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10178abe8>, '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.V4woBDST4I/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.euA1xGJ4Ao/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 08:35:47 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 08:35:47 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 08:35:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4woBDST4I/Render', 08:35:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:47 INFO - 'HOME': '/Users/cltbld', 08:35:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:47 INFO - 'LOGNAME': 'cltbld', 08:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:47 INFO - 'MOZ_NO_REMOTE': '1', 08:35:47 INFO - 'NO_EM_RESTART': '1', 08:35:47 INFO - 'PAGER': '/bin/cat', 08:35:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:47 INFO - 'PWD': '/builds/slave/test', 08:35:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:47 INFO - 'SHELL': '/bin/bash', 08:35:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euA1xGJ4Ao/Listeners', 08:35:47 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 08:35:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:47 INFO - 'USER': 'cltbld', 08:35:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:47 INFO - 'XPC_FLAGS': '0x0', 08:35:47 INFO - 'XPC_SERVICE_NAME': '0', 08:35:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:35:48 INFO - Cleaning up... 08:35:48 INFO - Return code: 0 08:35:48 INFO - Running post-action listener: _resource_record_post_action 08:35:48 INFO - Running post-action listener: _start_resource_monitoring 08:35:48 INFO - Starting resource monitoring. 08:35:48 INFO - [mozharness: 2017-01-11 16:35:48.205592Z] Finished create-virtualenv step (success) 08:35:48 INFO - [mozharness: 2017-01-11 16:35:48.206637Z] Running install step. 08:35:48 INFO - Running pre-action listener: _resource_record_pre_action 08:35:48 INFO - Running main action method: install 08:35:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:35:48 INFO - Reading from file tmpfile_stdout 08:35:48 INFO - Detecting whether we're running mozinstall >=1.0... 08:35:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:35:48 INFO - Reading from file tmpfile_stdout 08:35:48 INFO - Output received: 08:35:48 INFO - Usage: mozinstall [options] installer 08:35:48 INFO - Options: 08:35:48 INFO - -h, --help show this help message and exit 08:35:48 INFO - -d DEST, --destination=DEST 08:35:48 INFO - Directory to install application into. [default: 08:35:48 INFO - "/builds/slave/test"] 08:35:48 INFO - --app=APP Application being installed. [default: firefox] 08:35:48 INFO - mkdir: /builds/slave/test/build/application 08:35:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:36:10 INFO - Reading from file tmpfile_stdout 08:36:10 INFO - Output received: 08:36:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:36:10 INFO - Running post-action listener: _resource_record_post_action 08:36:10 INFO - [mozharness: 2017-01-11 16:36:10.869947Z] Finished install step (success) 08:36:10 INFO - [mozharness: 2017-01-11 16:36:10.870087Z] Running run-tests step. 08:36:10 INFO - Running pre-action listener: _resource_record_pre_action 08:36:10 INFO - Running main action method: run_tests 08:36:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:36:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:36:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:36:10 INFO - 2017-01-11 08:36:10.884 screenresolution[1897:14696] starting screenresolution argv=screenresolution get 08:36:10 INFO - 2017-01-11 08:36:10.887 screenresolution[1897:14696] Display 0: 1600x1200x32@60 08:36:10 INFO - 2017-01-11 08:36:10.893 screenresolution[1898:14699] starting screenresolution argv=screenresolution list 08:36:10 INFO - Available Modes on Display 0 08:36:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:36:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:36:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:36:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:36:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:36:11 INFO - Intel Iris: 08:36:11 INFO - Chipset Model: Intel Iris 08:36:11 INFO - Type: GPU 08:36:11 INFO - Bus: Built-In 08:36:11 INFO - VRAM (Dynamic, Max): 1536 MB 08:36:11 INFO - Vendor: Intel (0x8086) 08:36:11 INFO - Device ID: 0x0a2e 08:36:11 INFO - Revision ID: 0x0009 08:36:11 INFO - Displays: 08:36:11 INFO - Display: 08:36:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:36:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:36:11 INFO - Display Serial Number: 1600x1200 60 08:36:11 INFO - Main Display: Yes 08:36:11 INFO - Mirror: Off 08:36:11 INFO - Online: Yes 08:36:11 INFO - Rotation: Supported 08:36:11 INFO - Return code: 0 08:36:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:36:11 INFO - Python 2.7.3 08:36:11 INFO - Return code: 0 08:36:11 INFO - grabbing minidump binary from tooltool 08:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:11 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101795d30>, '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 0x1016bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10178abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:36:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:36:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:36:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:36:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:36:11 INFO - Return code: 0 08:36:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:36:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:36:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:36:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:36:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:36:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--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 08:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0375 --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 08:36:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.V4woBDST4I/Render', 08:36:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:36:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:36:11 INFO - 'HOME': '/Users/cltbld', 08:36:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:36:11 INFO - 'LOGNAME': 'cltbld', 08:36:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:36:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:36:11 INFO - 'MOZ_NO_REMOTE': '1', 08:36:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:36:11 INFO - 'NO_EM_RESTART': '1', 08:36:11 INFO - 'PAGER': '/bin/cat', 08:36:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:36:11 INFO - 'PWD': '/builds/slave/test', 08:36:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:36:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:36:11 INFO - 'SHELL': '/bin/bash', 08:36:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.euA1xGJ4Ao/Listeners', 08:36:11 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 08:36:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:36:11 INFO - 'USER': 'cltbld', 08:36:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:36:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:36:11 INFO - 'XPC_FLAGS': '0x0', 08:36:11 INFO - 'XPC_SERVICE_NAME': '0', 08:36:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:36:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--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 08:36:11 INFO - mozversion application_buildid: 20170111072206 08:36:11 INFO - mozversion application_changeset: 5493551203ed0b78b47c944c49d9908e446b4b2d 08:36:11 INFO - mozversion application_display_name: Nightly 08:36:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:36:11 INFO - mozversion application_name: Firefox 08:36:11 INFO - mozversion application_remotingname: firefox 08:36:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:36:11 INFO - mozversion application_vendor: Mozilla 08:36:11 INFO - mozversion application_version: 53.0a1 08:36:11 INFO - mozversion platform_buildid: 20170111072206 08:36:11 INFO - mozversion platform_changeset: 5493551203ed0b78b47c944c49d9908e446b4b2d 08:36:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:36:11 INFO - mozversion platform_version: 53.0a1 08:36:11 INFO - using testdate: 1484152571 08:36:11 INFO - actual date: 1484152571 08:36:11 INFO - starting webserver on 'localhost:52432' 08:36:11 INFO - SUITE-START | Running 2 tests 08:36:11 INFO - TEST-START | dromaeo_css 08:36:11 INFO - operating with platform_type : mac_ 08:36:11 INFO - Initialising browser for dromaeo_css test... 08:36:11 INFO - TEST-INFO | started process 1908 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpQlz44H/profile http://localhost:52432/getInfo.html) 08:36:13 INFO - PROCESS | 1908 | __metrics Screen width/height:1600/1200 08:36:13 INFO - PROCESS | 1908 | colorDepth:24 08:36:13 INFO - PROCESS | 1908 | Browser inner width/height: 1024/689 08:36:13 INFO - PROCESS | 1908 | __metrics 08:36:13 INFO - PROCESS | 1908 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:36:13 INFO - PROCESS | 1908 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:36:14 INFO - TEST-INFO | 1908: exit 0 08:36:14 INFO - Browser initialized. 08:36:14 INFO - Running cycle 1/1 for dromaeo_css test... 08:36:14 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpQlz44H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:26 INFO - PROCESS | 1910 | RSS: Main: 234221568 08:36:26 INFO - PROCESS | 1910 | 08:39:32 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:52432/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52432/tests/dromaeo/cssquery-ext.html) 08:39:34 INFO - PROCESS | 1910 | RSS: Main: 367464448 08:39:34 INFO - PROCESS | 1910 | 08:41:15 INFO - PROCESS | 1910 | ************************* 08:41:15 INFO - PROCESS | 1910 | A coding exception was thrown and uncaught in a Task. 08:41:15 INFO - PROCESS | 1910 | 08:41:15 INFO - PROCESS | 1910 | Full message: ReferenceError: fetch is not defined 08:41:15 INFO - PROCESS | 1910 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 08:41:15 INFO - PROCESS | 1910 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 08:41:15 INFO - PROCESS | 1910 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 08:41:15 INFO - PROCESS | 1910 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:41:15 INFO - PROCESS | 1910 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:41:15 INFO - PROCESS | 1910 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:41:15 INFO - PROCESS | 1910 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 08:41:15 INFO - PROCESS | 1910 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:41:15 INFO - PROCESS | 1910 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:41:15 INFO - PROCESS | 1910 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:41:15 INFO - PROCESS | 1910 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 08:41:15 INFO - PROCESS | 1910 | 08:41:15 INFO - PROCESS | 1910 | ************************* 08:42:37 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:52432/tests/dromaeo/cssquery-ext.html (next: http://localhost:52432/tests/dromaeo/cssquery-jquery.html) 08:42:37 INFO - PROCESS | 1910 | RSS: Main: 366379008 08:42:37 INFO - PROCESS | 1910 | 08:45:40 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:52432/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52432/tests/dromaeo/cssquery-mootools.html) 08:45:40 INFO - PROCESS | 1910 | RSS: Main: 341618688 08:45:40 INFO - PROCESS | 1910 | 08:48:43 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:52432/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52432/tests/dromaeo/cssquery-prototype.html) 08:48:43 INFO - PROCESS | 1910 | RSS: Main: 333205504 08:48:43 INFO - PROCESS | 1910 | 08:51:47 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:52432/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52432/tests/dromaeo/cssquery-yui.html) 08:51:47 INFO - PROCESS | 1910 | RSS: Main: 334598144 08:51:47 INFO - PROCESS | 1910 | 08:54:51 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:52432/tests/dromaeo/cssquery-yui.html (next: http://localhost:52432/tests/dromaeo/cssquery-dojo.html) 08:54:51 INFO - PROCESS | 1910 | RSS: Main: 396705792 08:54:51 INFO - PROCESS | 1910 | 08:54:51 INFO - PROCESS | 1910 | __start_tp_report 08:54:51 INFO - PROCESS | 1910 | _x_x_mozilla_page_load 08:54:51 INFO - PROCESS | 1910 | _x_x_mozilla_page_load_details 08:54:51 INFO - PROCESS | 1910 | |i|pagename|runs| 08:54:51 INFO - PROCESS | 1910 | |0;dojo.html;3330.2007518195624;3340.131565792894;3349.179451034497;3360.37833000895;3414.1293970037636;4687.69529980551;5621.100623900166;5650.237217975572;5735.369109397968;5755.971220143899;5683.545316374691;5688.488036076763;5740.167675687023;5759.596828222016;5787.450192231731;4166.458360413142;5097.847064588068;5134.229865520165;5158;5184.403793563732;4610.450892078414;5249.238860365244;5307.097793375116;5330.1205301125265;5379.408265090837;5292.470752924696;5297.708626025567;5305.1776974569;5318.867028324304;5328.786848526054;5132.589392848563;5189.014087323397;5199.896002079937;5224.555912747383;5243.213517972296;5116.155834287375;5193.221016847466;5200.089984252779;5214.217867319894;5214.687118772886;5690.715464226772;5713.485786279255;5721.34204566476;5728.885422291531;5734.483896449339;6198.442140207403;6218.129461875341;6221.377862213742;6221.502279817649;6223.159873417076;6207.193064901534;6230.844228894269;6279.403456671655;6314.778982735628;6341.4926805855885;5819.53443724501;5834.883302334015;5850.561207909382;5851.151583020438;5852.122181672698;6285.277193122758;6292.339304372975;6297.527685423612;6299.023651333959;6300.936990630126;5148.768305426265;6011.947909115887;6066;6090.421409966046;6163.722632481549;6144.631322120597;6300.905486417708;6302.779402720975;6303.180586523814;6307.148534947723;6116.344924030929;6166.167567378437;6171.537134714914;6204.720787564571;6227.346128656426;6263.937360626335;6287.9056814147825;6303.495720342362;6309.936900630935;6321.336259692758;4910.729909854992;4947.975260123676;4950.777215025332;5015.398152221756;5057.974710126426;4408.228560001987;4419.9337009944875;4459.576340247671;4484.39460672805;4491.393661855673;5885.499732522698;5893.057110862242;5894.616849904743;5899.675517846474;5911.349751527328;6320.115183874262;6320.462760665303;6321.525885558602;6339.366063393623;6341.841453963595;5646.632968857093;5674.687892165888;5688.488036076773;5697.7151142443545;5768.307803063575;5450.754716037788;5469.507744302952;5484.067708489566;5513.8345849624575;5537.529310008695;6321.431071203614;6324.652144131933;6327.8101656951285;6340.270868850142;6351.460125889351;6080.118382834553;6122.877542449215;6253.5622506424115;6299.118123462627;6300.779472718433;6223.3465486123305;6273.498120150468;6276.843078923063;6301.6534090625455;6323.272823625158;6230.376962303733;6246.3753624637175;6277.71750271248;6278.717457714322;6279.466245369194;6263.561550691408;6290.8427289316305;6292.056191571118;6302.527310451826;6324.810255692152;6042.758289668364;6075.27096748393;6084.7566097357385;6112.480439162543;6113.5414843886;5980.641161530322;6142.293636231711;6189.319174890848;6193.81418557444;6196.225471816023;4937.382827146606;5887.793927212527;5961.970190149022;5976.581639285208;6027.6986150693165;6121.051237058263;6168.907466388097;6176.969115154396;6186.4741496973265;6188.752449901954;5216.921746173886;5601.159826026129;5798.275215598051;5862.296524417097;6024.608400453956 08:54:51 INFO - PROCESS | 1910 | |1;ext.html;461.6652926628193;467.4250671673839;497.1473922223386;499.291006770386;499.92017242755645;31558.84220578897;41266.587334126685;42888;42914.78542607286;43059.56940430603;43406.348904766375;43662.345064823974;44126.55873441265;44299;44335.66992990208;8506.659733610648;9269.258459323239;9291.674791382304;9489.430634161938;9497.050294970517;8477.61850716716;11205.775884482306;11399.658010259705;11416.657500275005;11659.883401166007;11407.030402415805;11509;11510.30938143714;11513.330567067771;11515.712107197345;11382.317060976327;11460.197786154973;11479.770404591862;11506.884931150666;11514.712132196679;11300.982911537918;11313.886861131366;11361.091112710963;11377.544898204062;11378.089752819755;38660.420093698616;39822.20355592901;41552.58447415518;42013.78993105015;42087.57912420867;3965.504311961005;3981.900452488711;3991.820368083443;4019.437278780973;4126.649234815044;30037.849810751024;31192.532112018336;31218.53172202419;31375;31406;3193.393255281489;3226.757993150523;3310.2055506678466;3339.5992480902205;3347.447671134284;491706;494009.5898561524;496706.494025899;497538;497749.9999999964;66371.66814165995;66879;66904.33095669078;67027.65944681177;67099.66450167718;68049.65975170092;68267;68306.65846670834;68521.65739171371;68536.6573167131;13731.862681373259;16767.32930682759;16778.916105419637;16786.244618992176;16793.328266869434;11539.711507212387;11876.931076203184;12776.744465110645;12865.807012894815;12874.227546347249;15007.27416347134;16381.98641332881;16740.330386784637;18079.91520508774;18999.43001709951;6392.20097487814;6453.677316134174;6475.287718350977;6477.6437295948235;6490.545661803629;863.5811631358786;872.6204101215991;876.3471213945651;882.3646974178581;900.4102312985005;30412.391752164833;30412.54381184284;30580.69419305823;30780.33171935728;31316.37367252688;904.5929331800716;1054.2778196935124;1080.3679847289425;1087.9782404351868;1202.9759404811855;15386.38454461809;15956.920215398848;16088.517344479684;16239.675206495804;16420.425285114965;608232;615590;621005;621673.891630539;621715;52095.479045209824;61699;62864.68567657224;62950.68524657439;66391;1269.3209133113924;1387.9930600346934;1415.6390120519202;1441.4018182454165;1445.3134760988446;30565.694343056286;31656.683433165374;31940;32232.83883580567;32263.677363227005;53817.73091134519;54338;54427.45572544224;54459.36621901349;54511.454885450636;483749;563701;565457;565634;567986;25602.35994100088;26202.95188192451;27007.1897843065;27023.189304320902;41643.7917810409;35082.298354033286;35239.647603523634;35709.1072723184;40829;41679.37480937849;37006.6299337014;37105.62894371022;37140.88577342684;37875;37953.4306985401;36759;36986.44520332143;37633.81183094067;37820;38021;35373.64626353703;35687.464688029184;36318.636813632584;36319.910402687965;36581.26837463289;31436.913908736646;32362.838185809862;32990.17524561905;32996.50505242375;33096.007119786445;24059.157929472385;24102.87948560246;24389.878050609634;24515.303316635513;24603.769811509712 08:54:51 INFO - PROCESS | 1910 | |2;jquery.html;391.3757556697069;391.39334032250014;398.1261131815662;401.82520603537455;419.0675746464118;14172.929135354309;19809.702854457177;20330.69503957438;20990.05544750486;21012.264570740008;16599.253033613488;19474.221031158737;20756.27353042644;20902.477438064056;20913.686294705552;5647.407022262675;5965.612235204698;5970.8805823883495;5984.192134061911;5986.970065149668;5734.752701278326;5798.536117110642;5824.767009319622;5836.824895253128;5862.912056319158;4897.265410188483;5754.1944127822135;5768.509676677488;5773.33606635236;5792.942070579304;5737.139429085629;5782.884342313151;7428.9257107428775;7741.18717534662;7819.491733037335;7434.516756410816;7644.655990480442;7687.385009199251;7714.6914123435;7722.884156737653;28473.28816779597;28829.279268018257;28830.855845720846;28972.42055158906;29431.558526622117;2893.985530072336;2940.8235505869716;3002.324476992681;3004.3240270938863;3065.126438964907;16495.83504164955;16560.337586496527;17109.887857289235;17156.399526016656;17572.560685982826;1902.9048547572565;1934.2263094762209;1946.2993322403922;1948.9317873874347;2009.136071489259;157350;162507;166304.16847915683;167173;168187.15906420513;22789.658155127687;22893.885530572574;23001.539969200523;23034;23074.884625576764;40388.394174087414;40494.78515644535;40601.390979135336;40607.796961015;40683;8154.2253485918745;8290.129536398592;8612.48325100496;8763.079876612865;10345.63790267337;8327.875081873777;8367.121452247547;8403.95798021006;8485.660573577112;8500;3790.2608991246993;3919.7256192066284;3935.9212815743526;4618.769061546976;4799.112164249625;1694.8729344672358;1902.6015878329417;1976.0909981408713;2023.4435530229011;2024.3662625587106;916.2715641065236;991.973307626603;997.7356000659831;1006.1146191351564;1050.1965996013057;17694;19685.803141968685;20706.792932070788;21258.83076430811;21268.383177989446;1022.8414595737672;1030.5929157982555;1057.3338796558119;1067.1036329483272;1070.5289672544056;10190.929952355043;10618.256722029539;10633.255672102878;10662.040416362564;10673.679789606324;658497;704389.4780526065;714410;735551;741621;143934.2803285998;147285;151382.48617513684;152521.12183172614;154418;980.0444566547701;984.5815528400544;1023.1098943918689;1052.8368102944055;1060.867391576053;19114.522136946132;19358.516037099183;19614.411567652995;19645.508862277984;19683;38147.33083732139;55947.321580352655;56864.57838554069;58536.707316463144;59989.40010599838;87531;88184.67722984032;88220;88964.10697411705;90098;7968.36253099739;8083.434159609006;8150.959245203736;8302.584870756558;8380.706675266336;12180.817287740514;12566.308853012806;12949.352532373532;12997.09020368603;13080.345982700637;10520.579176832842;10861;10911.054015415952;11072;11094.722631934266;10685.358878467317;10863.782724345627;10980.231383803377;11308.434578271219;11318.037966772916;11119;11122.165837562054;11351.716207094889;11467.598634047768;11534.134939879375;8086.8786968194345;8282.088970213392;8341.541215233221;8439.620217090123;8526.74419767408;8757.737267881974;10929.453527323762;11317.660470185907;11332.716682083013;11338.773224535298 08:54:51 INFO - PROCESS | 1910 | |3;mootools.html;1354.7358265138298;1475.6532214929496;1477.682298305864;1501.144347721799;1509.2227502836042;7987.321077708394;8407.831843363128;8414.49513029217;8416.032156302028;8417.074121846592;7407.407407407408;7621.199774023731;7644.235576442353;7957.283844453998;8213.42506024577;2287.0737351372677;2329.5108027314286;2331.5103828196097;2340.6137987232087;2341.2976107167865;2225.4213904384897;2244.7194100737406;2249.7300323961067;2295.7704229576993;2338.9415264618438;1960.6568850451185;2243.7547161325456;2308.8383813133087;2313.618252988255;2336.217367181996;2295.8392912496133;2317.3743089365776;2318.48993221491;2319.860808351504;2324.2910912171697;2308.9191878284178;2333.754955729641;2338.356951838241;2341.1454818991115;2342.8242881783935;6814.250432452426;8295.751127466187;8309.169083091643;8373.204545568162;8385.077641459435;5011.373578302712;5163.612729045337;5166.61250406221;5169.948300516984;5183.196604526304;3231.418344697953;3308.5698859148156;3517.613062563116;3525;3532.6643968822923;1197.1320792425508;1202.9578964736193;1234.2039384596974;1248.4881198708485;1257.076049103908;10583.73540661482;10694.786104277871;10704.411257380842;10706.357618542834;10724.14206863449;4322.24360736876;4538.88652783683;4592.448906131285;4648.697834640805;4667.206574882278;9297.395669281475;9316;9321.207697345666;9327.906720932839;9336.813263734823;5193.428722840485;5195.740212989335;5207.244949482304;5209.062368773657;5210.062188805976;4228.471441069866;4503.301988191835;4730.952690473051;4755.025219829927;4765.761711914391;3746.625337466286;3782.2624588205035;3843.2121415110396;3872.1481274119647;3888.8833334999995;1246.2584762066556;1260.489501751792;1264.652220639313;1274.847018357803;1275.1329096214479;901.9819603607891;919.2416256588341;927.7216834949488;927.8693242431932;964.7829238421299;5643.858903527363;5699.458551437607;5846.766129354778;5937.498444182248;6002.54980876436;573.3406582430156;584.3192680527224;584.9853753656107;595.0360416125903;596.0641792385912;3893.8637147699696;3896.493455850721;3953.2686453006286;4000.27994960904;4003.319435695939;9497;9746.512674366395;9786.75533111678;9982.450965196984;9992.80014399708;9925.602975880884;9930.25523085757;9932.354396964174;9934.956829532939;9946.45294508809;7286.744963926237;7722.382209423233;7820.569868657279;7828.217178282126;7831.686732530635;5050.04049230645;5923.733431995484;5980.641161530322;5998.190244316961;6046.57673962836;9094.681686140953;9107.453552786854;9153.993060763178;9158.443064678888;9301.488418136796;9212.631494740135;9281.628734850801;9286.164245217962;9400.34197606161;9430.764230894283;6622.635755033327;6824.249332573512;6835.829104272433;7099.538529995534;7249.637518124178;7601.201873803171;7877.803054923673;7879.645415956181;7950.24472675095;7968.163342848918;6964.930350696428;7072.646367681698;7083.256258093033;7129;7215.278472152742;6995.370416662525;7011.859762804817;7039.296070392919;7043.647817609201;7108.502404831612;6361.7137228823885;6379.585326953733;6429.22849258092;6436.420722135031;6437.130987316652;4066.694997875112;4915.827946021872;4961.3798275215595;5022.573081288131;5030.496950304941;4907;4987.376577927759;5005.7997680092385;5060;5066.82266120684 08:54:51 INFO - PROCESS | 1910 | |4;prototype.html;354.028192611282;358.32992304390774;362.1435305502487;372.2090557565172;374.5991788786;4638.698484598499;5179.912218434129;5272.73636318184;5286.7356632168385;5320;4218.397009136524;4227.661787057028;4920.581750551208;5105.719185444799;5274.736263186835;3359.496075588657;3402.9149271268293;3721.8883433496903;4027.496562929634;4050.412690159925;3593.802340871251;3761.5486141663037;4138.482689663792;4138.530821558348;4175.373693945902;3387.71204447621;3989.4015897615445;4086.119285903431;4088.284550203717;4091;3377.9563364164574;3648.343298206322;3786.7503723771088;4066.4103704962613;4090.1819636072905;3558.857645694169;3564.055525285801;3578.856845726194;3585.2650206707563;3590.4793804898404;5124.975004999015;5150.690958542499;5156.948430515685;5178.012930043845;5194.63637545372;4272.423222864904;4484.529124441952;4499.325101234808;4637.217669398334;4699.295105734133;4862.367892173995;5517.889642207174;5524.226608274845;5537.833864984057;5553.222548843165;3395.5416018837386;3428.7428442866885;3925.685945124383;4041.4948131483566;4060.593940605945;5482.945170548283;5495;5788.616586574526;5789.189513468118;5851.210086638292;3392.8982130536124;3506.1409954560786;4073.5926407359025;4074.6536544394057;4091.161311931047;3800.144967382372;3855.1133239355104;4136.482939632546;4178.770167640809;4181.0071381830885;3924.823382947774;3941.3693808990424;4446.288593825037;4664.950386163154;4752.809887604457;5549.139883318092;5567.526760225345;5596.3284405870745;5601.971990140023;5697.515711164515;1190.6666133482638;1202.6572426858304;1300.6618279247464;1339.5378594384922;1349.2646507653155;794.3367288314322;833.3957880536684;839.5760141128814;926.4898215908162;949.6248981652209;4102.179564087194;4280.651594747645;4407.008423104776;4582.839600613963;4754.286856971482;4671.696339737906;5073.63667246168;5212.279947617277;5315.654482458628;5319.441458646864;4133.648639865585;4198.349255865346;4380.78096095194;4635.281531362644;4886;2255.853369531008;2522.785563227146;2658.24240091573;2799.6780370257275;2819.379736457976;4611.377464042312;4763.095011947788;5101.69389836611;5158.587313015025;5356.419856142447;4923.655344125948;4987.600991920638;5451.427600102012;5467.808626698046;5541.473560011793;5467.516636358148;5474.972625136928;5481.232627432163;5521.420250873681;5527.336719593674;4691.953080469151;4976.029674213493;5327.813526526553;5328.813491527778;5337.438029745666;4624.606908412823;4662.440507139165;4670.065986802585;5109.799197188732;5254.947450525446;4896.491447121988;5453.7545810439415;5482.205080263259;5529.834104976857;5539.753555449992;3261.624913134925;3395.0833275016103;3453.913652158716;3821.9934534369677;3828.2917660232947;4372.606465418127;5284.471552844685;5325.387580428301;5651.915221271766;5717.342505611741;4647.86056418308;5434.929264965282;5510.008198524304;5526.613137080527;5558.305211848519;4430.490493593149;4645.558671926162;5216.530512253916;5557.972210138923;5567.777288908398;4501.819927203006;5229.921551176812;5246.580273578181;5357.651752636066;5469.644473109235;4538.7957541911355;4962.602991760578;5353.839384818461;5431.511163995259;5437.374701909331;4610.884727881829;4750.738709370879;5413.1880217966045;5421.3765416975975;5424.593155513273 08:54:51 INFO - PROCESS | 1910 | |5;yui.html;632.5477283742125;705.9329363710445;721.2715157690731;739.6486668832306;765.3876898481213;12620.548636906748;14076.507322243724;15031.92484037581;15812.288447019882;15843.366265349372;14152.363143658535;14268.215248161347;14645.048071875348;14645.633859153526;14682.926585367059;841.3731769831469;869.1308691308691;870.0472982084607;871.3856731004659;872.9258013068896;690.278658801551;708.2386434582818;713.4114355656578;845.2857335551449;852.5822347049963;916.3631276263;920.5903372999018;920.6593560382668;921.2491819167391;924.3945215883607;916.8028873792167;920.5121285718546;921.0743203080895;921.8340698674236;923.2475532441106;529.3356837169366;541.0720614146758;658.5061204096927;681.7954613615896;682.74738346812;13454.730905381837;14859.554213373616;14909.478168264059;15355.309011094416;15375.846241537552;13606.727865442635;13674.658133546642;13849.861501384958;13904.721905561933;14005.78991315121;12666.74666506674;12867.292298923556;12954.157979731288;13026.34868256593;13472.865271347357;4422.253922967188;4444.777761111964;4527.501974782771;4596.264597664358;4675.041616468616;120012.39993800063;120719;122267;122449.16326255024;124907.37546312211;10911.781764364669;11011.504482298316;11063;11180.496877640526;11481.0815134789;19882.801171988383;20601.175952961712;21608.459788505097;22030;22084.779152208273;7695.576743279062;7698.653560589787;7726.420518461138;7733.110692270348;7930.5638189898955;4093;4162.7502349859105;4172.895677608084;4203.684723645739;4225.632848315689;3336.4494858348585;3391.4404123319378;3436.9312613747584;3438.914027149291;3441.328940856559;623.1431781300712;626.145311649595;637.0635166305524;640.3180612647516;646.767163821024;644.616453210339;649.3182158733312;649.9902501462482;653.8365408647838;657.5890068707058;9195.724128276162;9197.632094716137;9427.057294270655;9745.415275083518;11151.721206969729;591.7544219149091;594.7591225553658;598.949089327412;610.3621715307426;722;4534.433195850519;4968.378952630921;4984.277279794482;5008.799648014112;5013.3983921928875;99206;101743.4912825446;102188.48905755572;103657.96342036634;105624;88129.55935220284;91141;93118.4128952265;94027.52986235161;94472.52763736137;77005;79032;79712;79765.00587485476;81577.59211204025;9719.125278724949;9795.804083918425;9806.411615303105;9821.508924553887;9832.459214742972;50856.74571627118;51810.74094629503;51927.22109168441;52107;52602;63081.68459157858;65270;66609.33390666226;72832.63583682048;75009.6249518749;13008.609741707764;13034.543790967271;13219.66950826237;13481.98885083603;13550.661233469242;14541.636459088608;14915;15133.621659458602;15233.086014839146;15245.771313430085;11923.940380298043;11931.761364772483;14005.439782408997;14498.275086245856;14621.92689036548;13517.59447216585;13718.501782045914;13949.58151255464;14123.929380353033;14243;13494.595162145151;13667.521636742666;13706.725865482835;13875.306234688023;14204.934629903006;11067.335959842436;11171.273867198606;11361.943190283995;11428.941947518655;11776.470058847544;11172.888271117185;11243.04434123076;11318.283611932911;11398.658040258806;11570.247933884271 08:54:51 INFO - PROCESS | 1910 | __end_tp_report 08:54:51 INFO - PROCESS | 1910 | __start_cc_report 08:54:51 INFO - PROCESS | 1910 | _x_x_mozilla_cycle_collect,1405 08:54:51 INFO - PROCESS | 1910 | __end_cc_report 08:54:51 INFO - PROCESS | 1910 | __startTimestamp1484153691365__endTimestamp 08:54:51 INFO - PROCESS | 1910 | 08:54:51 INFO - PROCESS | 1910 | ------- Summary: start ------- 08:54:51 INFO - PROCESS | 1910 | Number of tests: 6 08:54:51 INFO - PROCESS | 1910 | 08:54:51 INFO - PROCESS | 1910 | [#0] dojo.html Cycles:165 Average:5741.29 Median:5961.97 stddev:665.31 (11.2%) stddev-sans-first:639.90 08:54:51 INFO - PROCESS | 1910 | Values: 3330.2 3340.1 3349.2 3360.4 3414.1 4687.7 5621.1 5650.2 5735.4 5756.0 5683.5 5688.5 5740.2 5759.6 5787.5 4166.5 5097.8 5134.2 5158.0 5184.4 4610.5 5249.2 5307.1 5330.1 5379.4 5292.5 5297.7 5305.2 5318.9 5328.8 5132.6 5189.0 5199.9 5224.6 5243.2 5116.2 5193.2 5200.1 5214.2 5214.7 5690.7 5713.5 5721.3 5728.9 5734.5 6198.4 6218.1 6221.4 6221.5 6223.2 6207.2 6230.8 6279.4 6314.8 6341.5 5819.5 5834.9 5850.6 5851.2 5852.1 6285.3 6292.3 6297.5 6299.0 6300.9 5148.8 6011.9 6066.0 6090.4 6163.7 6144.6 6300.9 6302.8 6303.2 6307.1 6116.3 6166.2 6171.5 6204.7 6227.3 6263.9 6287.9 6303.5 6309.9 6321.3 4910.7 4948.0 4950.8 5015.4 5058.0 4408.2 4419.9 4459.6 4484.4 4491.4 5885.5 5893.1 5894.6 5899.7 5911.3 6320.1 6320.5 6321.5 6339.4 6341.8 5646.6 5674.7 5688.5 5697.7 5768.3 5450.8 5469.5 5484.1 5513.8 5537.5 6321.4 6324.7 6327.8 6340.3 6351.5 6080.1 6122.9 6253.6 6299.1 6300.8 6223.3 6273.5 6276.8 6301.7 6323.3 6230.4 6246.4 6277.7 6278.7 6279.5 6263.6 6290.8 6292.1 6302.5 6324.8 6042.8 6075.3 6084.8 6112.5 6113.5 5980.6 6142.3 6189.3 6193.8 6196.2 4937.4 5887.8 5962.0 5976.6 6027.7 6121.1 6168.9 6177.0 6186.5 6188.8 5216.9 5601.2 5798.3 5862.3 6024.6 08:54:51 INFO - PROCESS | 1910 | 08:54:51 INFO - PROCESS | 1910 | [#1] ext.html Cycles:180 Average:69455.06 Median:36670.13 stddev:148547.51 (405.1%) stddev-sans-first:148873.90 08:54:51 INFO - PROCESS | 1910 | Values: 461.7 467.4 497.1 499.3 499.9 31558.8 41266.6 42888.0 42914.8 43059.6 43406.3 43662.3 44126.6 44299.0 44335.7 8506.7 9269.3 9291.7 9489.4 9497.1 8477.6 11205.8 11399.7 11416.7 11659.9 11407.0 11509.0 11510.3 11513.3 11515.7 11382.3 11460.2 11479.8 11506.9 11514.7 11301.0 11313.9 11361.1 11377.5 11378.1 38660.4 39822.2 41552.6 42013.8 42087.6 3965.5 3981.9 3991.8 4019.4 4126.6 30037.8 31192.5 31218.5 31375.0 31406.0 3193.4 3226.8 3310.2 3339.6 3347.4 491706.0 494009.6 496706.5 497538.0 497750.0 66371.7 66879.0 66904.3 67027.7 67099.7 68049.7 68267.0 68306.7 68521.7 68536.7 13731.9 16767.3 16778.9 16786.2 16793.3 11539.7 11876.9 12776.7 12865.8 12874.2 15007.3 16382.0 16740.3 18079.9 18999.4 6392.2 6453.7 6475.3 6477.6 6490.5 863.6 872.6 876.3 882.4 900.4 30412.4 30412.5 30580.7 30780.3 31316.4 904.6 1054.3 1080.4 1088.0 1203.0 15386.4 15956.9 16088.5 16239.7 16420.4 608232.0 615590.0 621005.0 621673.9 621715.0 52095.5 61699.0 62864.7 62950.7 66391.0 1269.3 1388.0 1415.6 1441.4 1445.3 30565.7 31656.7 31940.0 32232.8 32263.7 53817.7 54338.0 54427.5 54459.4 54511.5 483749.0 563701.0 565457.0 565634.0 567986.0 25602.4 26203.0 27007.2 27023.2 41643.8 35082.3 35239.6 35709.1 40829.0 41679.4 37006.6 37105.6 37140.9 37875.0 37953.4 36759.0 36986.4 37633.8 37820.0 38021.0 35373.6 35687.5 36318.6 36319.9 36581.3 31436.9 32362.8 32990.2 32996.5 33096.0 24059.2 24102.9 24389.9 24515.3 24603.8 08:54:51 INFO - PROCESS | 1910 | 08:54:51 INFO - PROCESS | 1910 | [#2] jquery.html Cycles:180 Average:41751.21 Median:28651.28 stddev:119349.52 (416.6%) stddev-sans-first:119643.92 08:54:51 INFO - PROCESS | 1910 | Values: 391.4 391.4 398.1 401.8 419.1 14172.9 19809.7 20330.7 20990.1 21012.3 16599.3 19474.2 20756.3 20902.5 20913.7 5647.4 5965.6 5970.9 5984.2 5987.0 5734.8 5798.5 5824.8 5836.8 5862.9 4897.3 5754.2 5768.5 5773.3 5792.9 5737.1 5782.9 7428.9 7741.2 7819.5 7434.5 7644.7 7687.4 7714.7 7722.9 28473.3 28829.3 28830.9 28972.4 29431.6 2894.0 2940.8 3002.3 3004.3 3065.1 16495.8 16560.3 17109.9 17156.4 17572.6 1902.9 1934.2 1946.3 1948.9 2009.1 157350.0 162507.0 166304.2 167173.0 168187.2 22789.7 22893.9 23001.5 23034.0 23074.9 40388.4 40494.8 40601.4 40607.8 40683.0 8154.2 8290.1 8612.5 8763.1 10345.6 8327.9 8367.1 8404.0 8485.7 8500.0 3790.3 3919.7 3935.9 4618.8 4799.1 1694.9 1902.6 1976.1 2023.4 2024.4 916.3 992.0 997.7 1006.1 1050.2 17694.0 19685.8 20706.8 21258.8 21268.4 1022.8 1030.6 1057.3 1067.1 1070.5 10190.9 10618.3 10633.3 10662.0 10673.7 658497.0 704389.5 714410.0 735551.0 741621.0 143934.3 147285.0 151382.5 152521.1 154418.0 980.0 984.6 1023.1 1052.8 1060.9 19114.5 19358.5 19614.4 19645.5 19683.0 38147.3 55947.3 56864.6 58536.7 59989.4 87531.0 88184.7 88220.0 88964.1 90098.0 7968.4 8083.4 8151.0 8302.6 8380.7 12180.8 12566.3 12949.4 12997.1 13080.3 10520.6 10861.0 10911.1 11072.0 11094.7 10685.4 10863.8 10980.2 11308.4 11318.0 11119.0 11122.2 11351.7 11467.6 11534.1 8086.9 8282.1 8341.5 8439.6 8526.7 8757.7 10929.5 11317.7 11332.7 11338.8 08:54:51 INFO - PROCESS | 1910 | 08:54:51 INFO - PROCESS | 1910 | [#3] mootools.html Cycles:180 Average:5401.34 Median:5426.96 stddev:2929.95 (54.0%) stddev-sans-first:2922.38 08:54:51 INFO - PROCESS | 1910 | Values: 1354.7 1475.7 1477.7 1501.1 1509.2 7987.3 8407.8 8414.5 8416.0 8417.1 7407.4 7621.2 7644.2 7957.3 8213.4 2287.1 2329.5 2331.5 2340.6 2341.3 2225.4 2244.7 2249.7 2295.8 2338.9 1960.7 2243.8 2308.8 2313.6 2336.2 2295.8 2317.4 2318.5 2319.9 2324.3 2308.9 2333.8 2338.4 2341.1 2342.8 6814.3 8295.8 8309.2 8373.2 8385.1 5011.4 5163.6 5166.6 5169.9 5183.2 3231.4 3308.6 3517.6 3525.0 3532.7 1197.1 1203.0 1234.2 1248.5 1257.1 10583.7 10694.8 10704.4 10706.4 10724.1 4322.2 4538.9 4592.4 4648.7 4667.2 9297.4 9316.0 9321.2 9327.9 9336.8 5193.4 5195.7 5207.2 5209.1 5210.1 4228.5 4503.3 4731.0 4755.0 4765.8 3746.6 3782.3 3843.2 3872.1 3888.9 1246.3 1260.5 1264.7 1274.8 1275.1 902.0 919.2 927.7 927.9 964.8 5643.9 5699.5 5846.8 5937.5 6002.5 573.3 584.3 585.0 595.0 596.1 3893.9 3896.5 3953.3 4000.3 4003.3 9497.0 9746.5 9786.8 9982.5 9992.8 9925.6 9930.3 9932.4 9935.0 9946.5 7286.7 7722.4 7820.6 7828.2 7831.7 5050.0 5923.7 5980.6 5998.2 6046.6 9094.7 9107.5 9154.0 9158.4 9301.5 9212.6 9281.6 9286.2 9400.3 9430.8 6622.6 6824.2 6835.8 7099.5 7249.6 7601.2 7877.8 7879.6 7950.2 7968.2 6964.9 7072.6 7083.3 7129.0 7215.3 6995.4 7011.9 7039.3 7043.6 7108.5 6361.7 6379.6 6429.2 6436.4 6437.1 4066.7 4915.8 4961.4 5022.6 5030.5 4907.0 4987.4 5005.8 5060.0 5066.8 08:54:51 INFO - PROCESS | 1910 | 08:54:51 INFO - PROCESS | 1910 | [#4] prototype.html Cycles:180 Average:4336.82 Median:4681.82 stddev:1308.87 (28.0%) stddev-sans-first:1277.95 08:54:51 INFO - PROCESS | 1910 | Values: 354.0 358.3 362.1 372.2 374.6 4638.7 5179.9 5272.7 5286.7 5320.0 4218.4 4227.7 4920.6 5105.7 5274.7 3359.5 3402.9 3721.9 4027.5 4050.4 3593.8 3761.5 4138.5 4138.5 4175.4 3387.7 3989.4 4086.1 4088.3 4091.0 3378.0 3648.3 3786.8 4066.4 4090.2 3558.9 3564.1 3578.9 3585.3 3590.5 5125.0 5150.7 5156.9 5178.0 5194.6 4272.4 4484.5 4499.3 4637.2 4699.3 4862.4 5517.9 5524.2 5537.8 5553.2 3395.5 3428.7 3925.7 4041.5 4060.6 5482.9 5495.0 5788.6 5789.2 5851.2 3392.9 3506.1 4073.6 4074.7 4091.2 3800.1 3855.1 4136.5 4178.8 4181.0 3924.8 3941.4 4446.3 4665.0 4752.8 5549.1 5567.5 5596.3 5602.0 5697.5 1190.7 1202.7 1300.7 1339.5 1349.3 794.3 833.4 839.6 926.5 949.6 4102.2 4280.7 4407.0 4582.8 4754.3 4671.7 5073.6 5212.3 5315.7 5319.4 4133.6 4198.3 4380.8 4635.3 4886.0 2255.9 2522.8 2658.2 2799.7 2819.4 4611.4 4763.1 5101.7 5158.6 5356.4 4923.7 4987.6 5451.4 5467.8 5541.5 5467.5 5475.0 5481.2 5521.4 5527.3 4692.0 4976.0 5327.8 5328.8 5337.4 4624.6 4662.4 4670.1 5109.8 5254.9 4896.5 5453.8 5482.2 5529.8 5539.8 3261.6 3395.1 3453.9 3822.0 3828.3 4372.6 5284.5 5325.4 5651.9 5717.3 4647.9 5434.9 5510.0 5526.6 5558.3 4430.5 4645.6 5216.5 5558.0 5567.8 4501.8 5229.9 5246.6 5357.7 5469.6 4538.8 4962.6 5353.8 5431.5 5437.4 4610.9 4750.7 5413.2 5421.4 5424.6 08:54:51 INFO - PROCESS | 1910 | 08:54:51 INFO - PROCESS | 1910 | [#5] yui.html Cycles:180 Average:21188.55 Median:4433.52 stddev:31091.79 (701.3%) stddev-sans-first:31140.70 08:54:51 INFO - PROCESS | 1910 | Values: 632.5 705.9 721.3 739.6 765.4 12620.5 14076.5 15031.9 15812.3 15843.4 14152.4 14268.2 14645.0 14645.6 14682.9 841.4 869.1 870.0 871.4 872.9 690.3 708.2 713.4 845.3 852.6 916.4 920.6 920.7 921.2 924.4 916.8 920.5 921.1 921.8 923.2 529.3 541.1 658.5 681.8 682.7 13454.7 14859.6 14909.5 15355.3 15375.8 13606.7 13674.7 13849.9 13904.7 14005.8 12666.7 12867.3 12954.2 13026.3 13472.9 4422.3 4444.8 4527.5 4596.3 4675.0 120012.4 120719.0 122267.0 122449.2 124907.4 10911.8 11011.5 11063.0 11180.5 11481.1 19882.8 20601.2 21608.5 22030.0 22084.8 7695.6 7698.7 7726.4 7733.1 7930.6 4093.0 4162.8 4172.9 4203.7 4225.6 3336.4 3391.4 3436.9 3438.9 3441.3 623.1 626.1 637.1 640.3 646.8 644.6 649.3 650.0 653.8 657.6 9195.7 9197.6 9427.1 9745.4 11151.7 591.8 594.8 598.9 610.4 722.0 4534.4 4968.4 4984.3 5008.8 5013.4 99206.0 101743.5 102188.5 103658.0 105624.0 88129.6 91141.0 93118.4 94027.5 94472.5 77005.0 79032.0 79712.0 79765.0 81577.6 9719.1 9795.8 9806.4 9821.5 9832.5 50856.7 51810.7 51927.2 52107.0 52602.0 63081.7 65270.0 66609.3 72832.6 75009.6 13008.6 13034.5 13219.7 13482.0 13550.7 14541.6 14915.0 15133.6 15233.1 15245.8 11923.9 11931.8 14005.4 14498.3 14621.9 13517.6 13718.5 13949.6 14123.9 14243.0 13494.6 13667.5 13706.7 13875.3 14204.9 11067.3 11171.3 11361.9 11428.9 11776.5 11172.9 11243.0 11318.3 11398.7 11570.2 08:54:51 INFO - PROCESS | 1910 | -------- Summary: end -------- 08:54:51 INFO - PROCESS | 1910 | 08:54:51 INFO - TEST-INFO | 1910: exit 0 08:54:52 INFO - TEST-OK | dromaeo_css | took 1120534ms 08:54:52 INFO - TEST-START | kraken 08:54:52 INFO - operating with platform_type : mac_ 08:54:52 INFO - Initialising browser for kraken test... 08:54:52 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmprHMPPQ/profile http://localhost:52432/getInfo.html) 08:54:54 INFO - PROCESS | 1916 | __metrics Screen width/height:1600/1200 08:54:54 INFO - PROCESS | 1916 | colorDepth:24 08:54:54 INFO - PROCESS | 1916 | Browser inner width/height: 1024/689 08:54:54 INFO - PROCESS | 1916 | __metrics 08:54:54 INFO - PROCESS | 1916 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:54:54 INFO - PROCESS | 1916 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:54:55 INFO - TEST-INFO | 1916: exit 0 08:54:55 INFO - Browser initialized. 08:54:55 INFO - Running cycle 1/1 for kraken test... 08:54:55 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmprHMPPQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:07 INFO - PROCESS | 1917 | RSS: Main: 233766912 08:55:07 INFO - PROCESS | 1917 | 08:55:10 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52432/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52432/tests/kraken/driver.html?testName=audio-beat-detection) 08:55:10 INFO - PROCESS | 1917 | RSS: Main: 286838784 08:55:10 INFO - PROCESS | 1917 | 08:55:13 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52432/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52432/tests/kraken/driver.html?testName=audio-dft) 08:55:14 INFO - PROCESS | 1917 | RSS: Main: 286089216 08:55:14 INFO - PROCESS | 1917 | 08:55:17 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52432/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52432/tests/kraken/driver.html?testName=audio-fft) 08:55:18 INFO - PROCESS | 1917 | RSS: Main: 381317120 08:55:18 INFO - PROCESS | 1917 | 08:55:20 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52432/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52432/tests/kraken/driver.html?testName=audio-oscillator) 08:55:20 INFO - PROCESS | 1917 | RSS: Main: 282390528 08:55:20 INFO - PROCESS | 1917 | 08:55:22 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52432/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52432/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:55:23 INFO - PROCESS | 1917 | RSS: Main: 286363648 08:55:23 INFO - PROCESS | 1917 | 08:55:26 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52432/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52432/tests/kraken/driver.html?testName=imaging-darkroom) 08:55:26 INFO - PROCESS | 1917 | RSS: Main: 326844416 08:55:26 INFO - PROCESS | 1917 | 08:55:29 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52432/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52432/tests/kraken/driver.html?testName=imaging-desaturate) 08:55:30 INFO - PROCESS | 1917 | RSS: Main: 331837440 08:55:30 INFO - PROCESS | 1917 | 08:55:33 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52432/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52432/tests/kraken/driver.html?testName=json-parse-financial) 08:55:33 INFO - PROCESS | 1917 | RSS: Main: 328916992 08:55:33 INFO - PROCESS | 1917 | 08:55:35 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52432/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52432/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:55:36 INFO - PROCESS | 1917 | RSS: Main: 303611904 08:55:36 INFO - PROCESS | 1917 | 08:55:37 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52432/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52432/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:55:38 INFO - PROCESS | 1917 | RSS: Main: 306073600 08:55:38 INFO - PROCESS | 1917 | 08:55:40 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52432/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52432/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:55:41 INFO - PROCESS | 1917 | RSS: Main: 308011008 08:55:41 INFO - PROCESS | 1917 | 08:55:44 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52432/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52432/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:55:45 INFO - PROCESS | 1917 | RSS: Main: 326860800 08:55:45 INFO - PROCESS | 1917 | 08:55:48 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52432/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52432/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:55:48 INFO - PROCESS | 1917 | RSS: Main: 320520192 08:55:48 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:52432/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52432/tests/kraken/driver.html?testName=ai-astar) 08:55:50 INFO - PROCESS | 1917 | RSS: Main: 364077056 08:55:50 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | __start_tp_report 08:55:50 INFO - PROCESS | 1917 | _x_x_mozilla_page_load 08:55:50 INFO - PROCESS | 1917 | _x_x_mozilla_page_load_details 08:55:50 INFO - PROCESS | 1917 | |i|pagename|runs| 08:55:50 INFO - PROCESS | 1917 | |0;ai-astar;113;114;114;113;113;114;113;112;114;114 08:55:50 INFO - PROCESS | 1917 | |1;audio-beat-detection;138;110;108;145;109;110;109;108;128;108 08:55:50 INFO - PROCESS | 1917 | |2;audio-dft;188;184;185;183;184;182;181;180;184;183 08:55:50 INFO - PROCESS | 1917 | |3;audio-fft;80;58;60;87;61;61;73;82;74;58 08:55:50 INFO - PROCESS | 1917 | |4;audio-oscillator;89;69;86;67;70;69;84;69;70;84 08:55:50 INFO - PROCESS | 1917 | |5;imaging-gaussian-blur;90;88;91;88;91;88;91;88;89;87 08:55:50 INFO - PROCESS | 1917 | |6;imaging-darkroom;100;100;99;100;98;100;100;100;101;100 08:55:50 INFO - PROCESS | 1917 | |7;imaging-desaturate;88;86;87;84;86;87;86;88;86;86 08:55:50 INFO - PROCESS | 1917 | |8;json-parse-financial;58;57;57;57;58;55;56;76;85;86 08:55:50 INFO - PROCESS | 1917 | |9;json-stringify-tinderbox;67;73;73;75;73;72;70;72;71;71 08:55:50 INFO - PROCESS | 1917 | |10;stanford-crypto-aes;88;88;86;83;87;86;86;90;93;88 08:55:50 INFO - PROCESS | 1917 | |11;stanford-crypto-ccm;140;139;156;154;144;134;150;143;211;177 08:55:50 INFO - PROCESS | 1917 | |12;stanford-crypto-pbkdf2;174;172;172;171;185;176;173;172;173;177 08:55:50 INFO - PROCESS | 1917 | |13;stanford-crypto-sha256-iterative;67;69;68;68;69;59;58;58;58;76 08:55:50 INFO - PROCESS | 1917 | __end_tp_report 08:55:50 INFO - PROCESS | 1917 | __start_cc_report 08:55:50 INFO - PROCESS | 1917 | _x_x_mozilla_cycle_collect,1975 08:55:50 INFO - PROCESS | 1917 | __end_cc_report 08:55:50 INFO - PROCESS | 1917 | __startTimestamp1484153750696__endTimestamp 08:55:50 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | ------- Summary: start ------- 08:55:50 INFO - PROCESS | 1917 | Number of tests: 14 08:55:50 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 08:55:50 INFO - PROCESS | 1917 | Values: 113.0 114.0 114.0 113.0 113.0 114.0 113.0 112.0 114.0 114.0 08:55:50 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | [#1] audio-beat-detection Cycles:10 Average:117.30 Median:110.00 stddev:14.20 (12.9%) stddev-sans-first:12.93 08:55:50 INFO - PROCESS | 1917 | Values: 138.0 110.0 108.0 145.0 109.0 110.0 109.0 108.0 128.0 108.0 08:55:50 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:2.22 (1.2%) stddev-sans-first:1.62 08:55:50 INFO - PROCESS | 1917 | Values: 188.0 184.0 185.0 183.0 184.0 182.0 181.0 180.0 184.0 183.0 08:55:50 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | [#3] audio-fft Cycles:10 Average:69.40 Median:73.50 stddev:11.08 (15.1%) stddev-sans-first:11.07 08:55:50 INFO - PROCESS | 1917 | Values: 80.0 58.0 60.0 87.0 61.0 61.0 73.0 82.0 74.0 58.0 08:55:50 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:77.00 stddev:8.79 (11.4%) stddev-sans-first:7.90 08:55:50 INFO - PROCESS | 1917 | Values: 89.0 69.0 86.0 67.0 70.0 69.0 84.0 69.0 70.0 84.0 08:55:50 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | [#5] imaging-gaussian-blur Cycles:10 Average:89.10 Median:89.50 stddev:1.52 (1.7%) stddev-sans-first:1.58 08:55:50 INFO - PROCESS | 1917 | Values: 90.0 88.0 91.0 88.0 91.0 88.0 91.0 88.0 89.0 87.0 08:55:50 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | [#6] imaging-darkroom Cycles:10 Average:99.80 Median:100.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 08:55:50 INFO - PROCESS | 1917 | Values: 100.0 100.0 99.0 100.0 98.0 100.0 100.0 100.0 101.0 100.0 08:55:50 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:86.50 stddev:1.17 (1.4%) stddev-sans-first:1.09 08:55:50 INFO - PROCESS | 1917 | Values: 88.0 86.0 87.0 84.0 86.0 87.0 86.0 88.0 86.0 86.0 08:55:50 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:58.00 stddev:12.61 (21.7%) stddev-sans-first:13.15 08:55:50 INFO - PROCESS | 1917 | Values: 58.0 57.0 57.0 57.0 58.0 55.0 56.0 76.0 85.0 86.0 08:55:50 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.50 stddev:2.16 (3.0%) stddev-sans-first:1.48 08:55:50 INFO - PROCESS | 1917 | Values: 67.0 73.0 73.0 75.0 73.0 72.0 70.0 72.0 71.0 71.0 08:55:50 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:88.00 stddev:2.68 (3.0%) stddev-sans-first:2.83 08:55:50 INFO - PROCESS | 1917 | Values: 88.0 88.0 86.0 83.0 87.0 86.0 86.0 90.0 93.0 88.0 08:55:50 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | [#11] stanford-crypto-ccm Cycles:10 Average:154.80 Median:152.00 stddev:23.17 (15.2%) stddev-sans-first:23.95 08:55:50 INFO - PROCESS | 1917 | Values: 140.0 139.0 156.0 154.0 144.0 134.0 150.0 143.0 211.0 177.0 08:55:50 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:173.50 stddev:4.14 (2.4%) stddev-sans-first:4.39 08:55:50 INFO - PROCESS | 1917 | Values: 174.0 172.0 172.0 171.0 185.0 176.0 173.0 172.0 173.0 177.0 08:55:50 INFO - PROCESS | 1917 | 08:55:50 INFO - PROCESS | 1917 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:68.00 stddev:6.31 (9.3%) stddev-sans-first:6.65 08:55:50 INFO - PROCESS | 1917 | Values: 67.0 69.0 68.0 68.0 69.0 59.0 58.0 58.0 58.0 76.0 08:55:50 INFO - PROCESS | 1917 | -------- Summary: end -------- 08:55:50 INFO - PROCESS | 1917 | 08:55:51 INFO - TEST-INFO | 1917: exit 0 08:55:51 INFO - TEST-OK | kraken | took 59667ms 08:55:51 INFO - SUITE-END | took 1180s 08:55:51 INFO - Completed test suite (00:19:40) 08:55:51 INFO - javascript benchmark 08:55:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3330.2007518195624, 3340.131565792894, 3349.179451034497, 3360.37833000895, 3414.1293970037636, 4687.69529980551, 5621.100623900166, 5650.237217975572, 5735.369109397968, 5755.971220143899, 5683.545316374691, 5688.488036076763, 5740.167675687023, 5759.596828222016, 5787.450192231731, 4166.458360413142, 5097.847064588068, 5134.229865520165, 5158.0, 5184.403793563732, 4610.450892078414, 5249.238860365244, 5307.097793375116, 5330.1205301125265, 5379.408265090837, 5292.470752924696, 5297.708626025567, 5305.1776974569, 5318.867028324304, 5328.786848526054, 5132.589392848563, 5189.014087323397, 5199.896002079937, 5224.555912747383, 5243.213517972296, 5116.155834287375, 5193.221016847466, 5200.089984252779, 5214.217867319894, 5214.687118772886, 5690.715464226772, 5713.485786279255, 5721.34204566476, 5728.885422291531, 5734.483896449339, 6198.442140207403, 6218.129461875341, 6221.377862213742, 6221.502279817649, 6223.159873417076, 6207.193064901534, 6230.844228894269, 6279.403456671655, 6314.778982735628, 6341.4926805855885, 5819.53443724501, 5834.883302334015, 5850.561207909382, 5851.151583020438, 5852.122181672698, 6285.277193122758, 6292.339304372975, 6297.527685423612, 6299.023651333959, 6300.936990630126, 5148.768305426265, 6011.947909115887, 6066.0, 6090.421409966046, 6163.722632481549, 6144.631322120597, 6300.905486417708, 6302.779402720975, 6303.180586523814, 6307.148534947723, 6116.344924030929, 6166.167567378437, 6171.537134714914, 6204.720787564571, 6227.346128656426, 6263.937360626335, 6287.9056814147825, 6303.495720342362, 6309.936900630935, 6321.336259692758, 4910.729909854992, 4947.975260123676, 4950.777215025332, 5015.398152221756, 5057.974710126426, 4408.228560001987, 4419.9337009944875, 4459.576340247671, 4484.39460672805, 4491.393661855673, 5885.499732522698, 5893.057110862242, 5894.616849904743, 5899.675517846474, 5911.349751527328, 6320.115183874262, 6320.462760665303, 6321.525885558602, 6339.366063393623, 6341.841453963595, 5646.632968857093, 5674.687892165888, 5688.488036076773, 5697.7151142443545, 5768.307803063575, 5450.754716037788, 5469.507744302952, 5484.067708489566, 5513.8345849624575, 5537.529310008695, 6321.431071203614, 6324.652144131933, 6327.8101656951285, 6340.270868850142, 6351.460125889351, 6080.118382834553, 6122.877542449215, 6253.5622506424115, 6299.118123462627, 6300.779472718433, 6223.3465486123305, 6273.498120150468, 6276.843078923063, 6301.6534090625455, 6323.272823625158, 6230.376962303733, 6246.3753624637175, 6277.71750271248, 6278.717457714322, 6279.466245369194, 6263.561550691408, 6290.8427289316305, 6292.056191571118, 6302.527310451826, 6324.810255692152, 6042.758289668364, 6075.27096748393, 6084.7566097357385, 6112.480439162543, 6113.5414843886, 5980.641161530322, 6142.293636231711, 6189.319174890848, 6193.81418557444, 6196.225471816023, 4937.382827146606, 5887.793927212527, 5961.970190149022, 5976.581639285208, 6027.6986150693165, 6121.051237058263, 6168.907466388097, 6176.969115154396, 6186.4741496973265, 6188.752449901954, 5216.921746173886, 5601.159826026129, 5798.275215598051, 5862.296524417097, 6024.608400453956], "value": 5698.492184337206, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.6652926628193, 467.4250671673839, 497.1473922223386, 499.291006770386, 499.92017242755645, 31558.84220578897, 41266.587334126685, 42888.0, 42914.78542607286, 43059.56940430603, 43406.348904766375, 43662.345064823974, 44126.55873441265, 44299.0, 44335.66992990208, 8506.659733610648, 9269.258459323239, 9291.674791382304, 9489.430634161938, 9497.050294970517, 8477.61850716716, 11205.775884482306, 11399.658010259705, 11416.657500275005, 11659.883401166007, 11407.030402415805, 11509.0, 11510.30938143714, 11513.330567067771, 11515.712107197345, 11382.317060976327, 11460.197786154973, 11479.770404591862, 11506.884931150666, 11514.712132196679, 11300.982911537918, 11313.886861131366, 11361.091112710963, 11377.544898204062, 11378.089752819755, 38660.420093698616, 39822.20355592901, 41552.58447415518, 42013.78993105015, 42087.57912420867, 3965.504311961005, 3981.900452488711, 3991.820368083443, 4019.437278780973, 4126.649234815044, 30037.849810751024, 31192.532112018336, 31218.53172202419, 31375.0, 31406.0, 3193.393255281489, 3226.757993150523, 3310.2055506678466, 3339.5992480902205, 3347.447671134284, 491706.0, 494009.5898561524, 496706.494025899, 497538.0, 497749.9999999964, 66371.66814165995, 66879.0, 66904.33095669078, 67027.65944681177, 67099.66450167718, 68049.65975170092, 68267.0, 68306.65846670834, 68521.65739171371, 68536.6573167131, 13731.862681373259, 16767.32930682759, 16778.916105419637, 16786.244618992176, 16793.328266869434, 11539.711507212387, 11876.931076203184, 12776.744465110645, 12865.807012894815, 12874.227546347249, 15007.27416347134, 16381.98641332881, 16740.330386784637, 18079.91520508774, 18999.43001709951, 6392.20097487814, 6453.677316134174, 6475.287718350977, 6477.6437295948235, 6490.545661803629, 863.5811631358786, 872.6204101215991, 876.3471213945651, 882.3646974178581, 900.4102312985005, 30412.391752164833, 30412.54381184284, 30580.69419305823, 30780.33171935728, 31316.37367252688, 904.5929331800716, 1054.2778196935124, 1080.3679847289425, 1087.9782404351868, 1202.9759404811855, 15386.38454461809, 15956.920215398848, 16088.517344479684, 16239.675206495804, 16420.425285114965, 608232.0, 615590.0, 621005.0, 621673.891630539, 621715.0, 52095.479045209824, 61699.0, 62864.68567657224, 62950.68524657439, 66391.0, 1269.3209133113924, 1387.9930600346934, 1415.6390120519202, 1441.4018182454165, 1445.3134760988446, 30565.694343056286, 31656.683433165374, 31940.0, 32232.83883580567, 32263.677363227005, 53817.73091134519, 54338.0, 54427.45572544224, 54459.36621901349, 54511.454885450636, 483749.0, 563701.0, 565457.0, 565634.0, 567986.0, 25602.35994100088, 26202.95188192451, 27007.1897843065, 27023.189304320902, 41643.7917810409, 35082.298354033286, 35239.647603523634, 35709.1072723184, 40829.0, 41679.37480937849, 37006.6299337014, 37105.62894371022, 37140.88577342684, 37875.0, 37953.4306985401, 36759.0, 36986.44520332143, 37633.81183094067, 37820.0, 38021.0, 35373.64626353703, 35687.464688029184, 36318.636813632584, 36319.910402687965, 36581.26837463289, 31436.913908736646, 32362.838185809862, 32990.17524561905, 32996.50505242375, 33096.007119786445, 24059.157929472385, 24102.87948560246, 24389.878050609634, 24515.303316635513, 24603.769811509712], "value": 20263.246414179164, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.3757556697069, 391.39334032250014, 398.1261131815662, 401.82520603537455, 419.0675746464118, 14172.929135354309, 19809.702854457177, 20330.69503957438, 20990.05544750486, 21012.264570740008, 16599.253033613488, 19474.221031158737, 20756.27353042644, 20902.477438064056, 20913.686294705552, 5647.407022262675, 5965.612235204698, 5970.8805823883495, 5984.192134061911, 5986.970065149668, 5734.752701278326, 5798.536117110642, 5824.767009319622, 5836.824895253128, 5862.912056319158, 4897.265410188483, 5754.1944127822135, 5768.509676677488, 5773.33606635236, 5792.942070579304, 5737.139429085629, 5782.884342313151, 7428.9257107428775, 7741.18717534662, 7819.491733037335, 7434.516756410816, 7644.655990480442, 7687.385009199251, 7714.6914123435, 7722.884156737653, 28473.28816779597, 28829.279268018257, 28830.855845720846, 28972.42055158906, 29431.558526622117, 2893.985530072336, 2940.8235505869716, 3002.324476992681, 3004.3240270938863, 3065.126438964907, 16495.83504164955, 16560.337586496527, 17109.887857289235, 17156.399526016656, 17572.560685982826, 1902.9048547572565, 1934.2263094762209, 1946.2993322403922, 1948.9317873874347, 2009.136071489259, 157350.0, 162507.0, 166304.16847915683, 167173.0, 168187.15906420513, 22789.658155127687, 22893.885530572574, 23001.539969200523, 23034.0, 23074.884625576764, 40388.394174087414, 40494.78515644535, 40601.390979135336, 40607.796961015, 40683.0, 8154.2253485918745, 8290.129536398592, 8612.48325100496, 8763.079876612865, 10345.63790267337, 8327.875081873777, 8367.121452247547, 8403.95798021006, 8485.660573577112, 8500.0, 3790.2608991246993, 3919.7256192066284, 3935.9212815743526, 4618.769061546976, 4799.112164249625, 1694.8729344672358, 1902.6015878329417, 1976.0909981408713, 2023.4435530229011, 2024.3662625587106, 916.2715641065236, 991.973307626603, 997.7356000659831, 1006.1146191351564, 1050.1965996013057, 17694.0, 19685.803141968685, 20706.792932070788, 21258.83076430811, 21268.383177989446, 1022.8414595737672, 1030.5929157982555, 1057.3338796558119, 1067.1036329483272, 1070.5289672544056, 10190.929952355043, 10618.256722029539, 10633.255672102878, 10662.040416362564, 10673.679789606324, 658497.0, 704389.4780526065, 714410.0, 735551.0, 741621.0, 143934.2803285998, 147285.0, 151382.48617513684, 152521.12183172614, 154418.0, 980.0444566547701, 984.5815528400544, 1023.1098943918689, 1052.8368102944055, 1060.867391576053, 19114.522136946132, 19358.516037099183, 19614.411567652995, 19645.508862277984, 19683.0, 38147.33083732139, 55947.321580352655, 56864.57838554069, 58536.707316463144, 59989.40010599838, 87531.0, 88184.67722984032, 88220.0, 88964.10697411705, 90098.0, 7968.36253099739, 8083.434159609006, 8150.959245203736, 8302.584870756558, 8380.706675266336, 12180.817287740514, 12566.308853012806, 12949.352532373532, 12997.09020368603, 13080.345982700637, 10520.579176832842, 10861.0, 10911.054015415952, 11072.0, 11094.722631934266, 10685.358878467317, 10863.782724345627, 10980.231383803377, 11308.434578271219, 11318.037966772916, 11119.0, 11122.165837562054, 11351.716207094889, 11467.598634047768, 11534.134939879375, 8086.8786968194345, 8282.088970213392, 8341.541215233221, 8439.620217090123, 8526.74419767408, 8757.737267881974, 10929.453527323762, 11317.660470185907, 11332.716682083013, 11338.773224535298], "value": 10704.307645014107, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.7358265138298, 1475.6532214929496, 1477.682298305864, 1501.144347721799, 1509.2227502836042, 7987.321077708394, 8407.831843363128, 8414.49513029217, 8416.032156302028, 8417.074121846592, 7407.407407407408, 7621.199774023731, 7644.235576442353, 7957.283844453998, 8213.42506024577, 2287.0737351372677, 2329.5108027314286, 2331.5103828196097, 2340.6137987232087, 2341.2976107167865, 2225.4213904384897, 2244.7194100737406, 2249.7300323961067, 2295.7704229576993, 2338.9415264618438, 1960.6568850451185, 2243.7547161325456, 2308.8383813133087, 2313.618252988255, 2336.217367181996, 2295.8392912496133, 2317.3743089365776, 2318.48993221491, 2319.860808351504, 2324.2910912171697, 2308.9191878284178, 2333.754955729641, 2338.356951838241, 2341.1454818991115, 2342.8242881783935, 6814.250432452426, 8295.751127466187, 8309.169083091643, 8373.204545568162, 8385.077641459435, 5011.373578302712, 5163.612729045337, 5166.61250406221, 5169.948300516984, 5183.196604526304, 3231.418344697953, 3308.5698859148156, 3517.613062563116, 3525.0, 3532.6643968822923, 1197.1320792425508, 1202.9578964736193, 1234.2039384596974, 1248.4881198708485, 1257.076049103908, 10583.73540661482, 10694.786104277871, 10704.411257380842, 10706.357618542834, 10724.14206863449, 4322.24360736876, 4538.88652783683, 4592.448906131285, 4648.697834640805, 4667.206574882278, 9297.395669281475, 9316.0, 9321.207697345666, 9327.906720932839, 9336.813263734823, 5193.428722840485, 5195.740212989335, 5207.244949482304, 5209.062368773657, 5210.062188805976, 4228.471441069866, 4503.301988191835, 4730.952690473051, 4755.025219829927, 4765.761711914391, 3746.625337466286, 3782.2624588205035, 3843.2121415110396, 3872.1481274119647, 3888.8833334999995, 1246.2584762066556, 1260.489501751792, 1264.652220639313, 1274.847018357803, 1275.1329096214479, 901.9819603607891, 919.2416256588341, 927.7216834949488, 927.8693242431932, 964.7829238421299, 5643.858903527363, 5699.458551437607, 5846.766129354778, 5937.498444182248, 6002.54980876436, 573.3406582430156, 584.3192680527224, 584.9853753656107, 595.0360416125903, 596.0641792385912, 3893.8637147699696, 3896.493455850721, 3953.2686453006286, 4000.27994960904, 4003.319435695939, 9497.0, 9746.512674366395, 9786.75533111678, 9982.450965196984, 9992.80014399708, 9925.602975880884, 9930.25523085757, 9932.354396964174, 9934.956829532939, 9946.45294508809, 7286.744963926237, 7722.382209423233, 7820.569868657279, 7828.217178282126, 7831.686732530635, 5050.04049230645, 5923.733431995484, 5980.641161530322, 5998.190244316961, 6046.57673962836, 9094.681686140953, 9107.453552786854, 9153.993060763178, 9158.443064678888, 9301.488418136796, 9212.631494740135, 9281.628734850801, 9286.164245217962, 9400.34197606161, 9430.764230894283, 6622.635755033327, 6824.249332573512, 6835.829104272433, 7099.538529995534, 7249.637518124178, 7601.201873803171, 7877.803054923673, 7879.645415956181, 7950.24472675095, 7968.163342848918, 6964.930350696428, 7072.646367681698, 7083.256258093033, 7129.0, 7215.278472152742, 6995.370416662525, 7011.859762804817, 7039.296070392919, 7043.647817609201, 7108.502404831612, 6361.7137228823885, 6379.585326953733, 6429.22849258092, 6436.420722135031, 6437.130987316652, 4066.694997875112, 4915.827946021872, 4961.3798275215595, 5022.573081288131, 5030.496950304941, 4907.0, 4987.376577927759, 5005.7997680092385, 5060.0, 5066.82266120684], "value": 4362.50499991412, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.028192611282, 358.32992304390774, 362.1435305502487, 372.2090557565172, 374.5991788786, 4638.698484598499, 5179.912218434129, 5272.73636318184, 5286.7356632168385, 5320.0, 4218.397009136524, 4227.661787057028, 4920.581750551208, 5105.719185444799, 5274.736263186835, 3359.496075588657, 3402.9149271268293, 3721.8883433496903, 4027.496562929634, 4050.412690159925, 3593.802340871251, 3761.5486141663037, 4138.482689663792, 4138.530821558348, 4175.373693945902, 3387.71204447621, 3989.4015897615445, 4086.119285903431, 4088.284550203717, 4091.0, 3377.9563364164574, 3648.343298206322, 3786.7503723771088, 4066.4103704962613, 4090.1819636072905, 3558.857645694169, 3564.055525285801, 3578.856845726194, 3585.2650206707563, 3590.4793804898404, 5124.975004999015, 5150.690958542499, 5156.948430515685, 5178.012930043845, 5194.63637545372, 4272.423222864904, 4484.529124441952, 4499.325101234808, 4637.217669398334, 4699.295105734133, 4862.367892173995, 5517.889642207174, 5524.226608274845, 5537.833864984057, 5553.222548843165, 3395.5416018837386, 3428.7428442866885, 3925.685945124383, 4041.4948131483566, 4060.593940605945, 5482.945170548283, 5495.0, 5788.616586574526, 5789.189513468118, 5851.210086638292, 3392.8982130536124, 3506.1409954560786, 4073.5926407359025, 4074.6536544394057, 4091.161311931047, 3800.144967382372, 3855.1133239355104, 4136.482939632546, 4178.770167640809, 4181.0071381830885, 3924.823382947774, 3941.3693808990424, 4446.288593825037, 4664.950386163154, 4752.809887604457, 5549.139883318092, 5567.526760225345, 5596.3284405870745, 5601.971990140023, 5697.515711164515, 1190.6666133482638, 1202.6572426858304, 1300.6618279247464, 1339.5378594384922, 1349.2646507653155, 794.3367288314322, 833.3957880536684, 839.5760141128814, 926.4898215908162, 949.6248981652209, 4102.179564087194, 4280.651594747645, 4407.008423104776, 4582.839600613963, 4754.286856971482, 4671.696339737906, 5073.63667246168, 5212.279947617277, 5315.654482458628, 5319.441458646864, 4133.648639865585, 4198.349255865346, 4380.78096095194, 4635.281531362644, 4886.0, 2255.853369531008, 2522.785563227146, 2658.24240091573, 2799.6780370257275, 2819.379736457976, 4611.377464042312, 4763.095011947788, 5101.69389836611, 5158.587313015025, 5356.419856142447, 4923.655344125948, 4987.600991920638, 5451.427600102012, 5467.808626698046, 5541.473560011793, 5467.516636358148, 5474.972625136928, 5481.232627432163, 5521.420250873681, 5527.336719593674, 4691.953080469151, 4976.029674213493, 5327.813526526553, 5328.813491527778, 5337.438029745666, 4624.606908412823, 4662.440507139165, 4670.065986802585, 5109.799197188732, 5254.947450525446, 4896.491447121988, 5453.7545810439415, 5482.205080263259, 5529.834104976857, 5539.753555449992, 3261.624913134925, 3395.0833275016103, 3453.913652158716, 3821.9934534369677, 3828.2917660232947, 4372.606465418127, 5284.471552844685, 5325.387580428301, 5651.915221271766, 5717.342505611741, 4647.86056418308, 5434.929264965282, 5510.008198524304, 5526.613137080527, 5558.305211848519, 4430.490493593149, 4645.558671926162, 5216.530512253916, 5557.972210138923, 5567.777288908398, 4501.819927203006, 5229.921551176812, 5246.580273578181, 5357.651752636066, 5469.644473109235, 4538.7957541911355, 4962.602991760578, 5353.839384818461, 5431.511163995259, 5437.374701909331, 4610.884727881829, 4750.738709370879, 5413.1880217966045, 5421.3765416975975, 5424.593155513273], "value": 3941.408121541841, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.5477283742125, 705.9329363710445, 721.2715157690731, 739.6486668832306, 765.3876898481213, 12620.548636906748, 14076.507322243724, 15031.92484037581, 15812.288447019882, 15843.366265349372, 14152.363143658535, 14268.215248161347, 14645.048071875348, 14645.633859153526, 14682.926585367059, 841.3731769831469, 869.1308691308691, 870.0472982084607, 871.3856731004659, 872.9258013068896, 690.278658801551, 708.2386434582818, 713.4114355656578, 845.2857335551449, 852.5822347049963, 916.3631276263, 920.5903372999018, 920.6593560382668, 921.2491819167391, 924.3945215883607, 916.8028873792167, 920.5121285718546, 921.0743203080895, 921.8340698674236, 923.2475532441106, 529.3356837169366, 541.0720614146758, 658.5061204096927, 681.7954613615896, 682.74738346812, 13454.730905381837, 14859.554213373616, 14909.478168264059, 15355.309011094416, 15375.846241537552, 13606.727865442635, 13674.658133546642, 13849.861501384958, 13904.721905561933, 14005.78991315121, 12666.74666506674, 12867.292298923556, 12954.157979731288, 13026.34868256593, 13472.865271347357, 4422.253922967188, 4444.777761111964, 4527.501974782771, 4596.264597664358, 4675.041616468616, 120012.39993800063, 120719.0, 122267.0, 122449.16326255024, 124907.37546312211, 10911.781764364669, 11011.504482298316, 11063.0, 11180.496877640526, 11481.0815134789, 19882.801171988383, 20601.175952961712, 21608.459788505097, 22030.0, 22084.779152208273, 7695.576743279062, 7698.653560589787, 7726.420518461138, 7733.110692270348, 7930.5638189898955, 4093.0, 4162.7502349859105, 4172.895677608084, 4203.684723645739, 4225.632848315689, 3336.4494858348585, 3391.4404123319378, 3436.9312613747584, 3438.914027149291, 3441.328940856559, 623.1431781300712, 626.145311649595, 637.0635166305524, 640.3180612647516, 646.767163821024, 644.616453210339, 649.3182158733312, 649.9902501462482, 653.8365408647838, 657.5890068707058, 9195.724128276162, 9197.632094716137, 9427.057294270655, 9745.415275083518, 11151.721206969729, 591.7544219149091, 594.7591225553658, 598.949089327412, 610.3621715307426, 722.0, 4534.433195850519, 4968.378952630921, 4984.277279794482, 5008.799648014112, 5013.3983921928875, 99206.0, 101743.4912825446, 102188.48905755572, 103657.96342036634, 105624.0, 88129.55935220284, 91141.0, 93118.4128952265, 94027.52986235161, 94472.52763736137, 77005.0, 79032.0, 79712.0, 79765.00587485476, 81577.59211204025, 9719.125278724949, 9795.804083918425, 9806.411615303105, 9821.508924553887, 9832.459214742972, 50856.74571627118, 51810.74094629503, 51927.22109168441, 52107.0, 52602.0, 63081.68459157858, 65270.0, 66609.33390666226, 72832.63583682048, 75009.6249518749, 13008.609741707764, 13034.543790967271, 13219.66950826237, 13481.98885083603, 13550.661233469242, 14541.636459088608, 14915.0, 15133.621659458602, 15233.086014839146, 15245.771313430085, 11923.940380298043, 11931.761364772483, 14005.439782408997, 14498.275086245856, 14621.92689036548, 13517.59447216585, 13718.501782045914, 13949.58151255464, 14123.929380353033, 14243.0, 13494.595162145151, 13667.521636742666, 13706.725865482835, 13875.306234688023, 14204.934629903006, 11067.335959842436, 11171.273867198606, 11361.943190283995, 11428.941947518655, 11776.470058847544, 11172.888271117185, 11243.04434123076, 11318.283611932911, 11398.658040258806, 11570.247933884271], "value": 7562.961384306038, "unit": "score"}], "name": "dromaeo_css", "value": 7373.830148284856, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 112.0, 114.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 110.0, 108.0, 145.0, 109.0, 110.0, 109.0, 108.0, 128.0, 108.0], "value": 117.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 184.0, 185.0, 183.0, 184.0, 182.0, 181.0, 180.0, 184.0, 183.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 60.0, 87.0, 61.0, 61.0, 73.0, 82.0, 74.0, 58.0], "value": 69.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 86.0, 67.0, 70.0, 69.0, 84.0, 69.0, 70.0, 84.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 91.0, 88.0, 91.0, 88.0, 91.0, 88.0, 89.0, 87.0], "value": 89.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 100.0, 99.0, 100.0, 98.0, 100.0, 100.0, 100.0, 101.0, 100.0], "value": 99.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 84.0, 86.0, 87.0, 86.0, 88.0, 86.0, 86.0], "value": 86.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 57.0, 58.0, 55.0, 56.0, 76.0, 85.0, 86.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 73.0, 75.0, 73.0, 72.0, 70.0, 72.0, 71.0, 71.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 86.0, 83.0, 87.0, 86.0, 86.0, 90.0, 93.0, 88.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 156.0, 154.0, 144.0, 134.0, 150.0, 143.0, 211.0, 177.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 172.0, 171.0, 185.0, 176.0, 173.0, 172.0, 173.0, 177.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 68.0, 68.0, 69.0, 59.0, 58.0, 58.0, 58.0, 76.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1452.5, "alertThreshold": 2.0}]} 08:55:51 INFO - Return code: 0 08:55:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:55:51 INFO - # TBPL SUCCESS # 08:55:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:55:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:55:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:55:51 INFO - 2017-01-11 08:55:51.979 screenresolution[1921:16731] starting screenresolution argv=screenresolution get 08:55:51 INFO - 2017-01-11 08:55:51.982 screenresolution[1921:16731] Display 0: 1600x1200x32@60 08:55:51 INFO - 2017-01-11 08:55:51.988 screenresolution[1922:16734] starting screenresolution argv=screenresolution list 08:55:51 INFO - Available Modes on Display 0 08:55:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:55:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:55:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:55:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:55:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:55:52 INFO - Intel Iris: 08:55:52 INFO - Chipset Model: Intel Iris 08:55:52 INFO - Type: GPU 08:55:52 INFO - Bus: Built-In 08:55:52 INFO - VRAM (Dynamic, Max): 1536 MB 08:55:52 INFO - Vendor: Intel (0x8086) 08:55:52 INFO - Device ID: 0x0a2e 08:55:52 INFO - Revision ID: 0x0009 08:55:52 INFO - Displays: 08:55:52 INFO - Display: 08:55:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:55:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:55:52 INFO - Display Serial Number: 1600x1200 60 08:55:52 INFO - Main Display: Yes 08:55:52 INFO - Mirror: Off 08:55:52 INFO - Online: Yes 08:55:52 INFO - Rotation: Supported 08:55:52 INFO - Return code: 0 08:55:52 INFO - Running post-action listener: _resource_record_post_action 08:55:52 INFO - [mozharness: 2017-01-11 16:55:52.229243Z] Finished run-tests step (success) 08:55:52 INFO - Running post-run listener: _resource_record_post_run 08:55:52 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 1732608; Write bytes: 550425600; Read time: 12; Write time: 1681 08:55:52 INFO - TinderboxPrint: CPU usage
53.7% 08:55:52 INFO - TinderboxPrint: I/O read bytes / time
1,732,608 / 12 08:55:52 INFO - TinderboxPrint: I/O write bytes / time
550,425,600 / 1,681 08:55:52 INFO - TinderboxPrint: CPU idle
2,229.6 (46.3%) 08:55:52 INFO - TinderboxPrint: CPU system
965.0 (20.0%) 08:55:52 INFO - TinderboxPrint: CPU user
1,619.0 (33.6%) 08:55:52 INFO - TinderboxPrint: Swap in / out
252,329,984 / 0 08:55:52 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 237814272; Write bytes: 230363136; Read time: 17471; Write time: 500 08:55:52 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 1732608; Write bytes: 298550272; Read time: 12; Write time: 1128 08:55:52 INFO - Running post-run listener: _upload_blobber_files 08:55:52 INFO - Blob upload gear active. 08:55:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:55:52 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 08:55:52 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'] 08:55:52 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 08:55:53 INFO - (blobuploader) - INFO - Open directory for files ... 08:55:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:55:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:55:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:53 INFO - (blobuploader) - INFO - Done attempting. 08:55:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:55:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:55:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:54 INFO - (blobuploader) - INFO - Done attempting. 08:55:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:55:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:55:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:55 INFO - (blobuploader) - INFO - Done attempting. 08:55:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:55:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:55:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:58 INFO - (blobuploader) - INFO - Done attempting. 08:55:58 INFO - (blobuploader) - INFO - Iteration through files over. 08:55:58 INFO - Return code: 0 08:55:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:55:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:55:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b18f43b9d4b3dea6c9782565000e36ec642ceb739c3167dc91874ad6949ea2ce1277e8f6cd4afdfe2055dd2de5312d0da4420920ad351654611897215f609126", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c5dcb5ae6806334d5100dac4216218f7c5697cf427a31c75446d6dcbfc7b1ad6d46937dd45cf8f1078f5182232f9710c19d2ccc71fbc61553c20a92438ece98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfaca4e0472d4158dfbc5974984c0b60a08ddca2c02e8e06f1021ba9e0ed819479cdfa197f06bb68b3d412965bd3b5f867dfb7ce6edc5d4678d11cd872e5256f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad0f54269a4fd904c12719cc4c74f744a32dd098bcc67ffd9edc3b6052a60dec01fa922bb4737ff7d3c0e5566fb6002eb80b3c50342fd657299519d972cfd1e6"} 08:55:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:55:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:55:58 INFO - Contents: 08:55:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b18f43b9d4b3dea6c9782565000e36ec642ceb739c3167dc91874ad6949ea2ce1277e8f6cd4afdfe2055dd2de5312d0da4420920ad351654611897215f609126", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c5dcb5ae6806334d5100dac4216218f7c5697cf427a31c75446d6dcbfc7b1ad6d46937dd45cf8f1078f5182232f9710c19d2ccc71fbc61553c20a92438ece98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfaca4e0472d4158dfbc5974984c0b60a08ddca2c02e8e06f1021ba9e0ed819479cdfa197f06bb68b3d412965bd3b5f867dfb7ce6edc5d4678d11cd872e5256f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad0f54269a4fd904c12719cc4c74f744a32dd098bcc67ffd9edc3b6052a60dec01fa922bb4737ff7d3c0e5566fb6002eb80b3c50342fd657299519d972cfd1e6"} 08:55:58 INFO - Running post-run listener: copy_logs_to_upload_dir 08:55:58 INFO - Copying logs to upload dir... 08:55:58 INFO - mkdir: /builds/slave/test/build/upload/logs 08:55:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.605857 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-11 08:55:59.051949) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 08:55:59.060084) ========= 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.V4woBDST4I/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.euA1xGJ4Ao/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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/b18f43b9d4b3dea6c9782565000e36ec642ceb739c3167dc91874ad6949ea2ce1277e8f6cd4afdfe2055dd2de5312d0da4420920ad351654611897215f609126", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c5dcb5ae6806334d5100dac4216218f7c5697cf427a31c75446d6dcbfc7b1ad6d46937dd45cf8f1078f5182232f9710c19d2ccc71fbc61553c20a92438ece98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfaca4e0472d4158dfbc5974984c0b60a08ddca2c02e8e06f1021ba9e0ed819479cdfa197f06bb68b3d412965bd3b5f867dfb7ce6edc5d4678d11cd872e5256f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad0f54269a4fd904c12719cc4c74f744a32dd098bcc67ffd9edc3b6052a60dec01fa922bb4737ff7d3c0e5566fb6002eb80b3c50342fd657299519d972cfd1e6"} build_url:https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011160 build_url: 'https://queue.taskcluster.net/v1/task/P2GXZY-zS-mPPhkQTACsWw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b18f43b9d4b3dea6c9782565000e36ec642ceb739c3167dc91874ad6949ea2ce1277e8f6cd4afdfe2055dd2de5312d0da4420920ad351654611897215f609126", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c5dcb5ae6806334d5100dac4216218f7c5697cf427a31c75446d6dcbfc7b1ad6d46937dd45cf8f1078f5182232f9710c19d2ccc71fbc61553c20a92438ece98", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfaca4e0472d4158dfbc5974984c0b60a08ddca2c02e8e06f1021ba9e0ed819479cdfa197f06bb68b3d412965bd3b5f867dfb7ce6edc5d4678d11cd872e5256f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad0f54269a4fd904c12719cc4c74f744a32dd098bcc67ffd9edc3b6052a60dec01fa922bb4737ff7d3c0e5566fb6002eb80b3c50342fd657299519d972cfd1e6"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 08:55:59.101587) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 08:55:59.102045) ========= 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.V4woBDST4I/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.euA1xGJ4Ao/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.005197 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 08:55:59.157606) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 08:55:59.158069) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 08:55:59.158459) ========= ========= Total master_lag: 0.75 =========