builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0178 starttime: 1489250315.9 results: success (0) buildid: 20170311080236 builduid: 1bb80191d4884421a932b85c3c74944b revision: 3154da520af568d4da3de62bc26fbf97a1317f51 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:35.903952) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:35.904368) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:35.904649) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:35.931497) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:35.931819) ========= 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.GK1psSsk5Z/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.6PZBToxTEp/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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-03-11 08:38:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.8M=0.001s 2017-03-11 08:38:36 (13.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136453 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.093386) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.093665) ========= 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.GK1psSsk5Z/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.6PZBToxTEp/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.025735 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.141663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.141997) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3154da520af568d4da3de62bc26fbf97a1317f51 --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 3154da520af568d4da3de62bc26fbf97a1317f51 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GK1psSsk5Z/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.6PZBToxTEp/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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-03-11 08:38:36,246 truncating revision to first 12 chars 2017-03-11 08:38:36,246 Setting DEBUG logging. 2017-03-11 08:38:36,247 attempt 1/10 2017-03-11 08:38:36,247 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3154da520af5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-11 08:38:36,541 unpacking tar archive at: mozilla-central-3154da520af5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.590472 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.756083) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.756453) ========= script_repo_revision: 3154da520af568d4da3de62bc26fbf97a1317f51 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.756958) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.757322) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.780285) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-03-11 08:38:36.780660) ========= /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.GK1psSsk5Z/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.6PZBToxTEp/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:38:36 INFO - MultiFileLogger online at 20170311 08:38:36 in /builds/slave/test 08:38:36 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:38:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:38:36 INFO - {'append_to_log': False, 08:38:36 INFO - 'base_work_dir': '/builds/slave/test', 08:38:36 INFO - 'blob_upload_branch': 'Firefox', 08:38:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:38:36 INFO - 'branch': 'Firefox', 08:38:36 INFO - 'buildbot_json_path': 'buildprops.json', 08:38:36 INFO - 'config_files': ('talos/mac_config.py',), 08:38:36 INFO - 'default_actions': ('clobber', 08:38:36 INFO - 'read-buildbot-config', 08:38:36 INFO - 'download-and-extract', 08:38:36 INFO - 'populate-webroot', 08:38:36 INFO - 'create-virtualenv', 08:38:36 INFO - 'install', 08:38:36 INFO - 'run-tests'), 08:38:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:38:36 INFO - 'download_minidump_stackwalk': True, 08:38:36 INFO - 'download_symbols': 'ondemand', 08:38:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:38:36 INFO - 'tooltool.py': '/tools/tooltool.py', 08:38:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:38:36 INFO - '/tools/misc-python/virtualenv.py')}, 08:38:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:38:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:38:36 INFO - 'gecko_profile': False, 08:38:37 INFO - 'gecko_profile_interval': 0, 08:38:37 INFO - 'installer_path': 'installer.exe', 08:38:37 INFO - 'log_level': 'info', 08:38:37 INFO - 'log_name': 'talos', 08:38:37 INFO - 'log_to_console': True, 08:38:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:38:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:38:37 INFO - 'opt_config_files': (), 08:38:37 INFO - 'pip_index': False, 08:38:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:38:37 INFO - 'cmd': ('bash', 08:38:37 INFO - '-c', 08:38:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:38:37 INFO - 'enabled': True, 08:38:37 INFO - 'halt_on_failure': False, 08:38:37 INFO - 'name': 'check_screen_resolution'},), 08:38:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:38:37 INFO - 'cmd': ('bash', 08:38:37 INFO - '-c', 08:38:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:38:37 INFO - 'enabled': True, 08:38:37 INFO - 'halt_on_failure': False, 08:38:37 INFO - 'name': 'check_screen_resolution'},), 08:38:37 INFO - 'run_cmd_checks_enabled': True, 08:38:37 INFO - 'suite': 'dromaeojs', 08:38:37 INFO - 'system_bits': '32', 08:38:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:38:37 INFO - 'title': 't-yosemite-r7-0178', 08:38:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:38:37 INFO - 'use_talos_json': True, 08:38:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:38:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:38:37 INFO - 'work_dir': 'build'} 08:38:37 INFO - [mozharness: 2017-03-11 16:38:37.003506Z] Running clobber step. 08:38:37 INFO - Running pre-action listener: _resource_record_pre_action 08:38:37 INFO - Running main action method: clobber 08:38:37 INFO - rmtree: /builds/slave/test/build 08:38:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:38:39 INFO - Running post-action listener: _resource_record_post_action 08:38:39 INFO - [mozharness: 2017-03-11 16:38:39.496744Z] Finished clobber step (success) 08:38:39 INFO - [mozharness: 2017-03-11 16:38:39.496871Z] Running read-buildbot-config step. 08:38:39 INFO - Running pre-action listener: _resource_record_pre_action 08:38:39 INFO - Running main action method: read_buildbot_config 08:38:39 INFO - Using buildbot properties: 08:38:39 INFO - { 08:38:39 INFO - "project": "", 08:38:39 INFO - "product": "firefox", 08:38:39 INFO - "script_repo_revision": "production", 08:38:39 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:38:39 INFO - "repository": "", 08:38:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:38:39 INFO - "buildid": "20170311080236", 08:38:39 INFO - "pgo_build": "False", 08:38:39 INFO - "basedir": "/builds/slave/test", 08:38:39 INFO - "buildnumber": 5, 08:38:39 INFO - "slavename": "t-yosemite-r7-0178", 08:38:39 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:38:39 INFO - "platform": "yosemite_r7", 08:38:39 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:38:39 INFO - "branch": "mozilla-central", 08:38:39 INFO - "repo_path": "mozilla-central", 08:38:39 INFO - "revision": "3154da520af568d4da3de62bc26fbf97a1317f51", 08:38:39 INFO - "stage_platform": "macosx64", 08:38:39 INFO - "builduid": "1bb80191d4884421a932b85c3c74944b", 08:38:39 INFO - "slavebuilddir": "test" 08:38:39 INFO - } 08:38:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 08:38:39 INFO - Running post-action listener: _resource_record_post_action 08:38:39 INFO - [mozharness: 2017-03-11 16:38:39.500106Z] Finished read-buildbot-config step (success) 08:38:39 INFO - [mozharness: 2017-03-11 16:38:39.500205Z] Running download-and-extract step. 08:38:39 INFO - Running pre-action listener: _resource_record_pre_action 08:38:39 INFO - Running main action method: download_and_extract 08:38:39 INFO - mkdir: /builds/slave/test/build/tests 08:38:39 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:38:39 INFO - trying https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 08:38:39 INFO - Downloading https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:38:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 08:38:40 INFO - Downloaded 1199 bytes. 08:38:40 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:38:40 INFO - Using the following test package requirements: 08:38:40 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:38:40 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:40 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 08:38:40 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:40 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 08:38:40 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:40 INFO - u'jsshell-mac.zip'], 08:38:40 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:40 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 08:38:40 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:38:40 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:40 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 08:38:40 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:40 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 08:38:40 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:40 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 08:38:40 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:40 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 08:38:40 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:38:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:38:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:38:40 INFO - Fetch https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:38:42 INFO - Expected file size: 51787241 08:38:42 INFO - Obtained file size: 51787241 08:38:58 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:38:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:38:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:38:58 INFO - Fetch https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:39:00 INFO - Expected file size: 51787241 08:39:00 INFO - Obtained file size: 51787241 08:39:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 08:39:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:39:15 INFO - Fetch https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 08:39:16 INFO - Expected file size: 14404438 08:39:16 INFO - Obtained file size: 14404438 08:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:17 INFO - trying https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:39:17 INFO - Downloading https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 08:39:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 08:39:19 INFO - Downloaded 74939199 bytes. 08:39:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:39:19 INFO - mkdir: /builds/slave/test/properties 08:39:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:39:19 INFO - Writing to file /builds/slave/test/properties/build_url 08:39:19 INFO - Contents: 08:39:19 INFO - build_url:https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:39:19 INFO - Running post-action listener: _resource_record_post_action 08:39:19 INFO - Running post-action listener: set_extra_try_arguments 08:39:19 INFO - [mozharness: 2017-03-11 16:39:19.966603Z] Finished download-and-extract step (success) 08:39:19 INFO - [mozharness: 2017-03-11 16:39:19.966726Z] Running populate-webroot step. 08:39:19 INFO - Running pre-action listener: _resource_record_pre_action 08:39:19 INFO - Running main action method: populate_webroot 08:39:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:39:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:39:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:39:19 INFO - '--tppagecycles', 08:39:19 INFO - '7'], 08:39:19 INFO - 'tests': ['tsvgm']}}, 08:39:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:39:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:39:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:39:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:39:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:39:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:39:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:39:19 INFO - 'talos_options': ['--disable-e10s'], 08:39:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:39:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:39:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:39:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:39:19 INFO - 'talos_options': ['--disable-e10s'], 08:39:19 INFO - 'tests': ['damp', 'tps']}, 08:39:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:39:19 INFO - 'tests': ['damp', 'tps']}, 08:39:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:39:19 INFO - 'tests': ['dromaeo_dom']}, 08:39:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:39:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:39:19 INFO - 'tests': ['basic_compositor_video']}, 08:39:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:39:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:39:19 INFO - 'tests': ['a11yr', 08:39:19 INFO - 'ts_paint', 08:39:19 INFO - 'tpaint', 08:39:19 INFO - 'sessionrestore', 08:39:19 INFO - 'sessionrestore_no_auto_restore', 08:39:19 INFO - 'tabpaint']}, 08:39:19 INFO - 'other-e10s': {'tests': ['a11yr', 08:39:19 INFO - 'ts_paint', 08:39:19 INFO - 'tpaint', 08:39:19 INFO - 'sessionrestore', 08:39:19 INFO - 'sessionrestore_no_auto_restore', 08:39:19 INFO - 'tabpaint']}, 08:39:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:39:19 INFO - 'ts_paint', 08:39:19 INFO - 'tpaint', 08:39:19 INFO - 'sessionrestore', 08:39:19 INFO - 'sessionrestore_no_auto_restore', 08:39:19 INFO - 'tabpaint']}, 08:39:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:39:19 INFO - 'ts_paint', 08:39:19 INFO - 'tpaint', 08:39:19 INFO - 'sessionrestore', 08:39:19 INFO - 'sessionrestore_no_auto_restore', 08:39:19 INFO - 'tabpaint']}, 08:39:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:39:19 INFO - 'tests': ['a11yr', 08:39:19 INFO - 'ts_paint', 08:39:19 INFO - 'tpaint', 08:39:19 INFO - 'sessionrestore', 08:39:19 INFO - 'sessionrestore_no_auto_restore', 08:39:19 INFO - 'tabpaint']}, 08:39:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:39:19 INFO - 'tests': ['a11yr', 08:39:19 INFO - 'ts_paint', 08:39:19 INFO - 'tpaint', 08:39:19 INFO - 'sessionrestore', 08:39:19 INFO - 'sessionrestore_no_auto_restore', 08:39:19 INFO - 'tabpaint']}, 08:39:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:39:19 INFO - 'tests': ['tsvgx', 08:39:19 INFO - 'tsvgr_opacity', 08:39:19 INFO - 'tart', 08:39:19 INFO - 'tscrollx', 08:39:19 INFO - 'cart', 08:39:19 INFO - 'tsvg_static']}, 08:39:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:39:19 INFO - 'tsvgr_opacity', 08:39:19 INFO - 'tart', 08:39:19 INFO - 'tscrollx', 08:39:19 INFO - 'cart', 08:39:19 INFO - 'tsvg_static']}, 08:39:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:39:19 INFO - 'talos_options': ['--disable-e10s'], 08:39:19 INFO - 'tests': ['tp5o']}, 08:39:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:39:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:39:19 INFO - 'talos_options': ['--disable-e10s', 08:39:19 INFO - '--xperf_path', 08:39:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:39:19 INFO - 'tests': ['tp5n']}, 08:39:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:39:19 INFO - 'talos_options': ['--xperf_path', 08:39:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:39:19 INFO - 'tests': ['tp5n']}}, 08:39:19 INFO - 'talos.zip': {'path': '', 08:39:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:39:19 INFO - Running post-action listener: _resource_record_post_action 08:39:19 INFO - [mozharness: 2017-03-11 16:39:19.984941Z] Finished populate-webroot step (success) 08:39:19 INFO - [mozharness: 2017-03-11 16:39:19.985086Z] Running create-virtualenv step. 08:39:19 INFO - Running pre-action listener: _resource_record_pre_action 08:39:19 INFO - Running main action method: create_virtualenv 08:39:19 INFO - Creating virtualenv /builds/slave/test/build/venv 08:39:19 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:39:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:39:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:39:20 INFO - Using real prefix '/tools/python27' 08:39:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:39:20 INFO - Installing distribute.............................................................................................................................................................................................done. 08:39:23 INFO - Installing pip.................done. 08:39:23 INFO - Return code: 0 08:39:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:39:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:39:23 INFO - Reading from file tmpfile_stdout 08:39:23 INFO - Output received: 08:39:23 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:39:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9428c6ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cdad30>, '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 0x109c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccfbe8>, '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.GK1psSsk5Z/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.6PZBToxTEp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:39: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', 'pip>=1.5'] in /builds/slave/test/build 08:39: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 pip>=1.5 08:39:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GK1psSsk5Z/Render', 08:39:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:24 INFO - 'HOME': '/Users/cltbld', 08:39:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:24 INFO - 'LOGNAME': 'cltbld', 08:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:24 INFO - 'MOZ_NO_REMOTE': '1', 08:39:24 INFO - 'NO_EM_RESTART': '1', 08:39:24 INFO - 'PAGER': '/bin/cat', 08:39:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:24 INFO - 'PWD': '/builds/slave/test', 08:39:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:24 INFO - 'SHELL': '/bin/bash', 08:39:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PZBToxTEp/Listeners', 08:39:24 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 08:39:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:24 INFO - 'USER': 'cltbld', 08:39:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:24 INFO - 'XPC_FLAGS': '0x0', 08:39:24 INFO - 'XPC_SERVICE_NAME': '0', 08:39:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:24 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:39:24 INFO - Cleaning up... 08:39:24 INFO - Return code: 0 08:39:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:39: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:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9428c6ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cdad30>, '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 0x109c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccfbe8>, '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.GK1psSsk5Z/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.6PZBToxTEp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:39:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:39:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GK1psSsk5Z/Render', 08:39:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:25 INFO - 'HOME': '/Users/cltbld', 08:39:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:25 INFO - 'LOGNAME': 'cltbld', 08:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:25 INFO - 'MOZ_NO_REMOTE': '1', 08:39:25 INFO - 'NO_EM_RESTART': '1', 08:39:25 INFO - 'PAGER': '/bin/cat', 08:39:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:25 INFO - 'PWD': '/builds/slave/test', 08:39:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:25 INFO - 'SHELL': '/bin/bash', 08:39:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PZBToxTEp/Listeners', 08:39:25 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 08:39:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:25 INFO - 'USER': 'cltbld', 08:39:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:25 INFO - 'XPC_FLAGS': '0x0', 08:39:25 INFO - 'XPC_SERVICE_NAME': '0', 08:39:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:25 INFO - Downloading/unpacking psutil>=3.1.1 08:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:39:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:29 INFO - Installing collected packages: psutil 08:39:29 INFO - Running setup.py install for psutil 08:39:29 INFO - building 'psutil._psutil_osx' extension 08:39:29 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:39:30 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:39:30 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:39:30 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:39:30 INFO - building 'psutil._psutil_posix' extension 08:39:30 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:39:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:39:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:39:30 INFO - ^ 08:39:30 INFO - 1 warning generated. 08:39:30 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:39:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:30 INFO - Successfully installed psutil 08:39:30 INFO - Cleaning up... 08:39:30 INFO - Return code: 0 08:39:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:30 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 0x109efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9428c6ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cdad30>, '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 0x109c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccfbe8>, '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.GK1psSsk5Z/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.6PZBToxTEp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:39:30 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:39:30 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:39:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GK1psSsk5Z/Render', 08:39:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:30 INFO - 'HOME': '/Users/cltbld', 08:39:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:30 INFO - 'LOGNAME': 'cltbld', 08:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:30 INFO - 'MOZ_NO_REMOTE': '1', 08:39:30 INFO - 'NO_EM_RESTART': '1', 08:39:30 INFO - 'PAGER': '/bin/cat', 08:39:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:30 INFO - 'PWD': '/builds/slave/test', 08:39:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:30 INFO - 'SHELL': '/bin/bash', 08:39:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PZBToxTEp/Listeners', 08:39:30 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 08:39:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:30 INFO - 'USER': 'cltbld', 08:39:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:30 INFO - 'XPC_FLAGS': '0x0', 08:39:30 INFO - 'XPC_SERVICE_NAME': '0', 08:39:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:39: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:39: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:39: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:39: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:39: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:39: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:39:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:39:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:39:33 INFO - Installing collected packages: mozsystemmonitor 08:39:33 INFO - Running setup.py install for mozsystemmonitor 08:39:33 INFO - Successfully installed mozsystemmonitor 08:39:33 INFO - Cleaning up... 08:39:33 INFO - Return code: 0 08:39:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:39:33 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:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:33 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:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:33 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 0x109efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9428c6ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cdad30>, '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 0x109c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccfbe8>, '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.GK1psSsk5Z/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.6PZBToxTEp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:39:33 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:39:33 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:39:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GK1psSsk5Z/Render', 08:39:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:33 INFO - 'HOME': '/Users/cltbld', 08:39:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:33 INFO - 'LOGNAME': 'cltbld', 08:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:33 INFO - 'MOZ_NO_REMOTE': '1', 08:39:33 INFO - 'NO_EM_RESTART': '1', 08:39:33 INFO - 'PAGER': '/bin/cat', 08:39:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:33 INFO - 'PWD': '/builds/slave/test', 08:39:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:33 INFO - 'SHELL': '/bin/bash', 08:39:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PZBToxTEp/Listeners', 08:39:33 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 08:39:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:33 INFO - 'USER': 'cltbld', 08:39:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:33 INFO - 'XPC_FLAGS': '0x0', 08:39:33 INFO - 'XPC_SERVICE_NAME': '0', 08:39:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:34 INFO - Downloading/unpacking jsonschema==2.5.1 08:39:34 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:39:34 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:39:34 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:39:34 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:39:34 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:39:34 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:39:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:39:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:39: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:39: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:39: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:39: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:39: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:39: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:39:37 INFO - Downloading functools32-3.2.3-2.tar.gz 08:39:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:39:37 INFO - warning: no files found matching '*.txt' 08:39:37 INFO - no previously-included directories found matching 'build' 08:39:37 INFO - no previously-included directories found matching 'dist' 08:39:37 INFO - no previously-included directories found matching '.git*' 08:39:37 INFO - Installing collected packages: jsonschema, functools32 08:39:37 INFO - Running setup.py install for functools32 08:39:37 INFO - warning: no files found matching '*.txt' 08:39:37 INFO - no previously-included directories found matching 'build' 08:39:37 INFO - no previously-included directories found matching 'dist' 08:39:37 INFO - no previously-included directories found matching '.git*' 08:39:37 INFO - Successfully installed jsonschema functools32 08:39:37 INFO - Cleaning up... 08:39:37 INFO - Return code: 0 08:39:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:39: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:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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:39:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:37 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 0x109efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9428c6ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cdad30>, '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 0x109c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccfbe8>, '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.GK1psSsk5Z/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.6PZBToxTEp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:39:37 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:39:37 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:39:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GK1psSsk5Z/Render', 08:39:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:37 INFO - 'HOME': '/Users/cltbld', 08:39:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:37 INFO - 'LOGNAME': 'cltbld', 08:39:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:37 INFO - 'MOZ_NO_REMOTE': '1', 08:39:37 INFO - 'NO_EM_RESTART': '1', 08:39:37 INFO - 'PAGER': '/bin/cat', 08:39:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:37 INFO - 'PWD': '/builds/slave/test', 08:39:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:37 INFO - 'SHELL': '/bin/bash', 08:39:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PZBToxTEp/Listeners', 08:39:37 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 08:39:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:37 INFO - 'USER': 'cltbld', 08:39:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:37 INFO - 'XPC_FLAGS': '0x0', 08:39:37 INFO - 'XPC_SERVICE_NAME': '0', 08:39:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:39:37 INFO - Cleaning up... 08:39:37 INFO - Return code: 0 08:39:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:39: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:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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:39:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:37 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 0x109efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9428c6ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cdad30>, '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 0x109c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccfbe8>, '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.GK1psSsk5Z/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.6PZBToxTEp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:39:37 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:39:37 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:39:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GK1psSsk5Z/Render', 08:39:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:37 INFO - 'HOME': '/Users/cltbld', 08:39:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:37 INFO - 'LOGNAME': 'cltbld', 08:39:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:37 INFO - 'MOZ_NO_REMOTE': '1', 08:39:37 INFO - 'NO_EM_RESTART': '1', 08:39:37 INFO - 'PAGER': '/bin/cat', 08:39:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:37 INFO - 'PWD': '/builds/slave/test', 08:39:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:37 INFO - 'SHELL': '/bin/bash', 08:39:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PZBToxTEp/Listeners', 08:39:37 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 08:39:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:37 INFO - 'USER': 'cltbld', 08:39:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:37 INFO - 'XPC_FLAGS': '0x0', 08:39:37 INFO - 'XPC_SERVICE_NAME': '0', 08:39:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:39:38 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:39:38 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:39:38 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:39:38 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:39:38 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:39:38 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:39:40 INFO - Downloading blobuploader-1.2.4.tar.gz 08:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:39:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:39:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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:39:42 INFO - Downloading docopt-0.6.1.tar.gz 08:39:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:39:42 INFO - Installing collected packages: blobuploader, requests, docopt 08:39:42 INFO - Running setup.py install for blobuploader 08:39:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:39:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:39:42 INFO - Running setup.py install for requests 08:39:42 INFO - Running setup.py install for docopt 08:39:42 INFO - Successfully installed blobuploader requests docopt 08:39:42 INFO - Cleaning up... 08:39:43 INFO - Return code: 0 08:39:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:43 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:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:43 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:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:43 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 0x109efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9428c6ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cdad30>, '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 0x109c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccfbe8>, '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.GK1psSsk5Z/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.6PZBToxTEp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:39:43 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:39:43 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:39:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GK1psSsk5Z/Render', 08:39:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:43 INFO - 'HOME': '/Users/cltbld', 08:39:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:43 INFO - 'LOGNAME': 'cltbld', 08:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:43 INFO - 'MOZ_NO_REMOTE': '1', 08:39:43 INFO - 'NO_EM_RESTART': '1', 08:39:43 INFO - 'PAGER': '/bin/cat', 08:39:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:43 INFO - 'PWD': '/builds/slave/test', 08:39:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:43 INFO - 'SHELL': '/bin/bash', 08:39:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PZBToxTEp/Listeners', 08:39:43 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 08:39:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:43 INFO - 'USER': 'cltbld', 08:39:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:43 INFO - 'XPC_FLAGS': '0x0', 08:39:43 INFO - 'XPC_SERVICE_NAME': '0', 08:39:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-OtnH9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-30pCFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-5wz6DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Kter5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Ry9EfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-bdvFy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-AA5yNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-UhKUur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-J9LW7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-l0WiyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-sIuXms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-4vnz0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-uTaDh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Aq_pe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-2aVeJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-rAb34k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-NrsjHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:39:45 INFO - Running setup.py install for manifestparser 08:39:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:39:45 INFO - Running setup.py install for mozcrash 08:39:45 INFO - Running setup.py install for mozdebug 08:39:45 INFO - Running setup.py install for mozdevice 08:39:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:39:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:39:45 INFO - Running setup.py install for mozfile 08:39:45 INFO - Running setup.py install for mozhttpd 08:39:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:39:45 INFO - Running setup.py install for mozinfo 08:39:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Running setup.py install for mozInstall 08:39:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Running setup.py install for mozleak 08:39:46 INFO - Running setup.py install for mozlog 08:39:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Running setup.py install for moznetwork 08:39:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Running setup.py install for mozprocess 08:39:46 INFO - Running setup.py install for mozprofile 08:39:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:39:47 INFO - Running setup.py install for mozrunner 08:39:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:39:47 INFO - Running setup.py install for mozscreenshot 08:39:47 INFO - Running setup.py install for moztest 08:39:47 INFO - Running setup.py install for mozversion 08:39:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:39:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:39:47 INFO - Cleaning up... 08:39:47 INFO - Return code: 0 08:39:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39: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:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:47 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 0x109efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9428c6ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cdad30>, '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 0x109c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccfbe8>, '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.GK1psSsk5Z/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.6PZBToxTEp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:39:47 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:39:47 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:39:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GK1psSsk5Z/Render', 08:39:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:47 INFO - 'HOME': '/Users/cltbld', 08:39:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:47 INFO - 'LOGNAME': 'cltbld', 08:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:47 INFO - 'MOZ_NO_REMOTE': '1', 08:39:47 INFO - 'NO_EM_RESTART': '1', 08:39:47 INFO - 'PAGER': '/bin/cat', 08:39:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:47 INFO - 'PWD': '/builds/slave/test', 08:39:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:47 INFO - 'SHELL': '/bin/bash', 08:39:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PZBToxTEp/Listeners', 08:39:47 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 08:39:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:47 INFO - 'USER': 'cltbld', 08:39:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:47 INFO - 'XPC_FLAGS': '0x0', 08:39:47 INFO - 'XPC_SERVICE_NAME': '0', 08:39:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:47 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-L2dinF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:48 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:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-OG6vwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:48 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:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-bSlIjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:48 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:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-B3KJBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:48 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:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-jPrQDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:48 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:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-pYWghU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:48 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:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-zcafKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:48 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:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-3OaOuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:48 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:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-H90grd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:48 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:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-RU76M3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:48 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:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-OXLQGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:49 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:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:49 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-2xjQHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:49 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-r44aqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:49 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:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:49 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-diYjoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:49 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:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:49 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-q3WQy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:49 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:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:49 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-hYkclH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:49 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:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:49 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-PYuu2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:49 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:39:49 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:39:49 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:39:49 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:39:49 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:39:49 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:39:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:39:49 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:39:49 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:39:49 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:39:49 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:39:49 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:39:49 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:39:52 INFO - Downloading blessings-1.6.tar.gz 08:39:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:39:52 INFO - Installing collected packages: blessings 08:39:52 INFO - Running setup.py install for blessings 08:39:52 INFO - Successfully installed blessings 08:39:52 INFO - Cleaning up... 08:39:52 INFO - Return code: 0 08:39:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:39:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:53 INFO - Reading from file tmpfile_stdout 08:39:53 INFO - Current package versions: 08:39:53 INFO - blessings == 1.6 08:39:53 INFO - blobuploader == 1.2.4 08:39:53 INFO - docopt == 0.6.1 08:39:53 INFO - functools32 == 3.2.3-2 08:39:53 INFO - jsonschema == 2.5.1 08:39:53 INFO - manifestparser == 1.1 08:39:53 INFO - mozInstall == 1.12 08:39:53 INFO - mozcrash == 1.0 08:39:53 INFO - mozdebug == 0.1 08:39:53 INFO - mozdevice == 0.49 08:39:53 INFO - mozfile == 1.2 08:39:53 INFO - mozhttpd == 0.7 08:39:53 INFO - mozinfo == 0.9 08:39:53 INFO - mozleak == 0.1 08:39:53 INFO - mozlog == 3.4 08:39:53 INFO - moznetwork == 0.27 08:39:53 INFO - mozprocess == 0.25 08:39:53 INFO - mozprofile == 0.28 08:39:53 INFO - mozrunner == 6.13 08:39:53 INFO - mozscreenshot == 0.1 08:39:53 INFO - mozsystemmonitor == 0.3 08:39:53 INFO - moztest == 0.8 08:39:53 INFO - mozversion == 1.4 08:39:53 INFO - psutil == 3.1.1 08:39:53 INFO - requests == 1.2.3 08:39:53 INFO - wsgiref == 0.1.2 08:39:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39: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:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:53 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 0x109efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9428c6ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cdad30>, '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 0x109c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccfbe8>, '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.GK1psSsk5Z/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.6PZBToxTEp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:39:53 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:39:53 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:39:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GK1psSsk5Z/Render', 08:39:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:53 INFO - 'HOME': '/Users/cltbld', 08:39:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:53 INFO - 'LOGNAME': 'cltbld', 08:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:53 INFO - 'MOZ_NO_REMOTE': '1', 08:39:53 INFO - 'NO_EM_RESTART': '1', 08:39:53 INFO - 'PAGER': '/bin/cat', 08:39:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:53 INFO - 'PWD': '/builds/slave/test', 08:39:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:53 INFO - 'SHELL': '/bin/bash', 08:39:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PZBToxTEp/Listeners', 08:39:53 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 08:39:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:53 INFO - 'USER': 'cltbld', 08:39:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:53 INFO - 'XPC_FLAGS': '0x0', 08:39:53 INFO - 'XPC_SERVICE_NAME': '0', 08:39:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:53 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:39:53 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:39:53 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:39:53 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:39:53 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:39:53 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:39:53 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:39:53 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:39:53 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:39:53 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:39:53 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:39:53 INFO - Cleaning up... 08:39:53 INFO - Return code: 0 08:39:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:39: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:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:53 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 0x109efcb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109eff768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9428c6ec20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cdad30>, '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 0x109c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccfbe8>, '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.GK1psSsk5Z/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.6PZBToxTEp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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:39:53 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:39:53 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:39:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GK1psSsk5Z/Render', 08:39:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:53 INFO - 'HOME': '/Users/cltbld', 08:39:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:53 INFO - 'LOGNAME': 'cltbld', 08:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:53 INFO - 'MOZ_NO_REMOTE': '1', 08:39:53 INFO - 'NO_EM_RESTART': '1', 08:39:53 INFO - 'PAGER': '/bin/cat', 08:39:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:53 INFO - 'PWD': '/builds/slave/test', 08:39:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:53 INFO - 'SHELL': '/bin/bash', 08:39:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PZBToxTEp/Listeners', 08:39:53 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 08:39:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:53 INFO - 'USER': 'cltbld', 08:39:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:53 INFO - 'XPC_FLAGS': '0x0', 08:39:53 INFO - 'XPC_SERVICE_NAME': '0', 08:39:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:39:53 INFO - Cleaning up... 08:39:53 INFO - Return code: 0 08:39:53 INFO - Running post-action listener: _resource_record_post_action 08:39:53 INFO - Running post-action listener: _start_resource_monitoring 08:39:53 INFO - Starting resource monitoring. 08:39:53 INFO - [mozharness: 2017-03-11 16:39:53.644293Z] Finished create-virtualenv step (success) 08:39:53 INFO - [mozharness: 2017-03-11 16:39:53.645209Z] Running install step. 08:39:53 INFO - Running pre-action listener: _resource_record_pre_action 08:39:53 INFO - Running main action method: install 08:39:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:53 INFO - Reading from file tmpfile_stdout 08:39:53 INFO - Detecting whether we're running mozinstall >=1.0... 08:39:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:39:54 INFO - Reading from file tmpfile_stdout 08:39:54 INFO - Output received: 08:39:54 INFO - Usage: mozinstall [options] installer 08:39:54 INFO - Options: 08:39:54 INFO - -h, --help show this help message and exit 08:39:54 INFO - -d DEST, --destination=DEST 08:39:54 INFO - Directory to install application into. [default: 08:39:54 INFO - "/builds/slave/test"] 08:39:54 INFO - --app=APP Application being installed. [default: firefox] 08:39:54 INFO - mkdir: /builds/slave/test/build/application 08:39:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:40:14 INFO - Reading from file tmpfile_stdout 08:40:14 INFO - Output received: 08:40:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:40:14 INFO - Running post-action listener: _resource_record_post_action 08:40:14 INFO - [mozharness: 2017-03-11 16:40:14.316782Z] Finished install step (success) 08:40:14 INFO - [mozharness: 2017-03-11 16:40:14.316917Z] Running run-tests step. 08:40:14 INFO - Running pre-action listener: _resource_record_pre_action 08:40:14 INFO - Running main action method: run_tests 08:40:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:40:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:40:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:40:14 INFO - 2017-03-11 08:40:14.331 screenresolution[1622:7538] starting screenresolution argv=screenresolution get 08:40:14 INFO - 2017-03-11 08:40:14.334 screenresolution[1622:7538] Display 0: 1600x1200x32@60 08:40:14 INFO - 2017-03-11 08:40:14.340 screenresolution[1623:7541] starting screenresolution argv=screenresolution list 08:40:14 INFO - Available Modes on Display 0 08:40:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:40:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:40:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:40:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:40:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:40:14 INFO - Intel Iris: 08:40:14 INFO - Chipset Model: Intel Iris 08:40:14 INFO - Type: GPU 08:40:14 INFO - Bus: Built-In 08:40:14 INFO - VRAM (Dynamic, Max): 1536 MB 08:40:14 INFO - Vendor: Intel (0x8086) 08:40:14 INFO - Device ID: 0x0a2e 08:40:14 INFO - Revision ID: 0x0009 08:40:14 INFO - Displays: 08:40:14 INFO - Display: 08:40:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:40:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:40:14 INFO - Display Serial Number: 1600x1200 60 08:40:14 INFO - Main Display: Yes 08:40:14 INFO - Mirror: Off 08:40:14 INFO - Online: Yes 08:40:14 INFO - Rotation: Supported 08:40:14 INFO - Return code: 0 08:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:40:14 INFO - Python 2.7.3 08:40:14 INFO - Return code: 0 08:40:14 INFO - grabbing minidump binary from tooltool 08:40:14 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:40:14 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 0x109cdad30>, '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 0x109c01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ccfbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:40:14 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:40:14 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:40:14 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:40:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:40:14 INFO - Return code: 0 08:40:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:40:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:40:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:40:14 INFO - ENV: RUST_BACKTRACE is now 1 08:40:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:40:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:40:14 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/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--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:40:14 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/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0178 --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:40:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GK1psSsk5Z/Render', 08:40:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:14 INFO - 'HOME': '/Users/cltbld', 08:40:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:14 INFO - 'LOGNAME': 'cltbld', 08:40:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:40:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:14 INFO - 'MOZ_NO_REMOTE': '1', 08:40:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:40:14 INFO - 'NO_EM_RESTART': '1', 08:40:14 INFO - 'PAGER': '/bin/cat', 08:40:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:14 INFO - 'PWD': '/builds/slave/test', 08:40:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:40:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:14 INFO - 'RUST_BACKTRACE': '1', 08:40:14 INFO - 'SHELL': '/bin/bash', 08:40:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6PZBToxTEp/Listeners', 08:40:14 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 08:40:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:14 INFO - 'USER': 'cltbld', 08:40:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:14 INFO - 'XPC_FLAGS': '0x0', 08:40:14 INFO - 'XPC_SERVICE_NAME': '0', 08:40:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:14 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/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--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:40:14 INFO - mozversion application_buildid: 20170311080236 08:40:14 INFO - mozversion application_changeset: 3154da520af568d4da3de62bc26fbf97a1317f51 08:40:14 INFO - mozversion application_display_name: Nightly 08:40:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:40:14 INFO - mozversion application_name: Firefox 08:40:14 INFO - mozversion application_remotingname: firefox 08:40:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:40:14 INFO - mozversion application_vendor: Mozilla 08:40:14 INFO - mozversion application_version: 55.0a1 08:40:14 INFO - mozversion platform_buildid: 20170311080236 08:40:14 INFO - mozversion platform_changeset: 3154da520af568d4da3de62bc26fbf97a1317f51 08:40:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:40:14 INFO - mozversion platform_version: 55.0a1 08:40:14 INFO - using testdate: 1489250414 08:40:14 INFO - actual date: 1489250414 08:40:14 INFO - starting webserver on 'localhost:49241' 08:40:14 INFO - SUITE-START | Running 2 tests 08:40:14 INFO - TEST-START | dromaeo_css 08:40:14 INFO - operating with platform_type : mac_ 08:40:14 INFO - Initialising browser for dromaeo_css test... 08:40:14 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpxLUXOG/profile http://localhost:49241/getInfo.html) 08:40:17 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 08:40:17 INFO - PROCESS | 1633 | colorDepth:24 08:40:17 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 08:40:17 INFO - PROCESS | 1633 | __metrics 08:40:17 INFO - PROCESS | 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:40:17 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:40:18 INFO - TEST-INFO | 1633: exit 0 08:40:18 INFO - Browser initialized. 08:40:18 INFO - Running cycle 1/1 for dromaeo_css test... 08:40:18 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpxLUXOG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:40:30 INFO - PROCESS | 1635 | RSS: Main: 232718336 08:40:30 INFO - PROCESS | 1635 | 08:43:35 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:43:38 INFO - PROCESS | 1635 | RSS: Main: 465358848 08:43:38 INFO - PROCESS | 1635 | 08:45:20 INFO - PROCESS | 1635 | ************************* 08:45:20 INFO - PROCESS | 1635 | A coding exception was thrown and uncaught in a Task. 08:45:20 INFO - PROCESS | 1635 | 08:45:20 ERROR - PROCESS | 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:45:20 INFO - PROCESS | 1635 | Full stack: 08:45:20 INFO - PROCESS | 1635 | ************************* 08:46:41 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 08:46:42 INFO - PROCESS | 1635 | RSS: Main: 365932544 08:46:42 INFO - PROCESS | 1635 | 08:49:44 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 08:49:45 INFO - PROCESS | 1635 | RSS: Main: 343826432 08:49:45 INFO - PROCESS | 1635 | 08:52:47 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 08:52:48 INFO - PROCESS | 1635 | RSS: Main: 336560128 08:52:48 INFO - PROCESS | 1635 | 08:55:52 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 08:55:52 INFO - PROCESS | 1635 | RSS: Main: 339120128 08:55:52 INFO - PROCESS | 1635 | 08:58:56 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 08:58:56 INFO - PROCESS | 1635 | RSS: Main: 403394560 08:58:56 INFO - PROCESS | 1635 | 08:58:56 INFO - PROCESS | 1635 | __start_tp_report 08:58:56 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 08:58:56 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 08:58:56 INFO - PROCESS | 1635 | |i|pagename|runs| 08:58:56 INFO - PROCESS | 1635 | |0;dojo.html;3304.900852974411;3360.9495857562133;3365.158710322421;3371.6459771723985;3390.8304584770754;5570.721463926808;5643.717814109299;5871.383504732001;5911.9113213301835;5920.644761314319;5625.887482250352;5626.943730562693;5649.576281778873;5649.943500564993;5655.236543066685;5137.666051706646;5163.8192663256605;5171.3535808024;5206.973965130188;5231.86920326993;5353.705546194958;5360.035193665139;5360.490753378423;5374.140137577989;5378.489043540877;5344.011357898801;5353.892922141555;5356.38401583819;5361.410244873061;5368.463153684639;5349.7057661828585;5359.276497672842;5360.410354860962;5372.516473517363;5374.086405311067;5197.48025197481;5291.761870715827;5297.5232229099565;5303.893922121574;5324.281222035014;5995.610285331483;6070.544709146788;6075.210222671069;6076.4834989025985;6078.179445774808;6263.123162757218;6266.091416744592;6270.404311590391;6272.404121608485;6281.434670879597;5539.9169012464845;6192.225971753531;6225.128482012522;6294.024426213944;6298.118263443076;6066.939330606726;6077.696115194222;6079.39206079393;6115;6116.541259405518;6401.583897046677;6463.57986730861;6464.224293084766;6466.256380516207;6470.2559205691;6120.508083830883;6137.223770008841;6207.193064901624;6291.182146321041;6309.810705678837;6166.445019948226;6285.43431091204;6288.811335659938;6289.150964619809;6300.716467758962;5266.657667251617;6144.126041557279;6171.259448866075;6256.874862502725;6292.4966002719675;6212.9068063979075;6254.093156492283;6259.155014073133;6262.874742505215;6269.498440124779;4958.876028099255;5112.693238405707;5114.181730923109;5130.461301563357;5132.178851383761;4480.215962206601;4505;4513.390692256569;4519.909601808011;4522.095580883836;5778.595498315078;5779;5780.479756821906;5787.160861675034;5808.535317174616;6217.6891155442045;6259.937400626027;6269.373062693694;6273.529485288622;6287;5751.1085781703905;5769.509591684669;5775.537956963432;5776.364599894008;5805.767769289266;5504.53211477029;5522.944770552243;5529.474699903502;5534.612577119563;5544.362398324244;5695.572832037531;6272.278687950853;6356.491480681534;6374.713137908805;6383.457406120532;6280.466160376236;6349.555531112777;6353.650549219652;6358.872822543616;6377.904331434939;5673.8297851064535;6588.934110658832;6601.438877695449;6603.603783772989;6612.206535215805;6126.120738204555;6159.692015399301;6172.475339596184;6212.968935155295;6294.433500984934;6119.969400152971;6275.058741188858;6284.968575157095;6297.433231009231;6297.527685423704;6102.337773232528;6122.794608433986;6156.076588511759;6215.06773983906;6317.210348706411;5293;6247.687615619292;6297.937020629735;6300.558960872695;6321.841953951188;6124.295705993868;6204.658743769136;6207.968960155351;6212;6217.720202590985;6083.117947897442;6117.265928088658;6158.538109641705;6268.153799237045;6330.683465826783;6039.577229593886;6040.275166979991;6042.818715438544;6043.153958445733;6053.636781793107 08:58:56 INFO - PROCESS | 1635 | |1;ext.html;756.4024420707641;774.233508826262;843.9029511606167;855.546560323029;856.5717141429285;38301.80849095754;38991;39114.80442597783;39163.804180979125;39190;35191.59233630658;39094.8045259774;40522;40564.79717601408;40600;7243.89134162988;8876.467411955287;9036.593353299084;9058.23005044572;9072.818543629124;7333.853322933538;7437.8512429751645;7440.925590744077;7441.479096463249;10696.197785166143;10935.398553079618;10959.588890444089;10962.780744385107;10968.780624387507;10993.450327483633;10844.024037836554;10882.836757448644;10922.126229901669;10926.235163538555;10954.342739435659;7179.569225846413;7354.595497247649;10621.309614875008;10671.519781609846;10678.412687302196;31310.686893131005;37134;39621.80189099036;39674.60325396767;39700.40449393261;3743.569489508714;3778.792166430845;3806.7906265155407;3836.1560456699763;3836.9424458633143;27286.863565682044;27681.446371072667;27816.443671126464;28329.85835070832;28413.431731365465;2810.6280913677906;2847.9715202847915;2848.6011958325853;2867.842268675222;2915.4460652475964;303004;303351;303987;304948;306060;49059;49069;49197;49218;49242.26136607882;51607.742761158035;51625.709357265616;51679.48320516822;51692.74153629208;51863.222051669254;13932.094413863066;14286.571402857931;14292.928535357465;14321.713565728836;14408.567742967727;11610.30338179695;11629.825552616718;11632.243904146204;11652.359120248468;11666.125040621988;10797.028267455968;12385;12788.680282993;12794.872051279553;12846.357682116044;4575.58819706228;5340.706261155674;5408.188771684278;5457.263269458652;5472.343318801769;856.8072183758604;989.9902099858105;1018.1956254558816;1072.6835583502886;1116.2799994003822;25214.99140034378;26226.86886565555;26527.071552495956;26760.33099172497;26790.866045669645;1041.7031146123318;1117.4133579870634;1128.4639796096953;1140.2816225777872;1175.8706542280343;13160.736785264242;13518.797218041736;13888.097273677178;13922.09506382082;14004.789928151085;402542;403197;403742;403746;403963;53994.65013374618;53999;54064;54201.45798541964;54450.18324725132;1230.9507619695112;1348.615644541301;1424.0530047518284;1429.6140042188758;1432.5702289313165;19727.704084438457;24437;28368.290792730346;29708.554371684873;29758.064516129205;51192.74403627958;51402.74298628483;51498;51544.22683659673;51559.48440515547;443852;446653;447049;447541;448102;33239.83380083084;33861.66138338585;33925;34022.82988585041;34081.31837363289;42184;43497.78251108724;43559.9110022252;43613.56386436095;43627.78186109176;33304.77404957426;35335.82332088323;35463.645363546035;35729.92810215698;36250.4562431569;34539.82730086333;34651.826740867145;34896.82551587226;35923.46114808332;36018.81990590135;35537.64462355343;35610.28779424345;35680.82159589185;36568.817155914054;37531.81234093812;29764.70235297706;30102.946396876003;31119.844400777853;32488;32769;24074.39814004664;24098.759012409653;24401.63397549074;24865.875670622256;25030 08:58:56 INFO - PROCESS | 1635 | |2;jquery.html;380.5338460386029;395.7684754418665;409.928262554053;416.8332666933226;439.9714018588792;13054.216746995187;14992.250387480623;17994.820051799477;21682.674759878573;21847.126114955423;16828.32686692531;18123;18548.536286592807;18553.90723046383;21898.89050554749;4982.804127009528;6386.233651961771;6597.868042639145;6631.734730610794;6674.06563081169;6521.576097553668;6585.2097748270035;6638.767643132492;6644.136262285921;6650.23522294935;6336.176297081373;6531.836704082389;6563.835904102411;6610.70251838666;6629.801105966804;6528.216614006302;6595.241547222059;6598.109255250528;6599;7192.856142877165;7367.336939675455;7445.702171913117;7449.217832127657;7454.925450745477;7455.850882982364;24874.87562562194;25880;26257.868710656516;27289;27543.31141721453;2836.8297902125732;2859.828410295389;2905.6513218413716;2912.461194678991;2919.284775230061;15560.37758489659;16016.75974860378;16025;16350.591235219095;17157.485275441755;1730.6452177303622;1894.4587082782805;1895.2324308655018;1912.177763561668;1940.2045161483725;133665;141946.29026854903;142003.28998355046;143053;146080;19228.71156932647;20185.394438166877;20383.4904127398;20886.895565522074;21180.894095529424;36927.446088308694;36963.81518092392;37038;37106.443403348974;37162.814185928895;10025.14786243163;10315.970744166254;10512.370582559715;10542.314749541256;10694.94652526748;7181.928180718231;8442.493450392996;8467.195616416431;8653.524056176844;8665.43674661145;9659.855102173473;10056.938327642962;10163.898361016296;10166.440845753406;10203.642872499428;3277.7869438486423;3654.7624404413627;3790.9431358529646;3972.741771784825;3978.701597380208;792.8652129138061;835.7534527314457;870.5473153959905;891.3136884598823;942.0673533202217;22266.777332226793;22366.54617449893;23834.523309533713;24916.501669966863;24989.750102499107;941.1294552538874;947.431541075363;967.7193613852045;986.063239922077;989.5349185882624;6802.387785099365;6979.546329488669;7040.823979400454;7051.92948070523;7271.745488907863;553025;565426;686793.9244252854;691065;715406;133215;138958;143293;145292;148602.51397486104;1272.8854403103765;1301.5965050834272;1338.819259399988;1339.6717804138048;1345.4685399267235;19824.207031718568;21040.947952602615;21047.894760526713;21112.472188195417;21115.366539003855;41412.792936035126;59142.70428647829;61050.778984420955;62045.37954620396;62501.06248406369;88274.55862720901;88788.55605722188;88922.77693057725;89251.55374223347;89697.23633164063;11186.216964812385;11566.94216528912;11795.823062654239;11808.992471280075;11904.583339583072;11376.748557658817;13105.344732763515;13108.672283192996;13277;13510.797338040134;11237.213395062266;11365.829512557484;11542.59600913964;11607.709807254887;11703.648890533297;10293.691189264335;11262.436878155895;11340.886591133984;11664;11970.880291196976;10039.247056470647;11479.36863472517;11847.940760296144;11865.347405892759;11916.523339066687;9566.952165239407;11424.257423267461;11774.411279436164;11844.348560829238;11865.932066114092;11328;11556.884431155917;11746.65066986589;11817;11900.285982841056 08:58:56 INFO - PROCESS | 1635 | |3;mootools.html;1362.0465674028183;1592.7212737770894;1619.8218195998443;1620.8703303735701;1628.1777702260356;9021.458712477248;9427.48148851813;9444.622215111405;9533;9544.665936692218;9046.90953090469;9353.53232338382;9989.600415983352;10236.641717539887;10534.473276336192;2265.954680906385;2314.537092581482;2316.339843144696;2317.895694693743;2321.5124823787023;2087.342487116561;2194.6378847490146;2200.5048864005553;2208.4810069633622;2210.171185805323;1926.2776458827939;2013.4865609269689;2016.5160361513279;2016.969745453812;2019.7374341335606;1996.8402527797814;2021.0198053943825;2232.598132336179;2316.81465482761;2320.760466150173;2197.9780202197935;2200.922967696139;2203.5262418580082;2207.64677651575;2208.149862303009;10762.623308184176;10804.621838235702;10812.189085818516;10813.134949204123;10825.891741082567;4813.855584332476;4964.925526117111;4998.225275082368;5019.071471777733;5522.254495643077;2901.840398778066;3167.33485967947;3231.757618178646;3404.3191361727504;3564.108972756811;1062.3041907550567;1077.8275475923815;1131.7114135895295;1191.3447603817865;1216.2945491614842;11991;14728.852711472855;14922.477713279983;14948.878834087378;14950.850491495055;4644.674872758875;4765.070811191854;4836.492168322346;4839.758012099381;4869.415670119537;12605.747885042249;12607.747845043232;12614.306213158181;12620.927221186119;12632.431540580696;5859.677717725566;5860;5863.3257175424515;5869.941300586939;5874.118882167623;5010.348654674942;5034;5080.161773307437;5090.211017292251;5163.845084647466;3850.439457760558;3887.61123887609;3962.841486340572;4015.578364271768;4038;1106.1261603333437;1114.6934592986993;1125.9887401126048;1127.9097672186206;1140.1448913315014;791.9722809701748;808.7250334886166;826.1696994520469;827.6813426830713;832.238501770885;6129.540284478682;6341.619502829845;6561;6598.769043083469;6631.535792494479;910.2990697163148;970.8495183246608;983.3755565216139;1013.5945621751358;1063.9308444951052;3498.4492335922564;4074.266632006267;4106.322456794595;4231.767252801125;4244.830206791756;13073.215607063416;13563.525276615272;13736.725265494633;13746.93126534361;13758.449662013607;13685.589432317047;13686.589402317946;13687.31563421825;13712.17726936387;13715.588532344045;9780.217582593375;9786.951065244628;9814.46020468881;9949.55227014786;10062.597496100221;6324.272708638566;6575.375339342755;6655.667216639245;6766.4248538874745;6792.864142717019;10858.131349491863;11936.76126477483;12003.879961200626;12049.578264760692;12148.878511214774;10129.493525323556;12291.44688489038;12499.437525311201;12572.559960401708;12632.557860474839;8173.427860049739;8208.753737387888;8217.506949583045;8291;8393.370497212856;9759.414435133915;9827;9935.701928942144;9941.701748947544;9969.052939970981;8625.353098517762;8724.127587241224;8884.289256859307;8917.55412229373;8981.730548083568;8649;8713.564321783759;8722.127787221227;8732.825343493221;8786.364090772615;7589.203133670885;7632;7761.611919403895;7768.495047821873;7797.8555897128745;5646.124850648156;5715.599908006399;5792.4497172768515;5946.226990491208;5985.341612422543;5798.507126894261;5890.617109887844;5972.820815375546;6091.9086213707715;6169.105479705508 08:58:56 INFO - PROCESS | 1635 | |4;prototype.html;371.0427098086936;377.26809988622057;378.23218865702614;386.83946162342613;390.5996353737419;5041.672291301067;5097.821576244833;5133.61497887659;5139.357580302462;5154.896902061956;3777.848886044555;4520.412346394973;4663.8367657132;4691.249400095985;5049.368828896388;3508.4737289406667;3650.142216579102;3801.4107813288983;3919.196564704243;3922.529296484419;3562.394392953191;3779.678727308168;3984.721069525134;4016.919661606766;4017.529219529997;3318.70131688148;3412.897613071612;3956.9208615827665;4003.619656132663;4014.558398576154;3410.316857793577;3443.6212016678146;3489.963503649636;3944.6252606002386;4046.4537287466255;2650.4566563854364;3517.8416971236356;3522.9295414091575;3527.9647203527893;3549.769264997767;4660.4174478190225;4709.621641071271;4941.382327209099;4968.931679688884;4974.751262436864;3799.905002374935;4323.718958267703;4369.003981701935;4689.484156742756;4690.7654617269;4912.828051018198;5277.445868183824;5362.865928351784;5408.540274076709;5457.481539253804;3957.7770568711926;3965.8499035279733;3966.920661586752;3971.8750468499215;3974.4038394241097;4855.757212139414;5085.3726807421635;5511.53151982082;5531.695756733378;5590.664560126405;4025.5370632377067;4608.5161058088415;4740.597049250852;4749.24012158053;4770.713757174581;4025.959740402617;4081.795910204478;4201.033762234703;4892.339534162914;4900.990593856573;4721.93756404813;4752.358431611758;5110.821121260738;5136;5162.767675454614;4221.746695198237;5313.840584782462;5433.468245640365;5475.4524547544925;5480.3971563128025;1323.2788130468919;1429.9857001430062;1485.866272035522;1555.3545278709435;1560.5084398414463;987.3828856964398;1026.9024442677933;1082.4749996251812;1101.388729255271;1176.2413243458093;4774.164521208844;4841.620138260579;5050.080969231742;5106.514881086291;5117.8464646060675;5274.393444753826;5351.705656188869;5632.97183514088;5717.799877004285;5754.856128596735;4385.144896745168;4776.570108690165;4794.256890182028;4800.895793967407;4898.069366820293;2484.6645702830247;2807.2033898305103;2927.2681829542616;2934.5891575179066;2948.4103179364215;5828.504577110993;5840.0071987762185;5851.824445266649;5852.8536786579825;5862.355140934494;5320;5349.893002139936;5483.983808905086;5540.473655002768;5772.624779389326;5308;5344.225087362311;5433.9184912225555;5634.3802181759975;5677.943220567907;4415.315626077963;4711.929321060118;5500.669959802424;5508.779648814003;5510.91733623988;4913.543228385807;5035.647504674637;5189.299444574934;5300.469953004668;5572.665640061609;5020.6234532410945;5079.87300317495;5161.490186673098;5847.795462038704;5864.797716468199;4177.4151618774;4412.536683648171;4422.624076953495;4426.64586833059;4430.335449682573;4735.905281894412;4978.8755281118265;5123.308353372247;5615.535649158846;5623.550115990629;5085.6185786066935;5108.642395032312;5511.834644960658;5520.861978450571;5562.582806289463;4693.530646935279;4951.845947013061;5264.31563896691;5528.612997090165;5542.722863856871;4374.978125109481;4915.721912302755;5191.454897235887;5353.583293782723;5390.760125171311;4971.577415919687;5452.591055670761;5481.451854814487;5494.313210848644;5509.531689806251;5046.199359355593;5172.844814655567;5397.298351214317;5401.648892821954;5429.809956651498 08:58:56 INFO - PROCESS | 1635 | |5;yui.html;697.3828162076563;712.5973824788994;814.9959250203748;824.2869917521344;830.3564737328574;14524.63688407789;15331.846681533181;15342.769858452104;15346.07923524588;15349.769753453693;13929.512467063654;14041.859581404184;14161;14170.220637864913;14207.78688319676;920.8020275640753;932.7668082979255;933.4725879877881;936.2603543200863;936.9833730402487;941.1811723800304;942.0861764088858;943.5612440215299;944.6929747831948;944.8157609266195;992.1417973452948;1020.6631811502186;1024.9948750256237;1031.3554028732042;1033.8294181460087;1020.3316827478013;1021.1473419694601;1022.8312328465794;1023.2734758321601;1023.976023976024;744.7877354953866;749.0748925077579;749.3106342165221;749.4566439331495;750.9361704255144;15858.36566537337;15878.36486540537;15927.203639818079;16112.677746445006;16145.192740362934;14590.197539135343;14654.706905861929;14869;14915.030523015968;15557.611059723484;11251.43742812856;11612.535498580046;11688.123390745728;11711.414429278588;12186.08604354677;3713.591504934455;3732.682721968636;3750.2124553843723;3752.137008488036;3820.44603532489;112740;113185;113709.43145284304;114706;117211.24183137175;11129.499172537255;11576.24754390962;11610.76778464426;11675.532978680927;11917.642470725892;24370.756292437203;24661.01355945778;24948.875255623607;24965.5006899861;24977;7679.923200768033;7725.845483090419;7853.8821917671285;7905.604719763989;8043.517388956564;4089.6114869087387;4165.708400412002;4177.227212965611;4189.832406703697;4193.853215137517;3498.1079824644553;3573.7498375114014;3590.6409359063887;3594.0475773919934;3597.5143355647174;595.7468076067654;601.6299975515027;605.6820169411006;624.537841996919;625.8153844615849;671.4292851076643;675.1796567170911;697.341012742953;705.8235441139715;709.2871663977669;9633.518324083769;9766;9778.853317200248;9956.398593246893;10105.242106842017;645.6739346629922;679.7145199016425;686.6566716641679;691.509028589707;715.9606221657755;4062.8232859964473;4177.858547934531;4192.580741925783;4304.053108316165;4512.548745125461;92363.61454578186;94541;97571.0242897562;97985.51007244918;100670;47668.39378238342;79599;84115;88894;88897;74839.87740183901;75190.6240468805;75273.87089193775;76315.31871757658;76891;9251.76870578241;10502.947485262524;10762;10872.293300935415;10878.945605271923;44399.778001109786;44448;44541;44745.55254447544;45512.54487455083;56600.584985375695;56726.581835454446;56836;57972.710136449045;58187.836243274054;12948.29252737837;13043.413046412745;13134.540291089766;13395.665108372368;13555.407816928719;13109.541166059142;13916.930415347859;14116.78824817608;14335.354909029327;14533.273336333352;12898.290594017419;13014.674633134247;13194.538191163263;13509.729805404033;13554.457821687021;12745.235285882876;12878.35608219604;12888.742225155633;13301.334933253105;13368.732625347633;12947.482100715866;13103.279319637511;13146;13189.868101318863;13615.455381784617;10448.079623317153;10738.355698658106;10741.462926853783;11240.550377985117;11728.537007228577;9037.539936102447;10653.627123050655;10922.453877305945;10934.125269978542;11081.390523521284 08:58:56 INFO - PROCESS | 1635 | __end_tp_report 08:58:56 INFO - PROCESS | 1635 | __start_cc_report 08:58:56 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,2700 08:58:56 INFO - PROCESS | 1635 | __end_cc_report 08:58:56 INFO - PROCESS | 1635 | __startTimestamp1489251536567__endTimestamp 08:58:56 INFO - PROCESS | 1635 | 08:58:56 INFO - PROCESS | 1635 | ------- Summary: start ------- 08:58:56 INFO - PROCESS | 1635 | Number of tests: 6 08:58:56 INFO - PROCESS | 1635 | 08:58:56 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5822.83 Median:6079.39 stddev:645.55 (10.6%) stddev-sans-first:616.58 08:58:56 INFO - PROCESS | 1635 | Values: 3304.9 3360.9 3365.2 3371.6 3390.8 5570.7 5643.7 5871.4 5911.9 5920.6 5625.9 5626.9 5649.6 5649.9 5655.2 5137.7 5163.8 5171.4 5207.0 5231.9 5353.7 5360.0 5360.5 5374.1 5378.5 5344.0 5353.9 5356.4 5361.4 5368.5 5349.7 5359.3 5360.4 5372.5 5374.1 5197.5 5291.8 5297.5 5303.9 5324.3 5995.6 6070.5 6075.2 6076.5 6078.2 6263.1 6266.1 6270.4 6272.4 6281.4 5539.9 6192.2 6225.1 6294.0 6298.1 6066.9 6077.7 6079.4 6115.0 6116.5 6401.6 6463.6 6464.2 6466.3 6470.3 6120.5 6137.2 6207.2 6291.2 6309.8 6166.4 6285.4 6288.8 6289.2 6300.7 5266.7 6144.1 6171.3 6256.9 6292.5 6212.9 6254.1 6259.2 6262.9 6269.5 4958.9 5112.7 5114.2 5130.5 5132.2 4480.2 4505.0 4513.4 4519.9 4522.1 5778.6 5779.0 5780.5 5787.2 5808.5 6217.7 6259.9 6269.4 6273.5 6287.0 5751.1 5769.5 5775.5 5776.4 5805.8 5504.5 5522.9 5529.5 5534.6 5544.4 5695.6 6272.3 6356.5 6374.7 6383.5 6280.5 6349.6 6353.7 6358.9 6377.9 5673.8 6588.9 6601.4 6603.6 6612.2 6126.1 6159.7 6172.5 6213.0 6294.4 6120.0 6275.1 6285.0 6297.4 6297.5 6102.3 6122.8 6156.1 6215.1 6317.2 5293.0 6247.7 6297.9 6300.6 6321.8 6124.3 6204.7 6208.0 6212.0 6217.7 6083.1 6117.3 6158.5 6268.2 6330.7 6039.6 6040.3 6042.8 6043.2 6053.6 08:58:56 INFO - PROCESS | 1635 | 08:58:56 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:53126.03 Median:34774.33 stddev:103046.24 (296.3%) stddev-sans-first:103260.30 08:58:56 INFO - PROCESS | 1635 | Values: 756.4 774.2 843.9 855.5 856.6 38301.8 38991.0 39114.8 39163.8 39190.0 35191.6 39094.8 40522.0 40564.8 40600.0 7243.9 8876.5 9036.6 9058.2 9072.8 7333.9 7437.9 7440.9 7441.5 10696.2 10935.4 10959.6 10962.8 10968.8 10993.5 10844.0 10882.8 10922.1 10926.2 10954.3 7179.6 7354.6 10621.3 10671.5 10678.4 31310.7 37134.0 39621.8 39674.6 39700.4 3743.6 3778.8 3806.8 3836.2 3836.9 27286.9 27681.4 27816.4 28329.9 28413.4 2810.6 2848.0 2848.6 2867.8 2915.4 303004.0 303351.0 303987.0 304948.0 306060.0 49059.0 49069.0 49197.0 49218.0 49242.3 51607.7 51625.7 51679.5 51692.7 51863.2 13932.1 14286.6 14292.9 14321.7 14408.6 11610.3 11629.8 11632.2 11652.4 11666.1 10797.0 12385.0 12788.7 12794.9 12846.4 4575.6 5340.7 5408.2 5457.3 5472.3 856.8 990.0 1018.2 1072.7 1116.3 25215.0 26226.9 26527.1 26760.3 26790.9 1041.7 1117.4 1128.5 1140.3 1175.9 13160.7 13518.8 13888.1 13922.1 14004.8 402542.0 403197.0 403742.0 403746.0 403963.0 53994.7 53999.0 54064.0 54201.5 54450.2 1231.0 1348.6 1424.1 1429.6 1432.6 19727.7 24437.0 28368.3 29708.6 29758.1 51192.7 51402.7 51498.0 51544.2 51559.5 443852.0 446653.0 447049.0 447541.0 448102.0 33239.8 33861.7 33925.0 34022.8 34081.3 42184.0 43497.8 43559.9 43613.6 43627.8 33304.8 35335.8 35463.6 35729.9 36250.5 34539.8 34651.8 34896.8 35923.5 36018.8 35537.6 35610.3 35680.8 36568.8 37531.8 29764.7 30102.9 31119.8 32488.0 32769.0 24074.4 24098.8 24401.6 24865.9 25030.0 08:58:56 INFO - PROCESS | 1635 | 08:58:56 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:39335.72 Median:24354.70 stddev:108185.06 (444.2%) stddev-sans-first:108449.01 08:58:56 INFO - PROCESS | 1635 | Values: 380.5 395.8 409.9 416.8 440.0 13054.2 14992.3 17994.8 21682.7 21847.1 16828.3 18123.0 18548.5 18553.9 21898.9 4982.8 6386.2 6597.9 6631.7 6674.1 6521.6 6585.2 6638.8 6644.1 6650.2 6336.2 6531.8 6563.8 6610.7 6629.8 6528.2 6595.2 6598.1 6599.0 7192.9 7367.3 7445.7 7449.2 7454.9 7455.9 24874.9 25880.0 26257.9 27289.0 27543.3 2836.8 2859.8 2905.7 2912.5 2919.3 15560.4 16016.8 16025.0 16350.6 17157.5 1730.6 1894.5 1895.2 1912.2 1940.2 133665.0 141946.3 142003.3 143053.0 146080.0 19228.7 20185.4 20383.5 20886.9 21180.9 36927.4 36963.8 37038.0 37106.4 37162.8 10025.1 10316.0 10512.4 10542.3 10694.9 7181.9 8442.5 8467.2 8653.5 8665.4 9659.9 10056.9 10163.9 10166.4 10203.6 3277.8 3654.8 3790.9 3972.7 3978.7 792.9 835.8 870.5 891.3 942.1 22266.8 22366.5 23834.5 24916.5 24989.8 941.1 947.4 967.7 986.1 989.5 6802.4 6979.5 7040.8 7051.9 7271.7 553025.0 565426.0 686793.9 691065.0 715406.0 133215.0 138958.0 143293.0 145292.0 148602.5 1272.9 1301.6 1338.8 1339.7 1345.5 19824.2 21040.9 21047.9 21112.5 21115.4 41412.8 59142.7 61050.8 62045.4 62501.1 88274.6 88788.6 88922.8 89251.6 89697.2 11186.2 11566.9 11795.8 11809.0 11904.6 11376.7 13105.3 13108.7 13277.0 13510.8 11237.2 11365.8 11542.6 11607.7 11703.6 10293.7 11262.4 11340.9 11664.0 11970.9 10039.2 11479.4 11847.9 11865.3 11916.5 9567.0 11424.3 11774.4 11844.3 11865.9 11328.0 11556.9 11746.7 11817.0 11900.3 08:58:56 INFO - PROCESS | 1635 | 08:58:56 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:6520.49 Median:4056.13 stddev:4119.60 (101.6%) stddev-sans-first:4112.93 08:58:56 INFO - PROCESS | 1635 | Values: 1362.0 1592.7 1619.8 1620.9 1628.2 9021.5 9427.5 9444.6 9533.0 9544.7 9046.9 9353.5 9989.6 10236.6 10534.5 2266.0 2314.5 2316.3 2317.9 2321.5 2087.3 2194.6 2200.5 2208.5 2210.2 1926.3 2013.5 2016.5 2017.0 2019.7 1996.8 2021.0 2232.6 2316.8 2320.8 2198.0 2200.9 2203.5 2207.6 2208.1 10762.6 10804.6 10812.2 10813.1 10825.9 4813.9 4964.9 4998.2 5019.1 5522.3 2901.8 3167.3 3231.8 3404.3 3564.1 1062.3 1077.8 1131.7 1191.3 1216.3 11991.0 14728.9 14922.5 14948.9 14950.9 4644.7 4765.1 4836.5 4839.8 4869.4 12605.7 12607.7 12614.3 12620.9 12632.4 5859.7 5860.0 5863.3 5869.9 5874.1 5010.3 5034.0 5080.2 5090.2 5163.8 3850.4 3887.6 3962.8 4015.6 4038.0 1106.1 1114.7 1126.0 1127.9 1140.1 792.0 808.7 826.2 827.7 832.2 6129.5 6341.6 6561.0 6598.8 6631.5 910.3 970.8 983.4 1013.6 1063.9 3498.4 4074.3 4106.3 4231.8 4244.8 13073.2 13563.5 13736.7 13746.9 13758.4 13685.6 13686.6 13687.3 13712.2 13715.6 9780.2 9787.0 9814.5 9949.6 10062.6 6324.3 6575.4 6655.7 6766.4 6792.9 10858.1 11936.8 12003.9 12049.6 12148.9 10129.5 12291.4 12499.4 12572.6 12632.6 8173.4 8208.8 8217.5 8291.0 8393.4 9759.4 9827.0 9935.7 9941.7 9969.1 8625.4 8724.1 8884.3 8917.6 8981.7 8649.0 8713.6 8722.1 8732.8 8786.4 7589.2 7632.0 7761.6 7768.5 7797.9 5646.1 5715.6 5792.4 5946.2 5985.3 5798.5 5890.6 5972.8 6091.9 6169.1 08:58:56 INFO - PROCESS | 1635 | 08:58:56 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4455.87 Median:4906.91 stddev:1290.19 (26.3%) stddev-sans-first:1256.86 08:58:56 INFO - PROCESS | 1635 | Values: 371.0 377.3 378.2 386.8 390.6 5041.7 5097.8 5133.6 5139.4 5154.9 3777.8 4520.4 4663.8 4691.2 5049.4 3508.5 3650.1 3801.4 3919.2 3922.5 3562.4 3779.7 3984.7 4016.9 4017.5 3318.7 3412.9 3956.9 4003.6 4014.6 3410.3 3443.6 3490.0 3944.6 4046.5 2650.5 3517.8 3522.9 3528.0 3549.8 4660.4 4709.6 4941.4 4968.9 4974.8 3799.9 4323.7 4369.0 4689.5 4690.8 4912.8 5277.4 5362.9 5408.5 5457.5 3957.8 3965.8 3966.9 3971.9 3974.4 4855.8 5085.4 5511.5 5531.7 5590.7 4025.5 4608.5 4740.6 4749.2 4770.7 4026.0 4081.8 4201.0 4892.3 4901.0 4721.9 4752.4 5110.8 5136.0 5162.8 4221.7 5313.8 5433.5 5475.5 5480.4 1323.3 1430.0 1485.9 1555.4 1560.5 987.4 1026.9 1082.5 1101.4 1176.2 4774.2 4841.6 5050.1 5106.5 5117.8 5274.4 5351.7 5633.0 5717.8 5754.9 4385.1 4776.6 4794.3 4800.9 4898.1 2484.7 2807.2 2927.3 2934.6 2948.4 5828.5 5840.0 5851.8 5852.9 5862.4 5320.0 5349.9 5484.0 5540.5 5772.6 5308.0 5344.2 5433.9 5634.4 5677.9 4415.3 4711.9 5500.7 5508.8 5510.9 4913.5 5035.6 5189.3 5300.5 5572.7 5020.6 5079.9 5161.5 5847.8 5864.8 4177.4 4412.5 4422.6 4426.6 4430.3 4735.9 4978.9 5123.3 5615.5 5623.6 5085.6 5108.6 5511.8 5520.9 5562.6 4693.5 4951.8 5264.3 5528.6 5542.7 4375.0 4915.7 5191.5 5353.6 5390.8 4971.6 5452.6 5481.5 5494.3 5509.5 5046.2 5172.8 5397.3 5401.6 5429.8 08:58:56 INFO - PROCESS | 1635 | 08:58:56 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:19839.21 Median:3582.20 stddev:28366.56 (791.9%) stddev-sans-first:28409.72 08:58:56 INFO - PROCESS | 1635 | Values: 697.4 712.6 815.0 824.3 830.4 14524.6 15331.8 15342.8 15346.1 15349.8 13929.5 14041.9 14161.0 14170.2 14207.8 920.8 932.8 933.5 936.3 937.0 941.2 942.1 943.6 944.7 944.8 992.1 1020.7 1025.0 1031.4 1033.8 1020.3 1021.1 1022.8 1023.3 1024.0 744.8 749.1 749.3 749.5 750.9 15858.4 15878.4 15927.2 16112.7 16145.2 14590.2 14654.7 14869.0 14915.0 15557.6 11251.4 11612.5 11688.1 11711.4 12186.1 3713.6 3732.7 3750.2 3752.1 3820.4 112740.0 113185.0 113709.4 114706.0 117211.2 11129.5 11576.2 11610.8 11675.5 11917.6 24370.8 24661.0 24948.9 24965.5 24977.0 7679.9 7725.8 7853.9 7905.6 8043.5 4089.6 4165.7 4177.2 4189.8 4193.9 3498.1 3573.7 3590.6 3594.0 3597.5 595.7 601.6 605.7 624.5 625.8 671.4 675.2 697.3 705.8 709.3 9633.5 9766.0 9778.9 9956.4 10105.2 645.7 679.7 686.7 691.5 716.0 4062.8 4177.9 4192.6 4304.1 4512.5 92363.6 94541.0 97571.0 97985.5 100670.0 47668.4 79599.0 84115.0 88894.0 88897.0 74839.9 75190.6 75273.9 76315.3 76891.0 9251.8 10502.9 10762.0 10872.3 10878.9 44399.8 44448.0 44541.0 44745.6 45512.5 56600.6 56726.6 56836.0 57972.7 58187.8 12948.3 13043.4 13134.5 13395.7 13555.4 13109.5 13916.9 14116.8 14335.4 14533.3 12898.3 13014.7 13194.5 13509.7 13554.5 12745.2 12878.4 12888.7 13301.3 13368.7 12947.5 13103.3 13146.0 13189.9 13615.5 10448.1 10738.4 10741.5 11240.6 11728.5 9037.5 10653.6 10922.5 10934.1 11081.4 08:58:56 INFO - PROCESS | 1635 | -------- Summary: end -------- 08:58:56 INFO - PROCESS | 1635 | 08:58:57 INFO - TEST-INFO | 1635: exit 0 08:58:57 INFO - TEST-OK | dromaeo_css | took 1122318ms 08:58:57 INFO - TEST-START | kraken 08:58:57 INFO - operating with platform_type : mac_ 08:58:57 INFO - Initialising browser for kraken test... 08:58:57 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpj5xvqi/profile http://localhost:49241/getInfo.html) 08:58:59 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 08:58:59 INFO - PROCESS | 1645 | colorDepth:24 08:58:59 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 08:58:59 INFO - PROCESS | 1645 | __metrics 08:58:59 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:58:59 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:59:00 INFO - TEST-INFO | 1645: exit 0 08:59:00 INFO - Browser initialized. 08:59:00 INFO - Running cycle 1/1 for kraken test... 08:59:00 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpj5xvqi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:59:12 INFO - PROCESS | 1646 | RSS: Main: 232701952 08:59:12 INFO - PROCESS | 1646 | 08:59:15 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 08:59:16 INFO - PROCESS | 1646 | RSS: Main: 284340224 08:59:16 INFO - PROCESS | 1646 | 08:59:18 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 08:59:19 INFO - PROCESS | 1646 | RSS: Main: 285282304 08:59:19 INFO - PROCESS | 1646 | 08:59:23 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 08:59:23 INFO - PROCESS | 1646 | RSS: Main: 376348672 08:59:23 INFO - PROCESS | 1646 | 08:59:25 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 08:59:26 INFO - PROCESS | 1646 | RSS: Main: 280006656 08:59:26 INFO - PROCESS | 1646 | 08:59:28 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:59:29 INFO - PROCESS | 1646 | RSS: Main: 281382912 08:59:29 INFO - PROCESS | 1646 | 08:59:31 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 08:59:32 INFO - PROCESS | 1646 | RSS: Main: 322846720 08:59:32 INFO - PROCESS | 1646 | 08:59:35 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 08:59:36 INFO - PROCESS | 1646 | RSS: Main: 327589888 08:59:36 INFO - PROCESS | 1646 | 08:59:39 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 08:59:40 INFO - PROCESS | 1646 | RSS: Main: 324177920 08:59:40 INFO - PROCESS | 1646 | 08:59:41 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:59:42 INFO - PROCESS | 1646 | RSS: Main: 300302336 08:59:42 INFO - PROCESS | 1646 | 08:59:44 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:59:44 INFO - PROCESS | 1646 | RSS: Main: 304979968 08:59:44 INFO - PROCESS | 1646 | 08:59:47 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:59:47 INFO - PROCESS | 1646 | RSS: Main: 306831360 08:59:47 INFO - PROCESS | 1646 | 08:59:50 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:59:51 INFO - PROCESS | 1646 | RSS: Main: 326578176 08:59:51 INFO - PROCESS | 1646 | 08:59:54 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:59:54 INFO - PROCESS | 1646 | RSS: Main: 321118208 08:59:54 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 08:59:56 INFO - PROCESS | 1646 | RSS: Main: 366084096 08:59:56 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | __start_tp_report 08:59:56 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 08:59:56 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 08:59:56 INFO - PROCESS | 1646 | |i|pagename|runs| 08:59:56 INFO - PROCESS | 1646 | |0;ai-astar;116;116;116;115;115;116;114;116;116;115 08:59:56 INFO - PROCESS | 1646 | |1;audio-beat-detection;148;110;111;151;113;112;110;110;133;110 08:59:56 INFO - PROCESS | 1646 | |2;audio-dft;185;186;186;188;187;186;232;249;184;186 08:59:56 INFO - PROCESS | 1646 | |3;audio-fft;81;60;58;92;63;60;61;59;78;61 08:59:56 INFO - PROCESS | 1646 | |4;audio-oscillator;90;86;121;101;80;70;85;68;69;85 08:59:56 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;88;89;89;88;89;88;93;88;89;89 08:59:56 INFO - PROCESS | 1646 | |6;imaging-darkroom;95;96;101;150;96;96;97;95;96;95 08:59:56 INFO - PROCESS | 1646 | |7;imaging-desaturate;86;110;76;128;129;114;84;84;86;86 08:59:56 INFO - PROCESS | 1646 | |8;json-parse-financial;63;61;62;61;61;61;62;63;62;61 08:59:56 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;56;63;55;61;61;61;57;58;58;58 08:59:56 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;87;86;85;86;85;86;86;98;106;104 08:59:56 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;143;141;140;139;138;145;147;150;183;158 08:59:56 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;215;171;173;173;170;169;173;172;173;169 08:59:56 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;66;69;67;66;68;65;66;63;64;63 08:59:56 INFO - PROCESS | 1646 | __end_tp_report 08:59:56 INFO - PROCESS | 1646 | __start_cc_report 08:59:56 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,2130 08:59:56 INFO - PROCESS | 1646 | __end_cc_report 08:59:56 INFO - PROCESS | 1646 | __startTimestamp1489251596936__endTimestamp 08:59:56 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | ------- Summary: start ------- 08:59:56 INFO - PROCESS | 1646 | Number of tests: 14 08:59:56 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:0.71 (0.6%) stddev-sans-first:0.73 08:59:56 INFO - PROCESS | 1646 | Values: 116.0 116.0 116.0 115.0 115.0 116.0 114.0 116.0 116.0 115.0 08:59:56 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:120.80 Median:112.50 stddev:16.67 (14.8%) stddev-sans-first:14.49 08:59:56 INFO - PROCESS | 1646 | Values: 148.0 110.0 111.0 151.0 113.0 112.0 110.0 110.0 133.0 110.0 08:59:56 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:196.90 Median:186.50 stddev:23.35 (12.5%) stddev-sans-first:24.37 08:59:56 INFO - PROCESS | 1646 | Values: 185.0 186.0 186.0 188.0 187.0 186.0 232.0 249.0 184.0 186.0 08:59:56 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:67.30 Median:62.00 stddev:11.89 (19.2%) stddev-sans-first:11.53 08:59:56 INFO - PROCESS | 1646 | Values: 81.0 60.0 58.0 92.0 63.0 60.0 61.0 59.0 78.0 61.0 08:59:56 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:85.50 Median:82.50 stddev:16.23 (19.7%) stddev-sans-first:17.13 08:59:56 INFO - PROCESS | 1646 | Values: 90.0 86.0 121.0 101.0 80.0 70.0 85.0 68.0 69.0 85.0 08:59:56 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:89.00 stddev:1.49 (1.7%) stddev-sans-first:1.54 08:59:56 INFO - PROCESS | 1646 | Values: 88.0 89.0 89.0 88.0 89.0 88.0 93.0 88.0 89.0 89.0 08:59:56 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:101.70 Median:96.00 stddev:17.06 (17.8%) stddev-sans-first:17.92 08:59:56 INFO - PROCESS | 1646 | Values: 95.0 96.0 101.0 150.0 96.0 96.0 97.0 95.0 96.0 95.0 08:59:56 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:98.30 Median:84.00 stddev:19.91 (23.7%) stddev-sans-first:20.62 08:59:56 INFO - PROCESS | 1646 | Values: 86.0 110.0 76.0 128.0 129.0 114.0 84.0 84.0 86.0 86.0 08:59:56 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.73 08:59:56 INFO - PROCESS | 1646 | Values: 63.0 61.0 62.0 61.0 61.0 61.0 62.0 63.0 62.0 61.0 08:59:56 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.50 stddev:2.57 (4.3%) stddev-sans-first:2.52 08:59:56 INFO - PROCESS | 1646 | Values: 56.0 63.0 55.0 61.0 61.0 61.0 57.0 58.0 58.0 58.0 08:59:56 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:86.00 stddev:8.37 (9.7%) stddev-sans-first:8.76 08:59:56 INFO - PROCESS | 1646 | Values: 87.0 86.0 85.0 86.0 85.0 86.0 86.0 98.0 106.0 104.0 08:59:56 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:148.40 Median:146.00 stddev:13.57 (9.3%) stddev-sans-first:14.25 08:59:56 INFO - PROCESS | 1646 | Values: 143.0 141.0 140.0 139.0 138.0 145.0 147.0 150.0 183.0 158.0 08:59:56 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:173.00 stddev:13.87 (8.0%) stddev-sans-first:1.74 08:59:56 INFO - PROCESS | 1646 | Values: 215.0 171.0 173.0 173.0 170.0 169.0 173.0 172.0 173.0 169.0 08:59:56 INFO - PROCESS | 1646 | 08:59:56 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:2.00 (3.0%) stddev-sans-first:2.12 08:59:56 INFO - PROCESS | 1646 | Values: 66.0 69.0 67.0 66.0 68.0 65.0 66.0 63.0 64.0 63.0 08:59:56 INFO - PROCESS | 1646 | -------- Summary: end -------- 08:59:56 INFO - PROCESS | 1646 | 08:59:57 INFO - TEST-INFO | 1646: exit 0 08:59:57 INFO - TEST-OK | kraken | took 60600ms 08:59:57 INFO - SUITE-END | took 1182s 08:59:58 INFO - Completed test suite (00:19:43) 08:59:58 INFO - javascript benchmark 08:59:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7536.392373080646, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3304.900852974411, 3360.9495857562133, 3365.158710322421, 3371.6459771723985, 3390.8304584770754, 5570.721463926808, 5643.717814109299, 5871.383504732001, 5911.9113213301835, 5920.644761314319, 5625.887482250352, 5626.943730562693, 5649.576281778873, 5649.943500564993, 5655.236543066685, 5137.666051706646, 5163.8192663256605, 5171.3535808024, 5206.973965130188, 5231.86920326993, 5353.705546194958, 5360.035193665139, 5360.490753378423, 5374.140137577989, 5378.489043540877, 5344.011357898801, 5353.892922141555, 5356.38401583819, 5361.410244873061, 5368.463153684639, 5349.7057661828585, 5359.276497672842, 5360.410354860962, 5372.516473517363, 5374.086405311067, 5197.48025197481, 5291.761870715827, 5297.5232229099565, 5303.893922121574, 5324.281222035014, 5995.610285331483, 6070.544709146788, 6075.210222671069, 6076.4834989025985, 6078.179445774808, 6263.123162757218, 6266.091416744592, 6270.404311590391, 6272.404121608485, 6281.434670879597, 5539.9169012464845, 6192.225971753531, 6225.128482012522, 6294.024426213944, 6298.118263443076, 6066.939330606726, 6077.696115194222, 6079.39206079393, 6115.0, 6116.541259405518, 6401.583897046677, 6463.57986730861, 6464.224293084766, 6466.256380516207, 6470.2559205691, 6120.508083830883, 6137.223770008841, 6207.193064901624, 6291.182146321041, 6309.810705678837, 6166.445019948226, 6285.43431091204, 6288.811335659938, 6289.150964619809, 6300.716467758962, 5266.657667251617, 6144.126041557279, 6171.259448866075, 6256.874862502725, 6292.4966002719675, 6212.9068063979075, 6254.093156492283, 6259.155014073133, 6262.874742505215, 6269.498440124779, 4958.876028099255, 5112.693238405707, 5114.181730923109, 5130.461301563357, 5132.178851383761, 4480.215962206601, 4505.0, 4513.390692256569, 4519.909601808011, 4522.095580883836, 5778.595498315078, 5779.0, 5780.479756821906, 5787.160861675034, 5808.535317174616, 6217.6891155442045, 6259.937400626027, 6269.373062693694, 6273.529485288622, 6287.0, 5751.1085781703905, 5769.509591684669, 5775.537956963432, 5776.364599894008, 5805.767769289266, 5504.53211477029, 5522.944770552243, 5529.474699903502, 5534.612577119563, 5544.362398324244, 5695.572832037531, 6272.278687950853, 6356.491480681534, 6374.713137908805, 6383.457406120532, 6280.466160376236, 6349.555531112777, 6353.650549219652, 6358.872822543616, 6377.904331434939, 5673.8297851064535, 6588.934110658832, 6601.438877695449, 6603.603783772989, 6612.206535215805, 6126.120738204555, 6159.692015399301, 6172.475339596184, 6212.968935155295, 6294.433500984934, 6119.969400152971, 6275.058741188858, 6284.968575157095, 6297.433231009231, 6297.527685423704, 6102.337773232528, 6122.794608433986, 6156.076588511759, 6215.06773983906, 6317.210348706411, 5293.0, 6247.687615619292, 6297.937020629735, 6300.558960872695, 6321.841953951188, 6124.295705993868, 6204.658743769136, 6207.968960155351, 6212.0, 6217.720202590985, 6083.117947897442, 6117.265928088658, 6158.538109641705, 6268.153799237045, 6330.683465826783, 6039.577229593886, 6040.275166979991, 6042.818715438544, 6043.153958445733, 6053.636781793107], "value": 5781.7431844155135, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.4024420707641, 774.233508826262, 843.9029511606167, 855.546560323029, 856.5717141429285, 38301.80849095754, 38991.0, 39114.80442597783, 39163.804180979125, 39190.0, 35191.59233630658, 39094.8045259774, 40522.0, 40564.79717601408, 40600.0, 7243.89134162988, 8876.467411955287, 9036.593353299084, 9058.23005044572, 9072.818543629124, 7333.853322933538, 7437.8512429751645, 7440.925590744077, 7441.479096463249, 10696.197785166143, 10935.398553079618, 10959.588890444089, 10962.780744385107, 10968.780624387507, 10993.450327483633, 10844.024037836554, 10882.836757448644, 10922.126229901669, 10926.235163538555, 10954.342739435659, 7179.569225846413, 7354.595497247649, 10621.309614875008, 10671.519781609846, 10678.412687302196, 31310.686893131005, 37134.0, 39621.80189099036, 39674.60325396767, 39700.40449393261, 3743.569489508714, 3778.792166430845, 3806.7906265155407, 3836.1560456699763, 3836.9424458633143, 27286.863565682044, 27681.446371072667, 27816.443671126464, 28329.85835070832, 28413.431731365465, 2810.6280913677906, 2847.9715202847915, 2848.6011958325853, 2867.842268675222, 2915.4460652475964, 303004.0, 303351.0, 303987.0, 304948.0, 306060.0, 49059.0, 49069.0, 49197.0, 49218.0, 49242.26136607882, 51607.742761158035, 51625.709357265616, 51679.48320516822, 51692.74153629208, 51863.222051669254, 13932.094413863066, 14286.571402857931, 14292.928535357465, 14321.713565728836, 14408.567742967727, 11610.30338179695, 11629.825552616718, 11632.243904146204, 11652.359120248468, 11666.125040621988, 10797.028267455968, 12385.0, 12788.680282993, 12794.872051279553, 12846.357682116044, 4575.58819706228, 5340.706261155674, 5408.188771684278, 5457.263269458652, 5472.343318801769, 856.8072183758604, 989.9902099858105, 1018.1956254558816, 1072.6835583502886, 1116.2799994003822, 25214.99140034378, 26226.86886565555, 26527.071552495956, 26760.33099172497, 26790.866045669645, 1041.7031146123318, 1117.4133579870634, 1128.4639796096953, 1140.2816225777872, 1175.8706542280343, 13160.736785264242, 13518.797218041736, 13888.097273677178, 13922.09506382082, 14004.789928151085, 402542.0, 403197.0, 403742.0, 403746.0, 403963.0, 53994.65013374618, 53999.0, 54064.0, 54201.45798541964, 54450.18324725132, 1230.9507619695112, 1348.615644541301, 1424.0530047518284, 1429.6140042188758, 1432.5702289313165, 19727.704084438457, 24437.0, 28368.290792730346, 29708.554371684873, 29758.064516129205, 51192.74403627958, 51402.74298628483, 51498.0, 51544.22683659673, 51559.48440515547, 443852.0, 446653.0, 447049.0, 447541.0, 448102.0, 33239.83380083084, 33861.66138338585, 33925.0, 34022.82988585041, 34081.31837363289, 42184.0, 43497.78251108724, 43559.9110022252, 43613.56386436095, 43627.78186109176, 33304.77404957426, 35335.82332088323, 35463.645363546035, 35729.92810215698, 36250.4562431569, 34539.82730086333, 34651.826740867145, 34896.82551587226, 35923.46114808332, 36018.81990590135, 35537.64462355343, 35610.28779424345, 35680.82159589185, 36568.817155914054, 37531.81234093812, 29764.70235297706, 30102.946396876003, 31119.844400777853, 32488.0, 32769.0, 24074.39814004664, 24098.759012409653, 24401.63397549074, 24865.875670622256, 25030.0], "value": 18401.794320541223, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.5338460386029, 395.7684754418665, 409.928262554053, 416.8332666933226, 439.9714018588792, 13054.216746995187, 14992.250387480623, 17994.820051799477, 21682.674759878573, 21847.126114955423, 16828.32686692531, 18123.0, 18548.536286592807, 18553.90723046383, 21898.89050554749, 4982.804127009528, 6386.233651961771, 6597.868042639145, 6631.734730610794, 6674.06563081169, 6521.576097553668, 6585.2097748270035, 6638.767643132492, 6644.136262285921, 6650.23522294935, 6336.176297081373, 6531.836704082389, 6563.835904102411, 6610.70251838666, 6629.801105966804, 6528.216614006302, 6595.241547222059, 6598.109255250528, 6599.0, 7192.856142877165, 7367.336939675455, 7445.702171913117, 7449.217832127657, 7454.925450745477, 7455.850882982364, 24874.87562562194, 25880.0, 26257.868710656516, 27289.0, 27543.31141721453, 2836.8297902125732, 2859.828410295389, 2905.6513218413716, 2912.461194678991, 2919.284775230061, 15560.37758489659, 16016.75974860378, 16025.0, 16350.591235219095, 17157.485275441755, 1730.6452177303622, 1894.4587082782805, 1895.2324308655018, 1912.177763561668, 1940.2045161483725, 133665.0, 141946.29026854903, 142003.28998355046, 143053.0, 146080.0, 19228.71156932647, 20185.394438166877, 20383.4904127398, 20886.895565522074, 21180.894095529424, 36927.446088308694, 36963.81518092392, 37038.0, 37106.443403348974, 37162.814185928895, 10025.14786243163, 10315.970744166254, 10512.370582559715, 10542.314749541256, 10694.94652526748, 7181.928180718231, 8442.493450392996, 8467.195616416431, 8653.524056176844, 8665.43674661145, 9659.855102173473, 10056.938327642962, 10163.898361016296, 10166.440845753406, 10203.642872499428, 3277.7869438486423, 3654.7624404413627, 3790.9431358529646, 3972.741771784825, 3978.701597380208, 792.8652129138061, 835.7534527314457, 870.5473153959905, 891.3136884598823, 942.0673533202217, 22266.777332226793, 22366.54617449893, 23834.523309533713, 24916.501669966863, 24989.750102499107, 941.1294552538874, 947.431541075363, 967.7193613852045, 986.063239922077, 989.5349185882624, 6802.387785099365, 6979.546329488669, 7040.823979400454, 7051.92948070523, 7271.745488907863, 553025.0, 565426.0, 686793.9244252854, 691065.0, 715406.0, 133215.0, 138958.0, 143293.0, 145292.0, 148602.51397486104, 1272.8854403103765, 1301.5965050834272, 1338.819259399988, 1339.6717804138048, 1345.4685399267235, 19824.207031718568, 21040.947952602615, 21047.894760526713, 21112.472188195417, 21115.366539003855, 41412.792936035126, 59142.70428647829, 61050.778984420955, 62045.37954620396, 62501.06248406369, 88274.55862720901, 88788.55605722188, 88922.77693057725, 89251.55374223347, 89697.23633164063, 11186.216964812385, 11566.94216528912, 11795.823062654239, 11808.992471280075, 11904.583339583072, 11376.748557658817, 13105.344732763515, 13108.672283192996, 13277.0, 13510.797338040134, 11237.213395062266, 11365.829512557484, 11542.59600913964, 11607.709807254887, 11703.648890533297, 10293.691189264335, 11262.436878155895, 11340.886591133984, 11664.0, 11970.880291196976, 10039.247056470647, 11479.36863472517, 11847.940760296144, 11865.347405892759, 11916.523339066687, 9566.952165239407, 11424.257423267461, 11774.411279436164, 11844.348560829238, 11865.932066114092, 11328.0, 11556.884431155917, 11746.65066986589, 11817.0, 11900.285982841056], "value": 11285.324193691165, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.0465674028183, 1592.7212737770894, 1619.8218195998443, 1620.8703303735701, 1628.1777702260356, 9021.458712477248, 9427.48148851813, 9444.622215111405, 9533.0, 9544.665936692218, 9046.90953090469, 9353.53232338382, 9989.600415983352, 10236.641717539887, 10534.473276336192, 2265.954680906385, 2314.537092581482, 2316.339843144696, 2317.895694693743, 2321.5124823787023, 2087.342487116561, 2194.6378847490146, 2200.5048864005553, 2208.4810069633622, 2210.171185805323, 1926.2776458827939, 2013.4865609269689, 2016.5160361513279, 2016.969745453812, 2019.7374341335606, 1996.8402527797814, 2021.0198053943825, 2232.598132336179, 2316.81465482761, 2320.760466150173, 2197.9780202197935, 2200.922967696139, 2203.5262418580082, 2207.64677651575, 2208.149862303009, 10762.623308184176, 10804.621838235702, 10812.189085818516, 10813.134949204123, 10825.891741082567, 4813.855584332476, 4964.925526117111, 4998.225275082368, 5019.071471777733, 5522.254495643077, 2901.840398778066, 3167.33485967947, 3231.757618178646, 3404.3191361727504, 3564.108972756811, 1062.3041907550567, 1077.8275475923815, 1131.7114135895295, 1191.3447603817865, 1216.2945491614842, 11991.0, 14728.852711472855, 14922.477713279983, 14948.878834087378, 14950.850491495055, 4644.674872758875, 4765.070811191854, 4836.492168322346, 4839.758012099381, 4869.415670119537, 12605.747885042249, 12607.747845043232, 12614.306213158181, 12620.927221186119, 12632.431540580696, 5859.677717725566, 5860.0, 5863.3257175424515, 5869.941300586939, 5874.118882167623, 5010.348654674942, 5034.0, 5080.161773307437, 5090.211017292251, 5163.845084647466, 3850.439457760558, 3887.61123887609, 3962.841486340572, 4015.578364271768, 4038.0, 1106.1261603333437, 1114.6934592986993, 1125.9887401126048, 1127.9097672186206, 1140.1448913315014, 791.9722809701748, 808.7250334886166, 826.1696994520469, 827.6813426830713, 832.238501770885, 6129.540284478682, 6341.619502829845, 6561.0, 6598.769043083469, 6631.535792494479, 910.2990697163148, 970.8495183246608, 983.3755565216139, 1013.5945621751358, 1063.9308444951052, 3498.4492335922564, 4074.266632006267, 4106.322456794595, 4231.767252801125, 4244.830206791756, 13073.215607063416, 13563.525276615272, 13736.725265494633, 13746.93126534361, 13758.449662013607, 13685.589432317047, 13686.589402317946, 13687.31563421825, 13712.17726936387, 13715.588532344045, 9780.217582593375, 9786.951065244628, 9814.46020468881, 9949.55227014786, 10062.597496100221, 6324.272708638566, 6575.375339342755, 6655.667216639245, 6766.4248538874745, 6792.864142717019, 10858.131349491863, 11936.76126477483, 12003.879961200626, 12049.578264760692, 12148.878511214774, 10129.493525323556, 12291.44688489038, 12499.437525311201, 12572.559960401708, 12632.557860474839, 8173.427860049739, 8208.753737387888, 8217.506949583045, 8291.0, 8393.370497212856, 9759.414435133915, 9827.0, 9935.701928942144, 9941.701748947544, 9969.052939970981, 8625.353098517762, 8724.127587241224, 8884.289256859307, 8917.55412229373, 8981.730548083568, 8649.0, 8713.564321783759, 8722.127787221227, 8732.825343493221, 8786.364090772615, 7589.203133670885, 7632.0, 7761.611919403895, 7768.495047821873, 7797.8555897128745, 5646.124850648156, 5715.599908006399, 5792.4497172768515, 5946.226990491208, 5985.341612422543, 5798.507126894261, 5890.617109887844, 5972.820815375546, 6091.9086213707715, 6169.105479705508], "value": 4946.6001737404085, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.0427098086936, 377.26809988622057, 378.23218865702614, 386.83946162342613, 390.5996353737419, 5041.672291301067, 5097.821576244833, 5133.61497887659, 5139.357580302462, 5154.896902061956, 3777.848886044555, 4520.412346394973, 4663.8367657132, 4691.249400095985, 5049.368828896388, 3508.4737289406667, 3650.142216579102, 3801.4107813288983, 3919.196564704243, 3922.529296484419, 3562.394392953191, 3779.678727308168, 3984.721069525134, 4016.919661606766, 4017.529219529997, 3318.70131688148, 3412.897613071612, 3956.9208615827665, 4003.619656132663, 4014.558398576154, 3410.316857793577, 3443.6212016678146, 3489.963503649636, 3944.6252606002386, 4046.4537287466255, 2650.4566563854364, 3517.8416971236356, 3522.9295414091575, 3527.9647203527893, 3549.769264997767, 4660.4174478190225, 4709.621641071271, 4941.382327209099, 4968.931679688884, 4974.751262436864, 3799.905002374935, 4323.718958267703, 4369.003981701935, 4689.484156742756, 4690.7654617269, 4912.828051018198, 5277.445868183824, 5362.865928351784, 5408.540274076709, 5457.481539253804, 3957.7770568711926, 3965.8499035279733, 3966.920661586752, 3971.8750468499215, 3974.4038394241097, 4855.757212139414, 5085.3726807421635, 5511.53151982082, 5531.695756733378, 5590.664560126405, 4025.5370632377067, 4608.5161058088415, 4740.597049250852, 4749.24012158053, 4770.713757174581, 4025.959740402617, 4081.795910204478, 4201.033762234703, 4892.339534162914, 4900.990593856573, 4721.93756404813, 4752.358431611758, 5110.821121260738, 5136.0, 5162.767675454614, 4221.746695198237, 5313.840584782462, 5433.468245640365, 5475.4524547544925, 5480.3971563128025, 1323.2788130468919, 1429.9857001430062, 1485.866272035522, 1555.3545278709435, 1560.5084398414463, 987.3828856964398, 1026.9024442677933, 1082.4749996251812, 1101.388729255271, 1176.2413243458093, 4774.164521208844, 4841.620138260579, 5050.080969231742, 5106.514881086291, 5117.8464646060675, 5274.393444753826, 5351.705656188869, 5632.97183514088, 5717.799877004285, 5754.856128596735, 4385.144896745168, 4776.570108690165, 4794.256890182028, 4800.895793967407, 4898.069366820293, 2484.6645702830247, 2807.2033898305103, 2927.2681829542616, 2934.5891575179066, 2948.4103179364215, 5828.504577110993, 5840.0071987762185, 5851.824445266649, 5852.8536786579825, 5862.355140934494, 5320.0, 5349.893002139936, 5483.983808905086, 5540.473655002768, 5772.624779389326, 5308.0, 5344.225087362311, 5433.9184912225555, 5634.3802181759975, 5677.943220567907, 4415.315626077963, 4711.929321060118, 5500.669959802424, 5508.779648814003, 5510.91733623988, 4913.543228385807, 5035.647504674637, 5189.299444574934, 5300.469953004668, 5572.665640061609, 5020.6234532410945, 5079.87300317495, 5161.490186673098, 5847.795462038704, 5864.797716468199, 4177.4151618774, 4412.536683648171, 4422.624076953495, 4426.64586833059, 4430.335449682573, 4735.905281894412, 4978.8755281118265, 5123.308353372247, 5615.535649158846, 5623.550115990629, 5085.6185786066935, 5108.642395032312, 5511.834644960658, 5520.861978450571, 5562.582806289463, 4693.530646935279, 4951.845947013061, 5264.31563896691, 5528.612997090165, 5542.722863856871, 4374.978125109481, 4915.721912302755, 5191.454897235887, 5353.583293782723, 5390.760125171311, 4971.577415919687, 5452.591055670761, 5481.451854814487, 5494.313210848644, 5509.531689806251, 5046.199359355593, 5172.844814655567, 5397.298351214317, 5401.648892821954, 5429.809956651498], "value": 4082.8045306846248, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.3828162076563, 712.5973824788994, 814.9959250203748, 824.2869917521344, 830.3564737328574, 14524.63688407789, 15331.846681533181, 15342.769858452104, 15346.07923524588, 15349.769753453693, 13929.512467063654, 14041.859581404184, 14161.0, 14170.220637864913, 14207.78688319676, 920.8020275640753, 932.7668082979255, 933.4725879877881, 936.2603543200863, 936.9833730402487, 941.1811723800304, 942.0861764088858, 943.5612440215299, 944.6929747831948, 944.8157609266195, 992.1417973452948, 1020.6631811502186, 1024.9948750256237, 1031.3554028732042, 1033.8294181460087, 1020.3316827478013, 1021.1473419694601, 1022.8312328465794, 1023.2734758321601, 1023.976023976024, 744.7877354953866, 749.0748925077579, 749.3106342165221, 749.4566439331495, 750.9361704255144, 15858.36566537337, 15878.36486540537, 15927.203639818079, 16112.677746445006, 16145.192740362934, 14590.197539135343, 14654.706905861929, 14869.0, 14915.030523015968, 15557.611059723484, 11251.43742812856, 11612.535498580046, 11688.123390745728, 11711.414429278588, 12186.08604354677, 3713.591504934455, 3732.682721968636, 3750.2124553843723, 3752.137008488036, 3820.44603532489, 112740.0, 113185.0, 113709.43145284304, 114706.0, 117211.24183137175, 11129.499172537255, 11576.24754390962, 11610.76778464426, 11675.532978680927, 11917.642470725892, 24370.756292437203, 24661.01355945778, 24948.875255623607, 24965.5006899861, 24977.0, 7679.923200768033, 7725.845483090419, 7853.8821917671285, 7905.604719763989, 8043.517388956564, 4089.6114869087387, 4165.708400412002, 4177.227212965611, 4189.832406703697, 4193.853215137517, 3498.1079824644553, 3573.7498375114014, 3590.6409359063887, 3594.0475773919934, 3597.5143355647174, 595.7468076067654, 601.6299975515027, 605.6820169411006, 624.537841996919, 625.8153844615849, 671.4292851076643, 675.1796567170911, 697.341012742953, 705.8235441139715, 709.2871663977669, 9633.518324083769, 9766.0, 9778.853317200248, 9956.398593246893, 10105.242106842017, 645.6739346629922, 679.7145199016425, 686.6566716641679, 691.509028589707, 715.9606221657755, 4062.8232859964473, 4177.858547934531, 4192.580741925783, 4304.053108316165, 4512.548745125461, 92363.61454578186, 94541.0, 97571.0242897562, 97985.51007244918, 100670.0, 47668.39378238342, 79599.0, 84115.0, 88894.0, 88897.0, 74839.87740183901, 75190.6240468805, 75273.87089193775, 76315.31871757658, 76891.0, 9251.76870578241, 10502.947485262524, 10762.0, 10872.293300935415, 10878.945605271923, 44399.778001109786, 44448.0, 44541.0, 44745.55254447544, 45512.54487455083, 56600.584985375695, 56726.581835454446, 56836.0, 57972.710136449045, 58187.836243274054, 12948.29252737837, 13043.413046412745, 13134.540291089766, 13395.665108372368, 13555.407816928719, 13109.541166059142, 13916.930415347859, 14116.78824817608, 14335.354909029327, 14533.273336333352, 12898.290594017419, 13014.674633134247, 13194.538191163263, 13509.729805404033, 13554.457821687021, 12745.235285882876, 12878.35608219604, 12888.742225155633, 13301.334933253105, 13368.732625347633, 12947.482100715866, 13103.279319637511, 13146.0, 13189.868101318863, 13615.455381784617, 10448.079623317153, 10738.355698658106, 10741.462926853783, 11240.550377985117, 11728.537007228577, 9037.539936102447, 10653.627123050655, 10922.453877305945, 10934.125269978542, 11081.390523521284], "value": 7555.087907698084, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1476.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 115.0, 115.0, 116.0, 114.0, 116.0, 116.0, 115.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 110.0, 111.0, 151.0, 113.0, 112.0, 110.0, 110.0, 133.0, 110.0], "value": 120.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 186.0, 188.0, 187.0, 186.0, 232.0, 249.0, 184.0, 186.0], "value": 196.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 58.0, 92.0, 63.0, 60.0, 61.0, 59.0, 78.0, 61.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 121.0, 101.0, 80.0, 70.0, 85.0, 68.0, 69.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 89.0, 88.0, 89.0, 88.0, 93.0, 88.0, 89.0, 89.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 101.0, 150.0, 96.0, 96.0, 97.0, 95.0, 96.0, 95.0], "value": 101.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 110.0, 76.0, 128.0, 129.0, 114.0, 84.0, 84.0, 86.0, 86.0], "value": 98.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 63.0, 62.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 63.0, 55.0, 61.0, 61.0, 61.0, 57.0, 58.0, 58.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 85.0, 86.0, 85.0, 86.0, 86.0, 98.0, 106.0, 104.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 141.0, 140.0, 139.0, 138.0, 145.0, 147.0, 150.0, 183.0, 158.0], "value": 148.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [215.0, 171.0, 173.0, 173.0, 170.0, 169.0, 173.0, 172.0, 173.0, 169.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 67.0, 66.0, 68.0, 65.0, 66.0, 63.0, 64.0, 63.0], "value": 65.7, "unit": "score"}]}]} 08:59:58 INFO - Return code: 0 08:59:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:59:58 ERROR - # TBPL SUCCESS # 08:59:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:59:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:59:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:59:58 INFO - 2017-03-11 08:59:58.273 screenresolution[1650:10224] starting screenresolution argv=screenresolution get 08:59:58 INFO - 2017-03-11 08:59:58.276 screenresolution[1650:10224] Display 0: 1600x1200x32@60 08:59:58 INFO - 2017-03-11 08:59:58.282 screenresolution[1651:10228] starting screenresolution argv=screenresolution list 08:59:58 INFO - Available Modes on Display 0 08:59:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:59:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:59:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:59:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:59:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:59:58 INFO - Intel Iris: 08:59:58 INFO - Chipset Model: Intel Iris 08:59:58 INFO - Type: GPU 08:59:58 INFO - Bus: Built-In 08:59:58 INFO - VRAM (Dynamic, Max): 1536 MB 08:59:58 INFO - Vendor: Intel (0x8086) 08:59:58 INFO - Device ID: 0x0a2e 08:59:58 INFO - Revision ID: 0x0009 08:59:58 INFO - Displays: 08:59:58 INFO - Display: 08:59:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:59:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:59:58 INFO - Display Serial Number: 1600x1200 60 08:59:58 INFO - Main Display: Yes 08:59:58 INFO - Mirror: Off 08:59:58 INFO - Online: Yes 08:59:58 INFO - Rotation: Supported 08:59:58 INFO - Return code: 0 08:59:58 INFO - Running post-action listener: _resource_record_post_action 08:59:58 INFO - [mozharness: 2017-03-11 16:59:58.523425Z] Finished run-tests step (success) 08:59:58 INFO - Running post-run listener: _resource_record_post_run 08:59:58 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 39064576; Write bytes: 513625088; Read time: 377; Write time: 1583 08:59:58 INFO - TinderboxPrint: CPU usage
54.2% 08:59:58 INFO - TinderboxPrint: I/O read bytes / time
39,064,576 / 377 08:59:58 INFO - TinderboxPrint: I/O write bytes / time
513,625,088 / 1,583 08:59:58 INFO - TinderboxPrint: CPU idle
2,204.2 (45.8%) 08:59:58 INFO - TinderboxPrint: CPU system
964.8 (20.0%) 08:59:58 INFO - TinderboxPrint: CPU user
1,648.6 (34.2%) 08:59:58 INFO - TinderboxPrint: Swap in / out
248,766,464 / 0 08:59:58 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 203356672; Write bytes: 204683264; Read time: 15661; Write time: 457 08:59:58 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 37237760; Write bytes: 298165248; Read time: 356; Write time: 1094 08:59:59 INFO - Running post-run listener: _upload_blobber_files 08:59:59 INFO - Blob upload gear active. 08:59:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:59:59 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:59:59 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:59:59 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:59:59 INFO - (blobuploader) - INFO - Open directory for files ... 08:59:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:59:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:00:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:00 INFO - (blobuploader) - INFO - Done attempting. 09:00:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:00:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:00:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:01 INFO - (blobuploader) - INFO - Done attempting. 09:00:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:00:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:00:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:02 INFO - (blobuploader) - INFO - Done attempting. 09:00:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:00:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:00:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:00:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:05 INFO - (blobuploader) - INFO - Done attempting. 09:00:05 INFO - (blobuploader) - INFO - Iteration through files over. 09:00:05 INFO - Return code: 0 09:00:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:00:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:00:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20d8869bfc5363eaf4b563124f6ab3052f4e998f4db94bf3fd7cadeb54e9778faa07f2e9deb60578ed6f721dc2697d977e7bb747a42e53d052c1700cc0a4024a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/487195d3c2f96d461c165cf858b344267dbccd21526b9cdd2f6bfe9de990717875e57ec8799ac217b9f2edb16a6f6ae56701494939de50af7087fe7a596a376d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7870e96e44dfefd2842b9fa7aa70575cbeb663a201720daf0f725eeaab9153f3e89c3eb2e512a22c835cec55d185de1a8ad277c59b74120d73bf9a0bd5dfd6fd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cdfdb97158e6d22b42e79f7cf03e289baf82c316a7d32c40b95d65738ca30eea43f155d3407c08469313bbd398fe79d0a16d7b309b33e007433e0b145eba544"} 09:00:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:00:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:00:05 INFO - Contents: 09:00:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20d8869bfc5363eaf4b563124f6ab3052f4e998f4db94bf3fd7cadeb54e9778faa07f2e9deb60578ed6f721dc2697d977e7bb747a42e53d052c1700cc0a4024a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/487195d3c2f96d461c165cf858b344267dbccd21526b9cdd2f6bfe9de990717875e57ec8799ac217b9f2edb16a6f6ae56701494939de50af7087fe7a596a376d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7870e96e44dfefd2842b9fa7aa70575cbeb663a201720daf0f725eeaab9153f3e89c3eb2e512a22c835cec55d185de1a8ad277c59b74120d73bf9a0bd5dfd6fd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cdfdb97158e6d22b42e79f7cf03e289baf82c316a7d32c40b95d65738ca30eea43f155d3407c08469313bbd398fe79d0a16d7b309b33e007433e0b145eba544"} 09:00:05 INFO - Running post-run listener: copy_logs_to_upload_dir 09:00:05 INFO - Copying logs to upload dir... 09:00:05 INFO - mkdir: /builds/slave/test/build/upload/logs 09:00:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.219502 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-03-11 09:00:06.055001) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-11 09:00:06.058785) ========= 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.GK1psSsk5Z/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.6PZBToxTEp/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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/20d8869bfc5363eaf4b563124f6ab3052f4e998f4db94bf3fd7cadeb54e9778faa07f2e9deb60578ed6f721dc2697d977e7bb747a42e53d052c1700cc0a4024a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/487195d3c2f96d461c165cf858b344267dbccd21526b9cdd2f6bfe9de990717875e57ec8799ac217b9f2edb16a6f6ae56701494939de50af7087fe7a596a376d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7870e96e44dfefd2842b9fa7aa70575cbeb663a201720daf0f725eeaab9153f3e89c3eb2e512a22c835cec55d185de1a8ad277c59b74120d73bf9a0bd5dfd6fd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cdfdb97158e6d22b42e79f7cf03e289baf82c316a7d32c40b95d65738ca30eea43f155d3407c08469313bbd398fe79d0a16d7b309b33e007433e0b145eba544"} build_url:https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20d8869bfc5363eaf4b563124f6ab3052f4e998f4db94bf3fd7cadeb54e9778faa07f2e9deb60578ed6f721dc2697d977e7bb747a42e53d052c1700cc0a4024a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/487195d3c2f96d461c165cf858b344267dbccd21526b9cdd2f6bfe9de990717875e57ec8799ac217b9f2edb16a6f6ae56701494939de50af7087fe7a596a376d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7870e96e44dfefd2842b9fa7aa70575cbeb663a201720daf0f725eeaab9153f3e89c3eb2e512a22c835cec55d185de1a8ad277c59b74120d73bf9a0bd5dfd6fd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cdfdb97158e6d22b42e79f7cf03e289baf82c316a7d32c40b95d65738ca30eea43f155d3407c08469313bbd398fe79d0a16d7b309b33e007433e0b145eba544"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-11 09:00:06.094852) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 09:00:06.095243) ========= 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.GK1psSsk5Z/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.6PZBToxTEp/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005079 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 09:00:06.144146) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-11 09:00:06.144478) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-11 09:00:06.144852) ========= ========= Total master_lag: 0.19 =========