builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0271 starttime: 1477949540.85 results: success (0) buildid: 20161031120204 builduid: c6d2503dd6bb4f12a2c414ab3220dcb8 revision: 1aa20bcbb80e1014e4d01057f7d52269b0c2d908 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 14:32:20.854715) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 14:32:20.855217) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 14:32:20.855551) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 14:32:20.881317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 14:32:20.881700) ========= 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.xF3mEtQ3Yn/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.lvAGmxXgMZ/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-31 14:32:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2016-10-31 14:32:21 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117160 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 14:32:21.022771) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 14:32:21.023316) ========= 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.xF3mEtQ3Yn/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.lvAGmxXgMZ/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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.024698 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 14:32:21.073216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 14:32:21.073680) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1aa20bcbb80e1014e4d01057f7d52269b0c2d908 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1aa20bcbb80e1014e4d01057f7d52269b0c2d908 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xF3mEtQ3Yn/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.lvAGmxXgMZ/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-31 14:32:21,169 truncating revision to first 12 chars 2016-10-31 14:32:21,169 Setting DEBUG logging. 2016-10-31 14:32:21,170 attempt 1/10 2016-10-31 14:32:21,170 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1aa20bcbb80e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 14:32:22,269 unpacking tar archive at: fx-team-1aa20bcbb80e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.367037 ========= master_lag: 0.19 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 14:32:22.632570) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 14:32:22.633037) ========= script_repo_revision: 1aa20bcbb80e1014e4d01057f7d52269b0c2d908 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 14:32:22.636738) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 14:32:22.637275) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 14:32:22.673504) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-10-31 14:32:22.673991) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xF3mEtQ3Yn/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.lvAGmxXgMZ/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 14:32:22 INFO - MultiFileLogger online at 20161031 14:32:22 in /builds/slave/test 14:32:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:32:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:32:22 INFO - {'append_to_log': False, 14:32:22 INFO - 'base_work_dir': '/builds/slave/test', 14:32:22 INFO - 'blob_upload_branch': 'Fx-Team', 14:32:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:32:22 INFO - 'branch': 'Fx-Team', 14:32:22 INFO - 'buildbot_json_path': 'buildprops.json', 14:32:22 INFO - 'config_files': ('talos/mac_config.py',), 14:32:22 INFO - 'default_actions': ('clobber', 14:32:22 INFO - 'read-buildbot-config', 14:32:22 INFO - 'download-and-extract', 14:32:22 INFO - 'populate-webroot', 14:32:22 INFO - 'create-virtualenv', 14:32:22 INFO - 'install', 14:32:22 INFO - 'run-tests'), 14:32:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:32:22 INFO - 'download_minidump_stackwalk': True, 14:32:22 INFO - 'download_symbols': 'ondemand', 14:32:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:32:22 INFO - 'tooltool.py': '/tools/tooltool.py', 14:32:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:32:22 INFO - '/tools/misc-python/virtualenv.py')}, 14:32:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:32:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:32:22 INFO - 'installer_path': 'installer.exe', 14:32:22 INFO - 'log_level': 'info', 14:32:22 INFO - 'log_name': 'talos', 14:32:22 INFO - 'log_to_console': True, 14:32:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:32:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:32:22 INFO - 'opt_config_files': (), 14:32:22 INFO - 'pip_index': False, 14:32:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:32:22 INFO - 'cmd': ('bash', 14:32:22 INFO - '-c', 14:32:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:32:22 INFO - 'enabled': True, 14:32:22 INFO - 'halt_on_failure': False, 14:32:22 INFO - 'name': 'check_screen_resolution'},), 14:32:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:32:22 INFO - 'cmd': ('bash', 14:32:22 INFO - '-c', 14:32:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:32:22 INFO - 'enabled': True, 14:32:22 INFO - 'halt_on_failure': False, 14:32:22 INFO - 'name': 'check_screen_resolution'},), 14:32:22 INFO - 'run_cmd_checks_enabled': True, 14:32:22 INFO - 'sps_profile': False, 14:32:22 INFO - 'sps_profile_interval': 0, 14:32:22 INFO - 'suite': 'dromaeojs', 14:32:22 INFO - 'system_bits': '32', 14:32:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:32:22 INFO - 'title': 't-yosemite-r7-0271', 14:32:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:32:22 INFO - 'use_talos_json': True, 14:32:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:32:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:32:22 INFO - 'work_dir': 'build'} 14:32:22 INFO - [mozharness: 2016-10-31 21:32:22.897096Z] Running clobber step. 14:32:22 INFO - Running pre-action listener: _resource_record_pre_action 14:32:22 INFO - Running main action method: clobber 14:32:22 INFO - rmtree: /builds/slave/test/build 14:32:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:32:24 INFO - Running post-action listener: _resource_record_post_action 14:32:24 INFO - [mozharness: 2016-10-31 21:32:24.995561Z] Finished clobber step (success) 14:32:24 INFO - [mozharness: 2016-10-31 21:32:24.995686Z] Running read-buildbot-config step. 14:32:24 INFO - Running pre-action listener: _resource_record_pre_action 14:32:24 INFO - Running main action method: read_buildbot_config 14:32:24 INFO - Using buildbot properties: 14:32:24 INFO - { 14:32:24 INFO - "project": "", 14:32:24 INFO - "product": "firefox", 14:32:24 INFO - "script_repo_revision": "production", 14:32:24 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:32:24 INFO - "repository": "", 14:32:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:32:24 INFO - "buildid": "20161031120204", 14:32:24 INFO - "pgo_build": "False", 14:32:24 INFO - "basedir": "/builds/slave/test", 14:32:24 INFO - "buildnumber": 17, 14:32:24 INFO - "slavename": "t-yosemite-r7-0271", 14:32:24 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 14:32:24 INFO - "platform": "yosemite_r7", 14:32:24 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:32:24 INFO - "branch": "fx-team", 14:32:24 INFO - "repo_path": "integration/fx-team", 14:32:24 INFO - "revision": "1aa20bcbb80e1014e4d01057f7d52269b0c2d908", 14:32:24 INFO - "stage_platform": "macosx64", 14:32:24 INFO - "builduid": "c6d2503dd6bb4f12a2c414ab3220dcb8", 14:32:24 INFO - "slavebuilddir": "test" 14:32:24 INFO - } 14:32:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 14:32:24 INFO - Running post-action listener: _resource_record_post_action 14:32:24 INFO - [mozharness: 2016-10-31 21:32:24.998985Z] Finished read-buildbot-config step (success) 14:32:24 INFO - [mozharness: 2016-10-31 21:32:24.999093Z] Running download-and-extract step. 14:32:24 INFO - Running pre-action listener: _resource_record_pre_action 14:32:24 INFO - Running main action method: download_and_extract 14:32:24 INFO - mkdir: /builds/slave/test/build/tests 14:32: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')]} 14:32:24 INFO - trying https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 14:32:25 INFO - Downloading https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:32:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 14:32:26 INFO - Downloaded 1199 bytes. 14:32:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:32:26 INFO - Using the following test package requirements: 14:32:26 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:32:26 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:32:26 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 14:32:26 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:32:26 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 14:32:26 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:32:26 INFO - u'jsshell-mac.zip'], 14:32:26 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:32:26 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 14:32:26 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:32:26 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:32:26 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 14:32:26 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:32:26 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 14:32:26 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:32:26 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 14:32:26 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:32:26 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 14:32:26 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:32:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:32:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:32:26 INFO - Fetch https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:32:26 INFO - Http code: 200 14:32:26 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 14:32:26 INFO - x-amz-cf-id: LBq7pzuMCPZtYZXBHZPwU8YZ5TwdSpKZ6Gwvj2k6NkKz_12SIgLiSQ== 14:32:26 INFO - x-amz-version-id: Pb7Jspka__mIDeXUjGUpBiaE6EFhkDe1 14:32:27 INFO - Expected file size: 16404303 14:32:27 INFO - Obtained file size: 16404303 14:32:33 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:32:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:32:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:32:33 INFO - Fetch https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:32:34 INFO - Http code: 200 14:32:34 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 14:32:34 INFO - x-amz-cf-id: -XiZSsIG98hPGRLwmwd-vsg48xLayDtnUo2NaOTWuSZYRfzK-AnikA== 14:32:34 INFO - x-amz-version-id: Pb7Jspka__mIDeXUjGUpBiaE6EFhkDe1 14:32:34 INFO - Expected file size: 16404303 14:32:34 INFO - Obtained file size: 16404303 14:32:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 14:32:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:32:40 INFO - Fetch https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 14:32:41 INFO - Http code: 200 14:32:41 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 14:32:41 INFO - x-amz-cf-id: nuqh2646KNHxUUWDAtjGD22j44Mf8xR_tlyLR8G0U8ySB821q55MmQ== 14:32:41 INFO - x-amz-version-id: udzeXVnTO510HhivQO.PGKLRnYmgwjbq 14:32:41 INFO - Expected file size: 14409038 14:32:41 INFO - Obtained file size: 14409038 14:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:32:42 INFO - trying https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:32:42 INFO - Downloading https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 14:32:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 14:32:45 INFO - Downloaded 112068671 bytes. 14:32:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:32:45 INFO - mkdir: /builds/slave/test/properties 14:32:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:32:45 INFO - Writing to file /builds/slave/test/properties/build_url 14:32:45 INFO - Contents: 14:32:45 INFO - build_url:https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:32:45 INFO - Running post-action listener: _resource_record_post_action 14:32:45 INFO - Running post-action listener: set_extra_try_arguments 14:32:45 INFO - [mozharness: 2016-10-31 21:32:45.838308Z] Finished download-and-extract step (success) 14:32:45 INFO - [mozharness: 2016-10-31 21:32:45.838455Z] Running populate-webroot step. 14:32:45 INFO - Running pre-action listener: _resource_record_pre_action 14:32:45 INFO - Running main action method: populate_webroot 14:32:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:32:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:32:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:32:45 INFO - '--tppagecycles', 14:32:45 INFO - '7'], 14:32:45 INFO - 'tests': ['tsvgm']}}, 14:32:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:32:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:32:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:32:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:32:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:32:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:32:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:45 INFO - 'talos_options': ['--disable-e10s'], 14:32:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:45 INFO - 'talos_options': ['--disable-e10s'], 14:32:45 INFO - 'tests': ['damp', 'tps']}, 14:32:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:45 INFO - 'tests': ['damp', 'tps']}, 14:32:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:32:45 INFO - 'tests': ['dromaeo_dom']}, 14:32:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:32:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:32:45 INFO - 'tests': ['basic_compositor_video']}, 14:32:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:32:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:32:45 INFO - 'tests': ['a11yr', 14:32:45 INFO - 'ts_paint', 14:32:45 INFO - 'tpaint', 14:32:45 INFO - 'sessionrestore', 14:32:45 INFO - 'sessionrestore_no_auto_restore', 14:32:45 INFO - 'tabpaint']}, 14:32:45 INFO - 'other-e10s': {'tests': ['a11yr', 14:32:45 INFO - 'ts_paint', 14:32:45 INFO - 'tpaint', 14:32:45 INFO - 'sessionrestore', 14:32:45 INFO - 'sessionrestore_no_auto_restore', 14:32:45 INFO - 'tabpaint']}, 14:32:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:32:45 INFO - 'ts_paint', 14:32:45 INFO - 'tpaint', 14:32:45 INFO - 'sessionrestore', 14:32:45 INFO - 'sessionrestore_no_auto_restore', 14:32:45 INFO - 'tabpaint']}, 14:32:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:32:45 INFO - 'ts_paint', 14:32:45 INFO - 'tpaint', 14:32:45 INFO - 'sessionrestore', 14:32:45 INFO - 'sessionrestore_no_auto_restore', 14:32:45 INFO - 'tabpaint']}, 14:32:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:32:45 INFO - 'tests': ['a11yr', 14:32:45 INFO - 'ts_paint', 14:32:45 INFO - 'tpaint', 14:32:45 INFO - 'sessionrestore', 14:32:45 INFO - 'sessionrestore_no_auto_restore', 14:32:45 INFO - 'tabpaint']}, 14:32:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:32:45 INFO - 'tests': ['a11yr', 14:32:45 INFO - 'ts_paint', 14:32:45 INFO - 'tpaint', 14:32:45 INFO - 'sessionrestore', 14:32:45 INFO - 'sessionrestore_no_auto_restore', 14:32:45 INFO - 'tabpaint']}, 14:32:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:32:45 INFO - 'tests': ['tsvgx', 14:32:45 INFO - 'tsvgr_opacity', 14:32:45 INFO - 'tart', 14:32:45 INFO - 'tscrollx', 14:32:45 INFO - 'cart']}, 14:32:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:32:45 INFO - 'tsvgr_opacity', 14:32:45 INFO - 'tart', 14:32:45 INFO - 'tscrollx', 14:32:45 INFO - 'cart']}, 14:32:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:45 INFO - 'talos_options': ['--disable-e10s'], 14:32:45 INFO - 'tests': ['tp5o']}, 14:32:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:45 INFO - 'tests': ['tp5o']}, 14:32:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:45 INFO - 'talos_options': ['--disable-e10s', 14:32:45 INFO - '--xperf_path', 14:32:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:45 INFO - 'tests': ['tp5n']}, 14:32:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:45 INFO - 'talos_options': ['--xperf_path', 14:32:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:45 INFO - 'tests': ['tp5n']}}, 14:32:45 INFO - 'talos.zip': {'path': '', 14:32:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:32:45 INFO - Running post-action listener: _resource_record_post_action 14:32:45 INFO - [mozharness: 2016-10-31 21:32:45.857135Z] Finished populate-webroot step (success) 14:32:45 INFO - [mozharness: 2016-10-31 21:32:45.857217Z] Running create-virtualenv step. 14:32:45 INFO - Running pre-action listener: _resource_record_pre_action 14:32:45 INFO - Running main action method: create_virtualenv 14:32:45 INFO - Creating virtualenv /builds/slave/test/build/venv 14:32:45 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 14:32:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:32:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:32:45 INFO - Using real prefix '/tools/python27' 14:32:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:32:46 INFO - Installing distribute.............................................................................................................................................................................................done. 14:32:49 INFO - Installing pip.................done. 14:32:49 INFO - Return code: 0 14:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:32:49 INFO - Reading from file tmpfile_stdout 14:32:49 INFO - Output received: 14:32:49 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) 14:32:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:32:49 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')]} 14:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:49 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')]} 14:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:49 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 0x1084eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108461570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff498c8c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082ffd30>, '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 0x108125db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082f7b20>, '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.xF3mEtQ3Yn/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.lvAGmxXgMZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 14:32:49 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 14:32:49 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 14:32:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xF3mEtQ3Yn/Render', 14:32:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:49 INFO - 'HOME': '/Users/cltbld', 14:32:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:49 INFO - 'LOGNAME': 'cltbld', 14:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:49 INFO - 'MOZ_NO_REMOTE': '1', 14:32:49 INFO - 'NO_EM_RESTART': '1', 14:32:49 INFO - 'PAGER': '/bin/cat', 14:32:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:49 INFO - 'PWD': '/builds/slave/test', 14:32:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:49 INFO - 'SHELL': '/bin/bash', 14:32:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvAGmxXgMZ/Listeners', 14:32:49 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 14:32:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:49 INFO - 'USER': 'cltbld', 14:32:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:49 INFO - 'XPC_FLAGS': '0x0', 14:32:49 INFO - 'XPC_SERVICE_NAME': '0', 14:32:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:50 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 14:32:50 INFO - Cleaning up... 14:32:50 INFO - Return code: 0 14:32:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:32:50 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')]} 14:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:50 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')]} 14:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:50 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 0x1084eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108461570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff498c8c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082ffd30>, '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 0x108125db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082f7b20>, '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.xF3mEtQ3Yn/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.lvAGmxXgMZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 14:32:50 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 14:32:50 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 14:32:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xF3mEtQ3Yn/Render', 14:32:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:50 INFO - 'HOME': '/Users/cltbld', 14:32:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:50 INFO - 'LOGNAME': 'cltbld', 14:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:50 INFO - 'MOZ_NO_REMOTE': '1', 14:32:50 INFO - 'NO_EM_RESTART': '1', 14:32:50 INFO - 'PAGER': '/bin/cat', 14:32:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:50 INFO - 'PWD': '/builds/slave/test', 14:32:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:50 INFO - 'SHELL': '/bin/bash', 14:32:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvAGmxXgMZ/Listeners', 14:32:50 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 14:32:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:50 INFO - 'USER': 'cltbld', 14:32:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:50 INFO - 'XPC_FLAGS': '0x0', 14:32:50 INFO - 'XPC_SERVICE_NAME': '0', 14:32:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:50 INFO - Downloading/unpacking psutil>=3.1.1 14:32:50 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 14:32:50 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 14:32:50 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 14:32:50 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 14:32:50 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 14:32:50 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 14:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:32:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:53 INFO - Installing collected packages: psutil 14:32:53 INFO - Running setup.py install for psutil 14:32:53 INFO - building 'psutil._psutil_osx' extension 14:32:53 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 14:32:54 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 14:32:54 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 14:32:54 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 14:32:54 INFO - building 'psutil._psutil_posix' extension 14:32:54 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 14:32:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:32:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:32:54 INFO - ^ 14:32:54 INFO - 1 warning generated. 14:32:54 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 14:32:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:54 INFO - Successfully installed psutil 14:32:54 INFO - Cleaning up... 14:32:55 INFO - Return code: 0 14:32:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:32:55 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')]} 14:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:55 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')]} 14:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:55 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 0x1084eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108461570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff498c8c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082ffd30>, '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 0x108125db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082f7b20>, '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.xF3mEtQ3Yn/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.lvAGmxXgMZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 14:32:55 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 14:32:55 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 14:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xF3mEtQ3Yn/Render', 14:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:55 INFO - 'HOME': '/Users/cltbld', 14:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:55 INFO - 'LOGNAME': 'cltbld', 14:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:55 INFO - 'MOZ_NO_REMOTE': '1', 14:32:55 INFO - 'NO_EM_RESTART': '1', 14:32:55 INFO - 'PAGER': '/bin/cat', 14:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:55 INFO - 'PWD': '/builds/slave/test', 14:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:55 INFO - 'SHELL': '/bin/bash', 14:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvAGmxXgMZ/Listeners', 14:32:55 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 14:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:55 INFO - 'USER': 'cltbld', 14:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:55 INFO - 'XPC_FLAGS': '0x0', 14:32:55 INFO - 'XPC_SERVICE_NAME': '0', 14:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:32:55 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 14:32:55 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 14:32:55 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 14:32:55 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 14:32:55 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 14:32:55 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 14:32:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:32:57 INFO - Installing collected packages: mozsystemmonitor 14:32:57 INFO - Running setup.py install for mozsystemmonitor 14:32:57 INFO - Successfully installed mozsystemmonitor 14:32:57 INFO - Cleaning up... 14:32:58 INFO - Return code: 0 14:32:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:32:58 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')]} 14:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:58 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')]} 14:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:58 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 0x1084eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108461570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff498c8c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082ffd30>, '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 0x108125db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082f7b20>, '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.xF3mEtQ3Yn/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.lvAGmxXgMZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 14:32:58 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 14:32:58 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 14:32:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xF3mEtQ3Yn/Render', 14:32:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:32:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:32:58 INFO - 'HOME': '/Users/cltbld', 14:32:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:32:58 INFO - 'LOGNAME': 'cltbld', 14:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:58 INFO - 'MOZ_NO_REMOTE': '1', 14:32:58 INFO - 'NO_EM_RESTART': '1', 14:32:58 INFO - 'PAGER': '/bin/cat', 14:32:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:58 INFO - 'PWD': '/builds/slave/test', 14:32:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:32:58 INFO - 'SHELL': '/bin/bash', 14:32:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvAGmxXgMZ/Listeners', 14:32:58 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 14:32:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:32:58 INFO - 'USER': 'cltbld', 14:32:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:32:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:58 INFO - 'XPC_FLAGS': '0x0', 14:32:58 INFO - 'XPC_SERVICE_NAME': '0', 14:32:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:58 INFO - Downloading/unpacking jsonschema==2.5.1 14:32:58 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 14:32:58 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 14:32:58 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 14:32:58 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 14:32:58 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 14:32:58 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 14:33:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:33:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:33:00 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 14:33:00 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 14:33:00 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 14:33:00 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 14:33:00 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 14:33:00 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 14:33:01 INFO - Downloading functools32-3.2.3-2.tar.gz 14:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:33:01 INFO - warning: no files found matching '*.txt' 14:33:01 INFO - no previously-included directories found matching 'build' 14:33:01 INFO - no previously-included directories found matching 'dist' 14:33:01 INFO - no previously-included directories found matching '.git*' 14:33:01 INFO - Installing collected packages: jsonschema, functools32 14:33:01 INFO - Running setup.py install for functools32 14:33:01 INFO - warning: no files found matching '*.txt' 14:33:01 INFO - no previously-included directories found matching 'build' 14:33:01 INFO - no previously-included directories found matching 'dist' 14:33:01 INFO - no previously-included directories found matching '.git*' 14:33:01 INFO - Successfully installed jsonschema functools32 14:33:01 INFO - Cleaning up... 14:33:01 INFO - Return code: 0 14:33:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:01 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 0x1084eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108461570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff498c8c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082ffd30>, '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 0x108125db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082f7b20>, '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.xF3mEtQ3Yn/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.lvAGmxXgMZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 14:33:01 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 14:33:01 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 14:33:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xF3mEtQ3Yn/Render', 14:33:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:01 INFO - 'HOME': '/Users/cltbld', 14:33:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:01 INFO - 'LOGNAME': 'cltbld', 14:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:01 INFO - 'MOZ_NO_REMOTE': '1', 14:33:01 INFO - 'NO_EM_RESTART': '1', 14:33:01 INFO - 'PAGER': '/bin/cat', 14:33:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:01 INFO - 'PWD': '/builds/slave/test', 14:33:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:01 INFO - 'SHELL': '/bin/bash', 14:33:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvAGmxXgMZ/Listeners', 14:33:01 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 14:33:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:01 INFO - 'USER': 'cltbld', 14:33:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:01 INFO - 'XPC_FLAGS': '0x0', 14:33:01 INFO - 'XPC_SERVICE_NAME': '0', 14:33:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:33:01 INFO - Cleaning up... 14:33:01 INFO - Return code: 0 14:33:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:01 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 0x1084eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108461570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff498c8c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082ffd30>, '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 0x108125db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082f7b20>, '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.xF3mEtQ3Yn/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.lvAGmxXgMZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 14:33:01 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 14:33:01 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 14:33:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xF3mEtQ3Yn/Render', 14:33:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:01 INFO - 'HOME': '/Users/cltbld', 14:33:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:01 INFO - 'LOGNAME': 'cltbld', 14:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:01 INFO - 'MOZ_NO_REMOTE': '1', 14:33:01 INFO - 'NO_EM_RESTART': '1', 14:33:01 INFO - 'PAGER': '/bin/cat', 14:33:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:01 INFO - 'PWD': '/builds/slave/test', 14:33:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:01 INFO - 'SHELL': '/bin/bash', 14:33:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvAGmxXgMZ/Listeners', 14:33:01 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 14:33:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:01 INFO - 'USER': 'cltbld', 14:33:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:01 INFO - 'XPC_FLAGS': '0x0', 14:33:01 INFO - 'XPC_SERVICE_NAME': '0', 14:33:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:02 INFO - Downloading/unpacking blobuploader==1.2.4 14:33:02 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 14:33:02 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 14:33:02 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 14:33:02 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 14:33:02 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 14:33:02 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 14:33:04 INFO - Downloading blobuploader-1.2.4.tar.gz 14:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:33:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:33:04 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 14:33:04 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 14:33:04 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 14:33:04 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 14:33:04 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 14:33:04 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 14:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:33:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:33:05 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 14:33:05 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 14:33:05 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 14:33:05 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 14:33:05 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 14:33:05 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 14:33:05 INFO - Downloading docopt-0.6.1.tar.gz 14:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:33:05 INFO - Installing collected packages: blobuploader, requests, docopt 14:33:05 INFO - Running setup.py install for blobuploader 14:33:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:33:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:33:06 INFO - Running setup.py install for requests 14:33:06 INFO - Running setup.py install for docopt 14:33:06 INFO - Successfully installed blobuploader requests docopt 14:33:06 INFO - Cleaning up... 14:33:06 INFO - Return code: 0 14:33:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33:06 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')]} 14:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:06 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')]} 14:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:06 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 0x1084eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108461570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff498c8c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082ffd30>, '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 0x108125db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082f7b20>, '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.xF3mEtQ3Yn/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.lvAGmxXgMZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 14:33:06 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 14:33:06 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 14:33:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xF3mEtQ3Yn/Render', 14:33:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:06 INFO - 'HOME': '/Users/cltbld', 14:33:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:06 INFO - 'LOGNAME': 'cltbld', 14:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:06 INFO - 'MOZ_NO_REMOTE': '1', 14:33:06 INFO - 'NO_EM_RESTART': '1', 14:33:06 INFO - 'PAGER': '/bin/cat', 14:33:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:06 INFO - 'PWD': '/builds/slave/test', 14:33:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:06 INFO - 'SHELL': '/bin/bash', 14:33:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvAGmxXgMZ/Listeners', 14:33:06 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 14:33:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:06 INFO - 'USER': 'cltbld', 14:33:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:06 INFO - 'XPC_FLAGS': '0x0', 14:33:06 INFO - 'XPC_SERVICE_NAME': '0', 14:33:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:33:07 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-5ZrqnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:33:07 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-1BCx0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:33:07 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-YZFNiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:33:07 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-q2VKEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:33:07 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-bbeAaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:33:07 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-4KyQaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:33:07 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-UauA3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:33:07 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-iC9K31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:33:07 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-KYpxLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:33:08 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-e9qV6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:33:08 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-tzCmHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:33:08 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-H01kXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:33:08 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-IgZC_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:33:08 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-UVeaat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:08 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-HLQzay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:33:08 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-nvKwtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:33:08 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-_eV1F6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:33:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:33:08 INFO - Running setup.py install for manifestparser 14:33:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:33:08 INFO - Running setup.py install for mozcrash 14:33:09 INFO - Running setup.py install for mozdebug 14:33:09 INFO - Running setup.py install for mozdevice 14:33:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:33:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:33:09 INFO - Running setup.py install for mozfile 14:33:09 INFO - Running setup.py install for mozhttpd 14:33:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:33:09 INFO - Running setup.py install for mozinfo 14:33:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:33:09 INFO - Running setup.py install for mozInstall 14:33:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:33:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:33:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:33:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:33:10 INFO - Running setup.py install for mozleak 14:33:10 INFO - Running setup.py install for mozlog 14:33:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:33:10 INFO - Running setup.py install for moznetwork 14:33:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:33:10 INFO - Running setup.py install for mozprocess 14:33:10 INFO - Running setup.py install for mozprofile 14:33:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:33:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:33:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:33:10 INFO - Running setup.py install for mozrunner 14:33:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:33:10 INFO - Running setup.py install for mozscreenshot 14:33:11 INFO - Running setup.py install for moztest 14:33:11 INFO - Running setup.py install for mozversion 14:33:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:33:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:33:11 INFO - Cleaning up... 14:33:11 INFO - Return code: 0 14:33:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:11 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 0x1084eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108461570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff498c8c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082ffd30>, '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 0x108125db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082f7b20>, '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.xF3mEtQ3Yn/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.lvAGmxXgMZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 14:33:11 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 14:33:11 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 14:33:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xF3mEtQ3Yn/Render', 14:33:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:11 INFO - 'HOME': '/Users/cltbld', 14:33:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:11 INFO - 'LOGNAME': 'cltbld', 14:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:11 INFO - 'MOZ_NO_REMOTE': '1', 14:33:11 INFO - 'NO_EM_RESTART': '1', 14:33:11 INFO - 'PAGER': '/bin/cat', 14:33:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:11 INFO - 'PWD': '/builds/slave/test', 14:33:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:11 INFO - 'SHELL': '/bin/bash', 14:33:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvAGmxXgMZ/Listeners', 14:33:11 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 14:33:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:11 INFO - 'USER': 'cltbld', 14:33:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:11 INFO - 'XPC_FLAGS': '0x0', 14:33:11 INFO - 'XPC_SERVICE_NAME': '0', 14:33:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:33:11 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-IcCpgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:33:11 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)) 14:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:33:11 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-W8tL7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 14:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:33:11 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-YsO83u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:33:12 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)) 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:33:12 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-74Z3Hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:33:12 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-tgwoXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:33:12 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)) 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:33:12 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-LSRkCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:33:12 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)) 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:33:12 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-nVIke_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:33:12 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)) 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:33:12 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-zvL0Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:33:12 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)) 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:33:12 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-Dj09Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:33:12 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)) 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:33:12 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-Jx2vwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:33:12 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)) 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:33:12 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-5SLald-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:33:12 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)) 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:33:12 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-OVRKGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:33:12 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-KviiYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:33:13 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)) 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:33:13 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-JaIlCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:13 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-xyHaDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:33:13 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)) 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:33:13 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-0gZP_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:33:13 INFO - Running setup.py (path:/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/pip-a8YEX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:33:13 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)) 14:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:33:13 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)) 14:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:33:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:33:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:33:16 INFO - Downloading blessings-1.6.tar.gz 14:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:33:16 INFO - Installing collected packages: blessings 14:33:16 INFO - Running setup.py install for blessings 14:33:16 INFO - Successfully installed blessings 14:33:16 INFO - Cleaning up... 14:33:16 INFO - Return code: 0 14:33:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:33:16 INFO - Reading from file tmpfile_stdout 14:33:16 INFO - Current package versions: 14:33:16 INFO - blessings == 1.6 14:33:16 INFO - blobuploader == 1.2.4 14:33:16 INFO - docopt == 0.6.1 14:33:16 INFO - functools32 == 3.2.3-2 14:33:16 INFO - jsonschema == 2.5.1 14:33:16 INFO - manifestparser == 1.1 14:33:16 INFO - mozInstall == 1.12 14:33:16 INFO - mozcrash == 0.17 14:33:16 INFO - mozdebug == 0.1 14:33:16 INFO - mozdevice == 0.48 14:33:16 INFO - mozfile == 1.2 14:33:16 INFO - mozhttpd == 0.7 14:33:16 INFO - mozinfo == 0.9 14:33:16 INFO - mozleak == 0.1 14:33:16 INFO - mozlog == 3.4 14:33:16 INFO - moznetwork == 0.27 14:33:16 INFO - mozprocess == 0.23 14:33:16 INFO - mozprofile == 0.28 14:33:16 INFO - mozrunner == 6.12 14:33:16 INFO - mozscreenshot == 0.1 14:33:16 INFO - mozsystemmonitor == 0.3 14:33:16 INFO - moztest == 0.7 14:33:16 INFO - mozversion == 1.4 14:33:16 INFO - psutil == 3.1.1 14:33:16 INFO - requests == 1.2.3 14:33:16 INFO - wsgiref == 0.1.2 14:33:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:16 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 0x1084eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108461570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff498c8c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082ffd30>, '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 0x108125db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082f7b20>, '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.xF3mEtQ3Yn/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.lvAGmxXgMZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 14:33:16 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 14:33:16 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 14:33:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xF3mEtQ3Yn/Render', 14:33:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:16 INFO - 'HOME': '/Users/cltbld', 14:33:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:16 INFO - 'LOGNAME': 'cltbld', 14:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:16 INFO - 'MOZ_NO_REMOTE': '1', 14:33:16 INFO - 'NO_EM_RESTART': '1', 14:33:16 INFO - 'PAGER': '/bin/cat', 14:33:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:16 INFO - 'PWD': '/builds/slave/test', 14:33:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:16 INFO - 'SHELL': '/bin/bash', 14:33:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvAGmxXgMZ/Listeners', 14:33:16 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 14:33:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:16 INFO - 'USER': 'cltbld', 14:33:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:16 INFO - 'XPC_FLAGS': '0x0', 14:33:16 INFO - 'XPC_SERVICE_NAME': '0', 14:33:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:16 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)) 14:33:16 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)) 14:33:16 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)) 14:33:16 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)) 14:33:16 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)) 14:33:16 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)) 14:33:16 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)) 14:33:16 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)) 14:33:16 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)) 14:33:16 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)) 14:33:16 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)) 14:33:16 INFO - Cleaning up... 14:33:16 INFO - Return code: 0 14:33:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:33:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1084eb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108461570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff498c8c8a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082ffd30>, '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 0x108125db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082f7b20>, '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.xF3mEtQ3Yn/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.lvAGmxXgMZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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 14:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:33:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xF3mEtQ3Yn/Render', 14:33:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:17 INFO - 'HOME': '/Users/cltbld', 14:33:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:17 INFO - 'LOGNAME': 'cltbld', 14:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:17 INFO - 'MOZ_NO_REMOTE': '1', 14:33:17 INFO - 'NO_EM_RESTART': '1', 14:33:17 INFO - 'PAGER': '/bin/cat', 14:33:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:17 INFO - 'PWD': '/builds/slave/test', 14:33:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:17 INFO - 'SHELL': '/bin/bash', 14:33:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvAGmxXgMZ/Listeners', 14:33:17 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 14:33:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:17 INFO - 'USER': 'cltbld', 14:33:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:17 INFO - 'XPC_FLAGS': '0x0', 14:33:17 INFO - 'XPC_SERVICE_NAME': '0', 14:33:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:33:17 INFO - Cleaning up... 14:33:17 INFO - Return code: 0 14:33:17 INFO - Running post-action listener: _resource_record_post_action 14:33:17 INFO - Running post-action listener: _start_resource_monitoring 14:33:17 INFO - Starting resource monitoring. 14:33:17 INFO - [mozharness: 2016-10-31 21:33:17.594697Z] Finished create-virtualenv step (success) 14:33:17 INFO - [mozharness: 2016-10-31 21:33:17.595661Z] Running install step. 14:33:17 INFO - Running pre-action listener: _resource_record_pre_action 14:33:17 INFO - Running main action method: install 14:33:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:33:17 INFO - Reading from file tmpfile_stdout 14:33:17 INFO - Detecting whether we're running mozinstall >=1.0... 14:33:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:33:17 INFO - Reading from file tmpfile_stdout 14:33:17 INFO - Output received: 14:33:17 INFO - Usage: mozinstall [options] installer 14:33:17 INFO - Options: 14:33:17 INFO - -h, --help show this help message and exit 14:33:17 INFO - -d DEST, --destination=DEST 14:33:17 INFO - Directory to install application into. [default: 14:33:17 INFO - "/builds/slave/test"] 14:33:17 INFO - --app=APP Application being installed. [default: firefox] 14:33:17 INFO - mkdir: /builds/slave/test/build/application 14:33:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:33:52 INFO - Reading from file tmpfile_stdout 14:33:52 INFO - Output received: 14:33:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:33:52 INFO - Running post-action listener: _resource_record_post_action 14:33:52 INFO - [mozharness: 2016-10-31 21:33:52.884170Z] Finished install step (success) 14:33:52 INFO - [mozharness: 2016-10-31 21:33:52.884297Z] Running run-tests step. 14:33:52 INFO - Running pre-action listener: _resource_record_pre_action 14:33:52 INFO - Running main action method: run_tests 14:33:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:33:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:33:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:33:52 INFO - 2016-10-31 14:33:52.897 screenresolution[1639:7460] starting screenresolution argv=screenresolution get 14:33:52 INFO - 2016-10-31 14:33:52.899 screenresolution[1639:7460] Display 0: 1600x1200x32@60 14:33:52 INFO - 2016-10-31 14:33:52.905 screenresolution[1640:7462] starting screenresolution argv=screenresolution list 14:33:52 INFO - Available Modes on Display 0 14:33:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:33:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:33:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:33:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:33:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:33:53 INFO - Intel Iris: 14:33:53 INFO - Chipset Model: Intel Iris 14:33:53 INFO - Type: GPU 14:33:53 INFO - Bus: Built-In 14:33:53 INFO - VRAM (Dynamic, Max): 1536 MB 14:33:53 INFO - Vendor: Intel (0x8086) 14:33:53 INFO - Device ID: 0x0a2e 14:33:53 INFO - Revision ID: 0x0009 14:33:53 INFO - Displays: 14:33:53 INFO - Display: 14:33:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:33:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:33:53 INFO - Display Serial Number: 1600x1200 60 14:33:53 INFO - Main Display: Yes 14:33:53 INFO - Mirror: Off 14:33:53 INFO - Online: Yes 14:33:53 INFO - Rotation: Supported 14:33:53 INFO - Return code: 0 14:33:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:33:53 INFO - Python 2.7.3 14:33:53 INFO - Return code: 0 14:33:53 INFO - grabbing minidump binary from tooltool 14:33: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')]} 14:33:53 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 0x1082ffd30>, '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 0x108125db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1082f7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:33:53 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 14:33:53 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 14:33:53 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 14:33:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:33:53 INFO - Return code: 0 14:33:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:33:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:33:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:33:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:33:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:33:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0271', '--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 14:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0271 --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 14:33:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xF3mEtQ3Yn/Render', 14:33:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:33:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:33:53 INFO - 'HOME': '/Users/cltbld', 14:33:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:33:53 INFO - 'LOGNAME': 'cltbld', 14:33:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:33:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:33:53 INFO - 'MOZ_NO_REMOTE': '1', 14:33:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:33:53 INFO - 'NO_EM_RESTART': '1', 14:33:53 INFO - 'PAGER': '/bin/cat', 14:33:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:33:53 INFO - 'PWD': '/builds/slave/test', 14:33:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:33:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:33:53 INFO - 'SHELL': '/bin/bash', 14:33:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lvAGmxXgMZ/Listeners', 14:33:53 INFO - 'TMPDIR': '/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/', 14:33:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:33:53 INFO - 'USER': 'cltbld', 14:33:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:33:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:33:53 INFO - 'XPC_FLAGS': '0x0', 14:33:53 INFO - 'XPC_SERVICE_NAME': '0', 14:33:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:33:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0271', '--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 14:33:53 INFO - mozversion application_buildid: 20161031120204 14:33:53 INFO - mozversion application_changeset: 1aa20bcbb80e1014e4d01057f7d52269b0c2d908 14:33:53 INFO - mozversion application_display_name: Nightly 14:33:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:33:53 INFO - mozversion application_name: Firefox 14:33:53 INFO - mozversion application_remotingname: firefox 14:33:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:33:53 INFO - mozversion application_vendor: Mozilla 14:33:53 INFO - mozversion application_version: 52.0a1 14:33:53 INFO - mozversion platform_buildid: 20161031120204 14:33:53 INFO - mozversion platform_changeset: 1aa20bcbb80e1014e4d01057f7d52269b0c2d908 14:33:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:33:53 INFO - mozversion platform_version: 52.0a1 14:33:53 INFO - using testdate: 1477949633 14:33:53 INFO - actual date: 1477949633 14:33:53 INFO - starting webserver on 'localhost:49275' 14:33:53 INFO - SUITE-START | Running 2 tests 14:33:53 INFO - TEST-START | dromaeo_css 14:33:53 INFO - operating with platform_type : mac_ 14:33:53 INFO - Initialising browser for dromaeo_css test... 14:33:53 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpfs3IlJ/profile http://localhost:49275/getInfo.html) 14:33:55 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 14:33:55 INFO - PROCESS | 1650 | colorDepth:24 14:33:55 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 14:33:55 INFO - PROCESS | 1650 | __metrics 14:33:56 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:33:56 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:33:56 INFO - TEST-INFO | 1650: exit 0 14:33:56 INFO - Browser initialized. 14:33:56 INFO - Running cycle 1/1 for dromaeo_css test... 14:33:56 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpfs3IlJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:34:08 INFO - PROCESS | 1652 | RSS: Main: 233152512 14:34:08 INFO - PROCESS | 1652 | 14:35:00 INFO - PROCESS | 1652 | 1477949700569 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:37:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 14:37:15 INFO - PROCESS | 1652 | RSS: Main: 441966592 14:37:15 INFO - PROCESS | 1652 | 14:40:18 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 14:40:19 INFO - PROCESS | 1652 | RSS: Main: 371122176 14:40:19 INFO - PROCESS | 1652 | 14:43:21 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 14:43:22 INFO - PROCESS | 1652 | RSS: Main: 341327872 14:43:22 INFO - PROCESS | 1652 | 14:46:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 14:46:25 INFO - PROCESS | 1652 | RSS: Main: 347045888 14:46:25 INFO - PROCESS | 1652 | 14:49:28 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 14:49:29 INFO - PROCESS | 1652 | RSS: Main: 334589952 14:49:29 INFO - PROCESS | 1652 | 14:52:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 14:52:32 INFO - PROCESS | 1652 | RSS: Main: 559575040 14:52:32 INFO - PROCESS | 1652 | 14:52:32 INFO - PROCESS | 1652 | __start_tp_report 14:52:32 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 14:52:32 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 14:52:32 INFO - PROCESS | 1652 | |i|pagename|runs| 14:52:32 INFO - PROCESS | 1652 | |0;dojo.html;3280.097973057409;3299.45558982768;3313.5526703894975;3328.2844188499466;3353.312570922961;5522.944770552293;5600.215969764231;5617.286727548096;5625.296837895263;5684.971575142124;4881.877168251295;5535.972320138404;5628.746706398211;5677.687727175004;5700.087985922253;5082.983403319333;5127.461616530267;5138.974305128488;5197.1424714922;5203.349581302337;5174.068667639824;5276.3668359796875;5294.973525132369;5304.675888876192;5313.1764576490705;5090.949090509084;5171.224316352577;5266.262723218752;5301.9396120776;5313.654612450197;5190.091733946582;5205.984832957575;5219.73901304937;5219.929914367545;5220.895582088337;5108.923366149511;5143.099957507421;5167;5174.844754657366;5180.093483640386;5625.803096891589;5644.181593668936;5646.2942132233475;5663.2637757091725;5674.177244299594;4930.728809915453;5581.748821303051;6096.298925623566;6100.678570187591;6137.560853825989;6203.627782333075;6273.466755325757;6280.1835761351185;6282;6290.087937249119;5729.713514324267;5740.6268592541355;5741.85645358861;5746.511546518551;5746.9712651436475;6129.370106229187;6238.126662267196;6299.275583307886;6309.274433440213;6329.746810127635;5989.251343582052;5996.5502587305255;6009.2188015557695;6018.187544681499;6020.789272375533;6142.682951206388;6143.082036032938;6150.876982460326;6163.322034576193;6165.506759459233;6029.397060293935;6092.5430592705725;6094.085887116879;6102.084687296941;6107.48086412651;6096.435059713508;6100.581173165739;6102.004547214632;6104.405702081107;6105.800759126419;4719.221328480762;4774.522547745267;4815.109204797123;4836.347093142451;4850.83022094225;4272.508661503967;4274.380214868889;4274.722143060691;4277.165952639206;4378.058717375779;4812.494688057774;5579.972100139474;5675.687837168913;5690.459406356389;5705.001624715658;5999.820005399845;6249.125122482856;6260.217472815898;6272;6275.090111933744;5551.139573366135;5581.246531718166;5610.803621873215;5623.0159722048475;5634.690092044895;5373.2208829719475;5382.596305277119;5385.596080293915;5388.407275199725;5409.215663728737;6293.244810622571;6296.937030629635;6299.590526615755;6305;6312.6212427253595;6074.544409169418;6121.696863452088;6122.794608433986;6127.708789264132;6179.62922224668;4885.022995401005;6166.136740856194;6264.937350626436;6287.056941458635;6315.494760419064;6140;6152.938470615237;6157.0456579230295;6161.322254552086;6175.413335733098;5958.731857066529;6098.855844323493;6127;6249.375062493714;6251.249850018027;5904.734286957183;6047.213862197887;6048.546359023179;6059.121427393092;6071.726772295169;5959.4934430573885;5989.46094851448;6031.065184896348;6034.185384972972;6034.2155519782145;5620.606557541097;5745.511631511201;5771.1920331154515;5834.066549352084;5879.882402352015;5973.641581505123;5986.461218490183;5988.191594134736;5990.9700451497465;5995.310539288038;5811.360750317546;5822.679752613478;5825.155352473952;5827.5629327801435;5835.7373918174635 14:52:32 INFO - PROCESS | 1652 | |1;ext.html;462.78711792575416;487.3299213581326;488.4090250796536;508.5423119192726;515.7885267040514;29478;31256.21859453515;39019.41470877939;40401.19197616046;40530.59469405305;41131;41416;41439.37840932389;41527.58472415275;41598.16803663925;9387.62449502019;9613.90386096137;9621.95189024054;9627.989061148584;9648.517574121266;9491.905080949206;9583.66457173999;9605.231581473501;9625.422474651508;9632.951835240814;9592.520373981308;9626.614935402575;9627.085426884434;9633.855492167622;9644.373115747489;9542.618295268216;9597.136257736836;9626.75933101671;9628.518574071304;9632.566534505964;9385.15533601979;9470.195033422167;9470.668526601605;9478.857817132679;9484.762880927963;38826.805865970775;39126.021849453995;39128.41307380392;39166.60833391658;39242.41136382957;3350.731941444679;3352.195473086466;3422.093145316493;3554.733394995386;3734.7945862977526;29594.556081658793;30226.84886575575;30237.395252094833;30275.0917472474;31015.671493751106;2602.3624212068166;3006.5941097951713;3158.4472717274616;3171.7462602991704;3270.378628060661;410277;479153;481741;482314.9999999965;482347;59856.70071649614;60393.396066039655;60439.39560604426;60448.39551604516;60485;33644.158896027795;34111.488327675106;62865;63108.68445657742;63297.05054424187;15486.986691730002;16128.435504757277;16133.032018078953;16140.273687684083;16178.75731864023;12315.93842030784;12421.565245216554;12457.439415226336;12462.189957652723;12467.875321246853;18499.352522661644;18533;18563.535911602048;18575.213717942148;18615.534611634546;7538.773836784905;7651.693932242648;7676.347510461562;7739.419543534257;7750;863.3869952333788;987.3039507147444;998.2064258914181;1003.7503308381113;1010.3836659637615;23741.643875341884;28706.71293287082;29587.408251834844;29977.400451990838;30306.242343941136;942.7171848445439;1011.4487604255698;1041.7447725307347;1083.2219416802843;1125.921185517006;15034.323455444532;15127.39490420393;15171.317290721943;15486.922565387325;15586.06483610987;625076;631731;639348;639708;639749;55666.721666392215;56196.87606247852;56242.71878640662;56309.15536266959;56350;1200.8378868852767;1233.660743295601;1305.2690493323769;1335.4925128451127;1337.498438085718;29882.954096606514;30599.694003060577;30616;31168.688313116578;31366.686333136375;47748;48446.51553484561;48465.75767121142;48483.5151648479;48522.51477485321;521995;524629;526309;526317;620766;21885;23400;25915.352116197246;25921.740782592686;26841;44806.55193448024;45358.77320613376;45484.545154549356;46360;47576;38221.61778382181;38313.80843095878;38742.80628596839;39577;39908.401373978835;37248.44127338146;37615.62384376121;37838.810805945795;38850.61149388583;38902.610973889896;34262;34969.82515087408;35187.472187917716;35231.82384088063;35238.82380588183;31707;33468.33063338768;34336;34461.310773784884;34608.134796630286;21671.674924876454;24274.635880461454;24393.756062439148;25124.371890702878;25543.489130217662 14:52:32 INFO - PROCESS | 1652 | |2;jquery.html;369.7688944409744;372.53247174795644;376.31886285822657;387.88557375574203;402.59338068550755;15501.302441390137;15501.689966200669;18460.261589536418;20843.895780521114;21043.894780526094;17973.7303940441;19651.901740491277;20446.18215271391;20546.69179962302;20707.482312942186;5372.2210279509445;5836.941630583682;5909.231799866011;5917.615355001911;5924.407559244062;5726.255586773714;5817.447342502455;5856.590038697293;5918.88162236755;5933.6439813611105;6042.546808989321;6135;6139.324674285825;6142.662153581551;6144.201253837017;6134.478569321613;6139.324674285847;6180.721867515973;6674.566153200027;6756.797296081126;5834.241548598655;5929.407059294036;5941.613795103304;5944.791932282393;5960.0761881908375;17076.743848842278;19775.802241977683;24425.633615495783;24454.87772561126;24621.261362159163;2107.557412943284;2199.7360316761933;2226.855254408458;2315.7452680205165;2489.4149874779414;9733.2213422926;11056.668299951014;13408;14756.557303280919;15396.384144634201;1860.2651952478695;1920.805402576693;1926.9421917342502;1944.0959953621634;1964.9508762280914;109509;115300.42349788197;115984;116181.41909290483;116240;8539.658413663385;10987.835182472269;11313.208075434804;11413.771724565628;11487;12519.561815336601;14280.214588197749;14282.714345713235;14291.428342866377;14333.283335833166;6664.233613134455;7409.518381305198;8167.550784706779;8206.384521160937;8357.874631880526;6463.4506066983895;8249.257566819015;8255.463394879314;8365.205305495969;8432.367572432093;3874.818180454988;3961.5840336764227;4352.978235108868;4479.350494178326;4558.1795276849825;1781.741647461111;1791.5968906996081;1835.3943198744382;1881.5484283771796;1923.278770461077;818.4025661267308;835.7701632051113;871.9825603487894;874.8425283448913;959;19467.513312167026;20234.392968210977;20286.594268114553;20289.28987485431;20678;811.2860682599393;829.9460535065201;854.4531499840107;888.8977767556813;924.8057907839294;7804.297613214724;8009.519428834288;10403.58385664565;10903.781924361627;10948.562057517769;523272;552559;556284;556932;571666;95172;131013;131036.3448182753;135419.32290338486;138992;1006.0894890124449;1065.541817018674;1083.0360978728938;1084.4957094950885;1086.4296244471557;17695.911520442314;17895.73156402681;18049.819501804814;18082.547936301697;18474.353397631017;51778.96442071213;51965.80341965773;52557.47442525679;52727.73636131795;54123.72938135284;75657;77564;78920.21079789128;80426;81110.59444702738;6878.312168783082;7806.531608103532;7850.704633735598;7856.921430785847;8086.83826323482;10114.409384668632;12296.262224266573;12669.303188324731;12840.871591283967;12848.807267891176;10643;10732.73168170802;11068.889311107108;11182.32906025641;11240.156988225752;10340.27618066728;10678.786424271626;10883.782324353628;11213.719657008314;11221.887781122085;10880.564777409132;11065.059469945145;11619.419029048682;11668;11682.591109311134;7993.280604745601;8004.879926800986;8107.581173294532;8182.7954301142945;8191.959040204999;9519.857202141835;11217.66347009591;11290.7741845161;11322.094232461548;11324.6036388726 14:52:32 INFO - PROCESS | 1652 | |3;mootools.html;1299.512682743971;1453.7746649269363;1470.2281302316283;1617;1812.2660322569357;7419.925800741991;7659.846803063942;8102.878456823152;8327.667573188291;8334.499930004189;8193.754187374374;8270;8283.95858020709;8289.83420331593;8307.792305192374;2268.1947908492493;2298.4139044543617;2300.5053913408615;2303.021215983209;2303.873286969216;2276.84062115652;2316.270374831931;2334.4747431827873;2334.8482348647367;2339.602267614501;2245.494763678176;2271.7955384015436;2304.4238940264936;2313.201945328867;2317.316391664463;2252.3693365857584;2266.546690661866;2289.5420915816903;2291.564602725485;2305.1470955746313;1930.5463216144194;2305.8501197422283;2306.4810417656063;2307.0541078158044;2315.513742114158;8077.636506357228;8291.08798032216;8306.875396869053;8317.168283171695;8322.750317490425;5015.172496538067;5185.844424667228;5196.324477817897;5225.294585230983;5226.320578324831;3402.9489557656657;3473.808940508271;3529.858805647771;3610.5667319921777;3612.187257866985;1045.1951996962296;1088.1294964028825;1710.9657806843918;1757.929682812686;1827.0955876841049;10773.5690572377;10866.076383507332;10876.564937402416;10880.67357979262;10912.399818010006;4530.79611417487;4681.531846815291;4716.268978308368;4731.361266229015;4735.408073990751;8533.44532605391;8587.742367728979;8601.182887625666;8610.354223433142;8612.354073444392;4975.0796102721115;5055.595552355876;5059.645824792229;5069.569086627678;5081.060003899291;4061.2080644274674;4605.861824145281;4737.739424331695;4740.1230772307235;4760.309755085563;3481.3385456763135;3578.8031658258524;3581.230035542371;3618.4029635109914;3665.17533554948;968.3802366485455;1108.957579874915;1115.5705053554277;1117.234694234452;1127.1827924754487;751.6467260387609;832.1636755061246;849.8555245608261;897.7531178925717;944.414463032924;5289.3917199521775;5323.840284791385;5337.599680024014;5460.798624302647;5582.33012038558;423.83258612847754;431.0323324137332;435.9825606975749;961.4519723757531;1010.8685870836745;3597.334493118781;3789.734718569729;3851.1527463957887;3873.2253549290253;3889.669378102836;8586.957065214634;9665.855012174823;10166;10172.847407288897;10188.184945204366;7472.775816725507;9129.680461183827;9581.425114493153;9900.455474948947;10123.544440500047;7541.283578060075;7859.685612575548;7882.684692612346;7885.802854928673;7914.525128492309;4974.950250497449;5135.841457503683;5256.658317209369;5768.625039372428;5945.583809133319;8370.372222083246;9289.16397524226;9292.303077269096;9403;9413.199878010446;9072.90927090747;9280.62877484893;9375.278319297806;9473.810523789623;9497.43015419077;6843.452523797984;7446.329830315081;7690.115636701851;7771;7840.960795196215;7864.21357864209;8016.759497215093;8022.679092836222;8024.679012839421;8029.4379393441895;6966.895496567454;7116;7133.17968433616;7197.784066478014;7250.564966102051;7005.859882802417;7039.260877607778;7046.2249152594195;7053.4004609608755;7184.6048467334795;6603.702833372606;6620.536562440583;6684.565503242274;6691.230508491586;6702.698378572878;4729.219678752967;4789.928151077806;4795.808167673394;4835.975820121018;4926.778294976663;4651.139539185261;4828;4847.321375007572;4886.657933944732;4935.98812243482 14:52:32 INFO - PROCESS | 1652 | |4;prototype.html;277.1836940211078;297.3339719029372;305.86083332083905;309.4013084681142;312.578019673441;5086.923696144556;5092.9373603690565;5103.387593488782;5110.361204849394;5158.638895277332;4177.7493350399;4774.331593576902;4915.70505769654;4928.3593132892765;5079.339685840845;3429.8113603751785;3613.7713177519636;3905;3906.1211227473877;3979.064919743858;3927.9410808837893;3941.5219292765214;3942.1918506706056;3944.7435916665327;3963.0884896473826;3216.8874089406877;3659.7309668005873;3826.215625796705;3863.884083477486;3921.470601468808;3072.523758817387;3481.5125882376487;3602.4056030755023;3853.460515527828;3913.5303763548413;2910.122970683918;2931.7654587632937;3333.3000069985333;3339.8664053437833;3343.916402089943;3934.665553427962;4912.459629440758;4923.347436672346;4929.580985616227;4947.282644016634;3336.4995250712345;4386.363977223285;4405.537418571068;4450.35469856869;4463.33050042493;5323.467653234684;5350.785968561253;5350.866228344323;5361.51746342831;5375.973120134413;3373.6289008209324;3660.194757153449;3669.43123815809;3672.3022625701033;3693.4829123922673;4721.347528365079;4976.377952755905;5153;5615.354234263071;5626.521745651625;3704.499677630564;3708.2212735325884;3716.7398282120535;3720.479132921393;3733.533308336458;3604.819759012039;3727.589965103836;3747.9063023424087;3759.586445490994;3779.4141908004303;4107.856225032109;4122.320491680432;4122.42286079949;4157.417961485395;4377.802998865059;5164.354455693038;5175.146100893386;5377.897531006134;5394.595405344615;5435.592330575223;1097.8023955687893;1157.7322831499494;1200.5017917564287;1268.65112094173;1283.8716128387086;788.8974433323631;832.493187330933;833.7832163637498;851.638053827121;869.6434461870602;5021.472745361684;5029.723365214948;5043.218301163325;5059.19052951526;5102.719350435762;4862.610991120702;5439.972800135974;5452.972735136378;5463.836084917459;5512.39363670004;3992.043898489719;4016.658584020391;4420.425344705168;5027.547520723152;5132.846014619493;2849.886004559836;2869.497837878363;2881.3516958684127;2890.4102743490994;2891.8120322178993;5140.434552199255;5196.714180720097;5661.575381846295;5704.686242256633;5704.942950570524;5172.637915345889;5550.7233336332865;5567.721613919288;5586.91619625706;5599.524040456607;5382.327209098784;5610.298712660918;5633.211350410946;5653.519450846724;5674.460926212003;4992.72540010303;5158.793648254028;5444.754986025559;5481.369642491165;5484.780608775604;4337.7397356158735;5239.4850471773;5255.817441075727;5366.1145910925825;5435.402105768283;5190.584753219809;5618.494335509824;5630.887382252414;5646.322441307069;5659.2456338535185;2961.452131355706;3283.8670658622736;3688.3914154165336;3702.500162478031;3705.870294539678;4595.80591488912;5539.307586551681;5548.750306236309;5552.222688823649;5567.216391804098;5389.353277606712;5403.5136837684795;5404.2163886235485;5408.405075441777;5410.918836217381;4419.602235798665;5098.847034588968;5377.758000890048;5383.7846486140115;5386.4110087523495;4150.896227594213;5259.763310651107;5266.289050978069;5269.394019687785;5297;4822.903541929212;4845.515448455127;5134.691918484903;5320.866978325573;5386.919196211981;4633.814647414066;4881.755912204447;5162;5205.349331333583;5296.867578310573 14:52:32 INFO - PROCESS | 1652 | |5;yui.html;704.3942209699658;724.612332402165;755.0976582983334;790.3361176611645;800.487687879757;15175.848241517582;15381.92309038456;15394.615134621612;15406.07563546188;15418.845811541882;13144.408501617427;13163;13200.339983000835;13220.933895330534;13250.536231231908;661.6129564204946;679.8096532970776;815.3355015662216;822.5147163173726;841.9326453883674;826.6982551368737;832.7834762961643;839.08539691736;839.630562552478;846.1707526623912;889.9911000890005;890.0698769785589;892.2861710631502;892.7277180459957;893.7050773244814;688.5627626457235;883.7127933421632;883.7392969074107;884.2174675412307;885.3979294080023;409.91801639672184;520.0015969338879;523.1655509462402;524.2503220394834;532.3000254665103;13768.586942391745;14300.070495417765;14302.141871487744;14511.274436278143;14523.636909077251;13787.51743688966;13981.930090349482;14037.64905877351;14085.154890706488;14091.647708807259;11319.377434241114;11400.942995285053;11590.652280431601;11719.179657423983;11945.880541194563;3689.0961714379882;3716.2381711749026;3724.683401910841;3742.6070262622306;3897.9220415591813;58620.41379586235;78688;83010.99999999939;83175.58412207961;83316;10560.419176945341;10874.61938832153;10920.344779313267;10968.890311096946;11176.552937882394;19192.424227272924;20248.190072396937;21586.460338491663;21737.23919662804;21750.34748957534;6864.5881247125335;7630.694772209161;7960.960195198987;7988.360931125496;8063.6774529018185;4172.937405938914;4342.544032876503;4363.781810909505;4475.418195634612;4480.484744254452;3398.796072235674;3537.8054207018863;3543.1496440854526;3544.680978711877;3550.6981906538235;610.8747706720112;619.5136817598163;635.1584150999944;646.1761254400677;646.7089809585706;559.7816851427865;580.3760956971273;656.5457511611803;679.9388055074968;700.8247938015496;8331.583420828934;9058.54707264634;9108.954455227682;9225.953870230605;9263.490508022123;526.8287806462915;613.7146227004464;655.8424380967596;682.2290811383106;683.5147045597582;4211.936820947688;4319.589638984291;4481.439820022497;4532.7280363178315;4547.567981041796;96476.51761741287;98801;100561.49719251358;103433;104978;89639;89720.5513972426;91543;96291;96686;60033;66745.66627166833;80891.67516547687;81767.591162045;83834;8502.74491765248;9498.620055197714;9501.619935202514;9540.809183816424;9677;49460;52723.209151861985;53062.204066938255;55724.72137639286;56420.84424803575;70331.64834175796;70781;71160.28839711536;72020.27979720135;72238.27761722526;10652.680419587425;11499.367534785333;11982.700432489257;12446.439910204244;12572.245665259748;13950.930245348709;14078.577642670736;14282.928585357007;14362.784558231844;14784.852151478777;12723.55467558631;12934.288614126313;12996.675083122998;13725.656858578615;13740.381682824496;12864.356782160667;13015.739685206432;13040.673983150496;13156.671083222996;13165;10764.677059688222;12863.45453459905;13118.934405327913;13328.733425331633;13371.130876493386;10470.947645261725;10556.155507559222;10700.090492308242;10801;11127.221094523306;7663.31030207284;9736.513174341397;10178;11157.66527004191;11422.714432139262 14:52:32 INFO - PROCESS | 1652 | __end_tp_report 14:52:32 INFO - PROCESS | 1652 | __start_cc_report 14:52:32 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2033 14:52:32 INFO - PROCESS | 1652 | __end_cc_report 14:52:32 INFO - PROCESS | 1652 | __startTimestamp1477950752925__endTimestamp 14:52:32 INFO - PROCESS | 1652 | 14:52:32 INFO - PROCESS | 1652 | ------- Summary: start ------- 14:52:32 INFO - PROCESS | 1652 | Number of tests: 6 14:52:32 INFO - PROCESS | 1652 | 14:52:32 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5653.69 Median:5822.68 stddev:641.38 (11.0%) stddev-sans-first:615.73 14:52:32 INFO - PROCESS | 1652 | Values: 3280.1 3299.5 3313.6 3328.3 3353.3 5522.9 5600.2 5617.3 5625.3 5685.0 4881.9 5536.0 5628.7 5677.7 5700.1 5083.0 5127.5 5139.0 5197.1 5203.3 5174.1 5276.4 5295.0 5304.7 5313.2 5090.9 5171.2 5266.3 5301.9 5313.7 5190.1 5206.0 5219.7 5219.9 5220.9 5108.9 5143.1 5167.0 5174.8 5180.1 5625.8 5644.2 5646.3 5663.3 5674.2 4930.7 5581.7 6096.3 6100.7 6137.6 6203.6 6273.5 6280.2 6282.0 6290.1 5729.7 5740.6 5741.9 5746.5 5747.0 6129.4 6238.1 6299.3 6309.3 6329.7 5989.3 5996.6 6009.2 6018.2 6020.8 6142.7 6143.1 6150.9 6163.3 6165.5 6029.4 6092.5 6094.1 6102.1 6107.5 6096.4 6100.6 6102.0 6104.4 6105.8 4719.2 4774.5 4815.1 4836.3 4850.8 4272.5 4274.4 4274.7 4277.2 4378.1 4812.5 5580.0 5675.7 5690.5 5705.0 5999.8 6249.1 6260.2 6272.0 6275.1 5551.1 5581.2 5610.8 5623.0 5634.7 5373.2 5382.6 5385.6 5388.4 5409.2 6293.2 6296.9 6299.6 6305.0 6312.6 6074.5 6121.7 6122.8 6127.7 6179.6 4885.0 6166.1 6264.9 6287.1 6315.5 6140.0 6152.9 6157.0 6161.3 6175.4 5958.7 6098.9 6127.0 6249.4 6251.2 5904.7 6047.2 6048.5 6059.1 6071.7 5959.5 5989.5 6031.1 6034.2 6034.2 5620.6 5745.5 5771.2 5834.1 5879.9 5973.6 5986.5 5988.2 5991.0 5995.3 5811.4 5822.7 5825.2 5827.6 5835.7 14:52:32 INFO - PROCESS | 1652 | 14:52:32 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:67705.39 Median:39127.22 stddev:148009.45 (378.3%) stddev-sans-first:148338.55 14:52:32 INFO - PROCESS | 1652 | Values: 462.8 487.3 488.4 508.5 515.8 29478.0 31256.2 39019.4 40401.2 40530.6 41131.0 41416.0 41439.4 41527.6 41598.2 9387.6 9613.9 9622.0 9628.0 9648.5 9491.9 9583.7 9605.2 9625.4 9633.0 9592.5 9626.6 9627.1 9633.9 9644.4 9542.6 9597.1 9626.8 9628.5 9632.6 9385.2 9470.2 9470.7 9478.9 9484.8 38826.8 39126.0 39128.4 39166.6 39242.4 3350.7 3352.2 3422.1 3554.7 3734.8 29594.6 30226.8 30237.4 30275.1 31015.7 2602.4 3006.6 3158.4 3171.7 3270.4 410277.0 479153.0 481741.0 482315.0 482347.0 59856.7 60393.4 60439.4 60448.4 60485.0 33644.2 34111.5 62865.0 63108.7 63297.1 15487.0 16128.4 16133.0 16140.3 16178.8 12315.9 12421.6 12457.4 12462.2 12467.9 18499.4 18533.0 18563.5 18575.2 18615.5 7538.8 7651.7 7676.3 7739.4 7750.0 863.4 987.3 998.2 1003.8 1010.4 23741.6 28706.7 29587.4 29977.4 30306.2 942.7 1011.4 1041.7 1083.2 1125.9 15034.3 15127.4 15171.3 15486.9 15586.1 625076.0 631731.0 639348.0 639708.0 639749.0 55666.7 56196.9 56242.7 56309.2 56350.0 1200.8 1233.7 1305.3 1335.5 1337.5 29883.0 30599.7 30616.0 31168.7 31366.7 47748.0 48446.5 48465.8 48483.5 48522.5 521995.0 524629.0 526309.0 526317.0 620766.0 21885.0 23400.0 25915.4 25921.7 26841.0 44806.6 45358.8 45484.5 46360.0 47576.0 38221.6 38313.8 38742.8 39577.0 39908.4 37248.4 37615.6 37838.8 38850.6 38902.6 34262.0 34969.8 35187.5 35231.8 35238.8 31707.0 33468.3 34336.0 34461.3 34608.1 21671.7 24274.6 24393.8 25124.4 25543.5 14:52:32 INFO - PROCESS | 1652 | 14:52:32 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:33373.10 Median:24440.26 stddev:92602.53 (378.9%) stddev-sans-first:92829.15 14:52:32 INFO - PROCESS | 1652 | Values: 369.8 372.5 376.3 387.9 402.6 15501.3 15501.7 18460.3 20843.9 21043.9 17973.7 19651.9 20446.2 20546.7 20707.5 5372.2 5836.9 5909.2 5917.6 5924.4 5726.3 5817.4 5856.6 5918.9 5933.6 6042.5 6135.0 6139.3 6142.7 6144.2 6134.5 6139.3 6180.7 6674.6 6756.8 5834.2 5929.4 5941.6 5944.8 5960.1 17076.7 19775.8 24425.6 24454.9 24621.3 2107.6 2199.7 2226.9 2315.7 2489.4 9733.2 11056.7 13408.0 14756.6 15396.4 1860.3 1920.8 1926.9 1944.1 1965.0 109509.0 115300.4 115984.0 116181.4 116240.0 8539.7 10987.8 11313.2 11413.8 11487.0 12519.6 14280.2 14282.7 14291.4 14333.3 6664.2 7409.5 8167.6 8206.4 8357.9 6463.5 8249.3 8255.5 8365.2 8432.4 3874.8 3961.6 4353.0 4479.4 4558.2 1781.7 1791.6 1835.4 1881.5 1923.3 818.4 835.8 872.0 874.8 959.0 19467.5 20234.4 20286.6 20289.3 20678.0 811.3 829.9 854.5 888.9 924.8 7804.3 8009.5 10403.6 10903.8 10948.6 523272.0 552559.0 556284.0 556932.0 571666.0 95172.0 131013.0 131036.3 135419.3 138992.0 1006.1 1065.5 1083.0 1084.5 1086.4 17695.9 17895.7 18049.8 18082.5 18474.4 51779.0 51965.8 52557.5 52727.7 54123.7 75657.0 77564.0 78920.2 80426.0 81110.6 6878.3 7806.5 7850.7 7856.9 8086.8 10114.4 12296.3 12669.3 12840.9 12848.8 10643.0 10732.7 11068.9 11182.3 11240.2 10340.3 10678.8 10883.8 11213.7 11221.9 10880.6 11065.1 11619.4 11668.0 11682.6 7993.3 8004.9 8107.6 8182.8 8192.0 9519.9 11217.7 11290.8 11322.1 11324.6 14:52:32 INFO - PROCESS | 1652 | 14:52:32 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5375.29 Median:5057.62 stddev:2919.31 (57.7%) stddev-sans-first:2911.43 14:52:32 INFO - PROCESS | 1652 | Values: 1299.5 1453.8 1470.2 1617.0 1812.3 7419.9 7659.8 8102.9 8327.7 8334.5 8193.8 8270.0 8284.0 8289.8 8307.8 2268.2 2298.4 2300.5 2303.0 2303.9 2276.8 2316.3 2334.5 2334.8 2339.6 2245.5 2271.8 2304.4 2313.2 2317.3 2252.4 2266.5 2289.5 2291.6 2305.1 1930.5 2305.9 2306.5 2307.1 2315.5 8077.6 8291.1 8306.9 8317.2 8322.8 5015.2 5185.8 5196.3 5225.3 5226.3 3402.9 3473.8 3529.9 3610.6 3612.2 1045.2 1088.1 1711.0 1757.9 1827.1 10773.6 10866.1 10876.6 10880.7 10912.4 4530.8 4681.5 4716.3 4731.4 4735.4 8533.4 8587.7 8601.2 8610.4 8612.4 4975.1 5055.6 5059.6 5069.6 5081.1 4061.2 4605.9 4737.7 4740.1 4760.3 3481.3 3578.8 3581.2 3618.4 3665.2 968.4 1109.0 1115.6 1117.2 1127.2 751.6 832.2 849.9 897.8 944.4 5289.4 5323.8 5337.6 5460.8 5582.3 423.8 431.0 436.0 961.5 1010.9 3597.3 3789.7 3851.2 3873.2 3889.7 8587.0 9665.9 10166.0 10172.8 10188.2 7472.8 9129.7 9581.4 9900.5 10123.5 7541.3 7859.7 7882.7 7885.8 7914.5 4975.0 5135.8 5256.7 5768.6 5945.6 8370.4 9289.2 9292.3 9403.0 9413.2 9072.9 9280.6 9375.3 9473.8 9497.4 6843.5 7446.3 7690.1 7771.0 7841.0 7864.2 8016.8 8022.7 8024.7 8029.4 6966.9 7116.0 7133.2 7197.8 7250.6 7005.9 7039.3 7046.2 7053.4 7184.6 6603.7 6620.5 6684.6 6691.2 6702.7 4729.2 4789.9 4795.8 4836.0 4926.8 4651.1 4828.0 4847.3 4886.7 4936.0 14:52:32 INFO - PROCESS | 1652 | 14:52:32 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4314.98 Median:4938.43 stddev:1342.38 (27.2%) stddev-sans-first:1311.49 14:52:32 INFO - PROCESS | 1652 | Values: 277.2 297.3 305.9 309.4 312.6 5086.9 5092.9 5103.4 5110.4 5158.6 4177.7 4774.3 4915.7 4928.4 5079.3 3429.8 3613.8 3905.0 3906.1 3979.1 3927.9 3941.5 3942.2 3944.7 3963.1 3216.9 3659.7 3826.2 3863.9 3921.5 3072.5 3481.5 3602.4 3853.5 3913.5 2910.1 2931.8 3333.3 3339.9 3343.9 3934.7 4912.5 4923.3 4929.6 4947.3 3336.5 4386.4 4405.5 4450.4 4463.3 5323.5 5350.8 5350.9 5361.5 5376.0 3373.6 3660.2 3669.4 3672.3 3693.5 4721.3 4976.4 5153.0 5615.4 5626.5 3704.5 3708.2 3716.7 3720.5 3733.5 3604.8 3727.6 3747.9 3759.6 3779.4 4107.9 4122.3 4122.4 4157.4 4377.8 5164.4 5175.1 5377.9 5394.6 5435.6 1097.8 1157.7 1200.5 1268.7 1283.9 788.9 832.5 833.8 851.6 869.6 5021.5 5029.7 5043.2 5059.2 5102.7 4862.6 5440.0 5453.0 5463.8 5512.4 3992.0 4016.7 4420.4 5027.5 5132.8 2849.9 2869.5 2881.4 2890.4 2891.8 5140.4 5196.7 5661.6 5704.7 5704.9 5172.6 5550.7 5567.7 5586.9 5599.5 5382.3 5610.3 5633.2 5653.5 5674.5 4992.7 5158.8 5444.8 5481.4 5484.8 4337.7 5239.5 5255.8 5366.1 5435.4 5190.6 5618.5 5630.9 5646.3 5659.2 2961.5 3283.9 3688.4 3702.5 3705.9 4595.8 5539.3 5548.8 5552.2 5567.2 5389.4 5403.5 5404.2 5408.4 5410.9 4419.6 5098.8 5377.8 5383.8 5386.4 4150.9 5259.8 5266.3 5269.4 5297.0 4822.9 4845.5 5134.7 5320.9 5386.9 4633.8 4881.8 5162.0 5205.3 5296.9 14:52:32 INFO - PROCESS | 1652 | 14:52:32 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:19585.97 Median:4540.15 stddev:27738.99 (611.0%) stddev-sans-first:27780.57 14:52:32 INFO - PROCESS | 1652 | Values: 704.4 724.6 755.1 790.3 800.5 15175.8 15381.9 15394.6 15406.1 15418.8 13144.4 13163.0 13200.3 13220.9 13250.5 661.6 679.8 815.3 822.5 841.9 826.7 832.8 839.1 839.6 846.2 890.0 890.1 892.3 892.7 893.7 688.6 883.7 883.7 884.2 885.4 409.9 520.0 523.2 524.3 532.3 13768.6 14300.1 14302.1 14511.3 14523.6 13787.5 13981.9 14037.6 14085.2 14091.6 11319.4 11400.9 11590.7 11719.2 11945.9 3689.1 3716.2 3724.7 3742.6 3897.9 58620.4 78688.0 83011.0 83175.6 83316.0 10560.4 10874.6 10920.3 10968.9 11176.6 19192.4 20248.2 21586.5 21737.2 21750.3 6864.6 7630.7 7961.0 7988.4 8063.7 4172.9 4342.5 4363.8 4475.4 4480.5 3398.8 3537.8 3543.1 3544.7 3550.7 610.9 619.5 635.2 646.2 646.7 559.8 580.4 656.5 679.9 700.8 8331.6 9058.5 9109.0 9226.0 9263.5 526.8 613.7 655.8 682.2 683.5 4211.9 4319.6 4481.4 4532.7 4547.6 96476.5 98801.0 100561.5 103433.0 104978.0 89639.0 89720.6 91543.0 96291.0 96686.0 60033.0 66745.7 80891.7 81767.6 83834.0 8502.7 9498.6 9501.6 9540.8 9677.0 49460.0 52723.2 53062.2 55724.7 56420.8 70331.6 70781.0 71160.3 72020.3 72238.3 10652.7 11499.4 11982.7 12446.4 12572.2 13950.9 14078.6 14282.9 14362.8 14784.9 12723.6 12934.3 12996.7 13725.7 13740.4 12864.4 13015.7 13040.7 13156.7 13165.0 10764.7 12863.5 13118.9 13328.7 13371.1 10470.9 10556.2 10700.1 10801.0 11127.2 7663.3 9736.5 10178.0 11157.7 11422.7 14:52:32 INFO - PROCESS | 1652 | -------- Summary: end -------- 14:52:32 INFO - PROCESS | 1652 | 14:52:33 INFO - TEST-INFO | 1652: exit 0 14:52:33 INFO - TEST-OK | dromaeo_css | took 1120093ms 14:52:33 INFO - TEST-START | kraken 14:52:33 INFO - operating with platform_type : mac_ 14:52:33 INFO - Initialising browser for kraken test... 14:52:33 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpnrTIQw/profile http://localhost:49275/getInfo.html) 14:52:36 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 14:52:36 INFO - PROCESS | 1664 | colorDepth:24 14:52:36 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 14:52:36 INFO - PROCESS | 1664 | __metrics 14:52:36 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:52:36 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:52:36 INFO - TEST-INFO | 1664: exit 0 14:52:36 INFO - Browser initialized. 14:52:36 INFO - Running cycle 1/1 for kraken test... 14:52:36 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/T/tmpnrTIQw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:52:49 INFO - PROCESS | 1665 | RSS: Main: 241586176 14:52:49 INFO - PROCESS | 1665 | 14:52:51 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 14:52:52 INFO - PROCESS | 1665 | RSS: Main: 292810752 14:52:52 INFO - PROCESS | 1665 | 14:52:55 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 14:52:55 INFO - PROCESS | 1665 | RSS: Main: 294211584 14:52:55 INFO - PROCESS | 1665 | 14:52:59 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 14:53:00 INFO - PROCESS | 1665 | RSS: Main: 386822144 14:53:00 INFO - PROCESS | 1665 | 14:53:02 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 14:53:02 INFO - PROCESS | 1665 | RSS: Main: 287694848 14:53:02 INFO - PROCESS | 1665 | 14:53:04 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:53:05 INFO - PROCESS | 1665 | RSS: Main: 292151296 14:53:05 INFO - PROCESS | 1665 | 14:53:08 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 14:53:08 INFO - PROCESS | 1665 | RSS: Main: 329510912 14:53:08 INFO - PROCESS | 1665 | 14:53:11 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 14:53:12 INFO - PROCESS | 1665 | RSS: Main: 331202560 14:53:12 INFO - PROCESS | 1665 | 14:53:14 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 14:53:15 INFO - PROCESS | 1665 | RSS: Main: 327512064 14:53:15 INFO - PROCESS | 1665 | 14:53:17 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:53:17 INFO - PROCESS | 1665 | RSS: Main: 305381376 14:53:17 INFO - PROCESS | 1665 | 14:53:19 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:53:20 INFO - PROCESS | 1665 | RSS: Main: 307671040 14:53:20 INFO - PROCESS | 1665 | 14:53:22 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:53:22 INFO - PROCESS | 1665 | RSS: Main: 310140928 14:53:22 INFO - PROCESS | 1665 | 14:53:25 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:53:26 INFO - PROCESS | 1665 | RSS: Main: 318648320 14:53:26 INFO - PROCESS | 1665 | 14:53:29 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:53:30 INFO - PROCESS | 1665 | RSS: Main: 318377984 14:53:30 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 14:53:32 INFO - PROCESS | 1665 | RSS: Main: 362180608 14:53:32 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | __start_tp_report 14:53:32 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 14:53:32 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 14:53:32 INFO - PROCESS | 1665 | |i|pagename|runs| 14:53:32 INFO - PROCESS | 1665 | |0;ai-astar;114;114;114;114;114;113;114;113;114;113 14:53:32 INFO - PROCESS | 1665 | |1;audio-beat-detection;168;142;142;149;114;107;112;102;163;100 14:53:32 INFO - PROCESS | 1665 | |2;audio-dft;198;264;197;183;182;181;182;180;181;183 14:53:32 INFO - PROCESS | 1665 | |3;audio-fft;80;60;59;87;61;60;58;58;82;60 14:53:32 INFO - PROCESS | 1665 | |4;audio-oscillator;88;72;91;70;70;69;93;69;70;90 14:53:32 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;90;87;91;87;90;86;91;89;90;87 14:53:32 INFO - PROCESS | 1665 | |6;imaging-darkroom;94;94;93;94;94;95;95;95;94;93 14:53:32 INFO - PROCESS | 1665 | |7;imaging-desaturate;82;83;79;77;83;84;83;86;79;80 14:53:32 INFO - PROCESS | 1665 | |8;json-parse-financial;58;54;54;54;54;57;56;55;55;55 14:53:32 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;66;73;64;74;71;68;69;70;69;72 14:53:32 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;86;89;87;86;86;88;88;86;86;84 14:53:32 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;154;153;146;145;144;146;147;146;185;157 14:53:32 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;171;172;173;173;173;174;173;174;174;175 14:53:32 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;67;67;67;67;65;67;67;67;65;67 14:53:32 INFO - PROCESS | 1665 | __end_tp_report 14:53:32 INFO - PROCESS | 1665 | __start_cc_report 14:53:32 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,2135 14:53:32 INFO - PROCESS | 1665 | __end_cc_report 14:53:32 INFO - PROCESS | 1665 | __startTimestamp1477950812347__endTimestamp 14:53:32 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | ------- Summary: start ------- 14:53:32 INFO - PROCESS | 1665 | Number of tests: 14 14:53:32 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:53:32 INFO - PROCESS | 1665 | Values: 114.0 114.0 114.0 114.0 114.0 113.0 114.0 113.0 114.0 113.0 14:53:32 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:129.90 Median:142.00 stddev:25.77 (18.1%) stddev-sans-first:23.35 14:53:32 INFO - PROCESS | 1665 | Values: 168.0 142.0 142.0 149.0 114.0 107.0 112.0 102.0 163.0 100.0 14:53:32 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:193.10 Median:183.00 stddev:25.78 (14.1%) stddev-sans-first:27.28 14:53:32 INFO - PROCESS | 1665 | Values: 198.0 264.0 197.0 183.0 182.0 181.0 182.0 180.0 181.0 183.0 14:53:32 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:66.50 Median:60.50 stddev:11.55 (19.1%) stddev-sans-first:11.17 14:53:32 INFO - PROCESS | 1665 | Values: 80.0 60.0 59.0 87.0 61.0 60.0 58.0 58.0 82.0 60.0 14:53:32 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:80.00 stddev:10.69 (13.4%) stddev-sans-first:10.73 14:53:32 INFO - PROCESS | 1665 | Values: 88.0 72.0 91.0 70.0 70.0 69.0 93.0 69.0 70.0 90.0 14:53:32 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:90.00 stddev:1.87 (2.1%) stddev-sans-first:1.94 14:53:32 INFO - PROCESS | 1665 | Values: 90.0 87.0 91.0 87.0 90.0 86.0 91.0 89.0 90.0 87.0 14:53:32 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 14:53:32 INFO - PROCESS | 1665 | Values: 94.0 94.0 93.0 94.0 94.0 95.0 95.0 95.0 94.0 93.0 14:53:32 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:81.60 Median:83.00 stddev:2.76 (3.3%) stddev-sans-first:2.92 14:53:32 INFO - PROCESS | 1665 | Values: 82.0 83.0 79.0 77.0 83.0 84.0 83.0 86.0 79.0 80.0 14:53:32 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:1.40 (2.5%) stddev-sans-first:1.05 14:53:32 INFO - PROCESS | 1665 | Values: 58.0 54.0 54.0 54.0 54.0 57.0 56.0 55.0 55.0 55.0 14:53:32 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.50 stddev:3.10 (4.4%) stddev-sans-first:3.00 14:53:32 INFO - PROCESS | 1665 | Values: 66.0 73.0 64.0 74.0 71.0 68.0 69.0 70.0 69.0 72.0 14:53:32 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:86.50 stddev:1.43 (1.7%) stddev-sans-first:1.50 14:53:32 INFO - PROCESS | 1665 | Values: 86.0 89.0 87.0 86.0 86.0 88.0 88.0 86.0 86.0 84.0 14:53:32 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:152.30 Median:150.00 stddev:12.31 (8.2%) stddev-sans-first:13.04 14:53:32 INFO - PROCESS | 1665 | Values: 154.0 153.0 146.0 145.0 144.0 146.0 147.0 146.0 185.0 157.0 14:53:32 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:173.50 stddev:1.14 (0.7%) stddev-sans-first:0.88 14:53:32 INFO - PROCESS | 1665 | Values: 171.0 172.0 173.0 173.0 173.0 174.0 173.0 174.0 174.0 175.0 14:53:32 INFO - PROCESS | 1665 | 14:53:32 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 14:53:32 INFO - PROCESS | 1665 | Values: 67.0 67.0 67.0 67.0 65.0 67.0 67.0 67.0 65.0 67.0 14:53:32 INFO - PROCESS | 1665 | -------- Summary: end -------- 14:53:32 INFO - PROCESS | 1665 | 14:53:33 INFO - TEST-INFO | 1665: exit 0 14:53:33 INFO - TEST-OK | kraken | took 59668ms 14:53:33 INFO - SUITE-END | took 1179s 14:53:33 INFO - Completed test suite (00:19:40) 14:53:33 INFO - javascript benchmark 14:53:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3280.097973057409, 3299.45558982768, 3313.5526703894975, 3328.2844188499466, 3353.312570922961, 5522.944770552293, 5600.215969764231, 5617.286727548096, 5625.296837895263, 5684.971575142124, 4881.877168251295, 5535.972320138404, 5628.746706398211, 5677.687727175004, 5700.087985922253, 5082.983403319333, 5127.461616530267, 5138.974305128488, 5197.1424714922, 5203.349581302337, 5174.068667639824, 5276.3668359796875, 5294.973525132369, 5304.675888876192, 5313.1764576490705, 5090.949090509084, 5171.224316352577, 5266.262723218752, 5301.9396120776, 5313.654612450197, 5190.091733946582, 5205.984832957575, 5219.73901304937, 5219.929914367545, 5220.895582088337, 5108.923366149511, 5143.099957507421, 5167.0, 5174.844754657366, 5180.093483640386, 5625.803096891589, 5644.181593668936, 5646.2942132233475, 5663.2637757091725, 5674.177244299594, 4930.728809915453, 5581.748821303051, 6096.298925623566, 6100.678570187591, 6137.560853825989, 6203.627782333075, 6273.466755325757, 6280.1835761351185, 6282.0, 6290.087937249119, 5729.713514324267, 5740.6268592541355, 5741.85645358861, 5746.511546518551, 5746.9712651436475, 6129.370106229187, 6238.126662267196, 6299.275583307886, 6309.274433440213, 6329.746810127635, 5989.251343582052, 5996.5502587305255, 6009.2188015557695, 6018.187544681499, 6020.789272375533, 6142.682951206388, 6143.082036032938, 6150.876982460326, 6163.322034576193, 6165.506759459233, 6029.397060293935, 6092.5430592705725, 6094.085887116879, 6102.084687296941, 6107.48086412651, 6096.435059713508, 6100.581173165739, 6102.004547214632, 6104.405702081107, 6105.800759126419, 4719.221328480762, 4774.522547745267, 4815.109204797123, 4836.347093142451, 4850.83022094225, 4272.508661503967, 4274.380214868889, 4274.722143060691, 4277.165952639206, 4378.058717375779, 4812.494688057774, 5579.972100139474, 5675.687837168913, 5690.459406356389, 5705.001624715658, 5999.820005399845, 6249.125122482856, 6260.217472815898, 6272.0, 6275.090111933744, 5551.139573366135, 5581.246531718166, 5610.803621873215, 5623.0159722048475, 5634.690092044895, 5373.2208829719475, 5382.596305277119, 5385.596080293915, 5388.407275199725, 5409.215663728737, 6293.244810622571, 6296.937030629635, 6299.590526615755, 6305.0, 6312.6212427253595, 6074.544409169418, 6121.696863452088, 6122.794608433986, 6127.708789264132, 6179.62922224668, 4885.022995401005, 6166.136740856194, 6264.937350626436, 6287.056941458635, 6315.494760419064, 6140.0, 6152.938470615237, 6157.0456579230295, 6161.322254552086, 6175.413335733098, 5958.731857066529, 6098.855844323493, 6127.0, 6249.375062493714, 6251.249850018027, 5904.734286957183, 6047.213862197887, 6048.546359023179, 6059.121427393092, 6071.726772295169, 5959.4934430573885, 5989.46094851448, 6031.065184896348, 6034.185384972972, 6034.2155519782145, 5620.606557541097, 5745.511631511201, 5771.1920331154515, 5834.066549352084, 5879.882402352015, 5973.641581505123, 5986.461218490183, 5988.191594134736, 5990.9700451497465, 5995.310539288038, 5811.360750317546, 5822.679752613478, 5825.155352473952, 5827.5629327801435, 5835.7373918174635], "value": 5613.053585763024, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [462.78711792575416, 487.3299213581326, 488.4090250796536, 508.5423119192726, 515.7885267040514, 29478.0, 31256.21859453515, 39019.41470877939, 40401.19197616046, 40530.59469405305, 41131.0, 41416.0, 41439.37840932389, 41527.58472415275, 41598.16803663925, 9387.62449502019, 9613.90386096137, 9621.95189024054, 9627.989061148584, 9648.517574121266, 9491.905080949206, 9583.66457173999, 9605.231581473501, 9625.422474651508, 9632.951835240814, 9592.520373981308, 9626.614935402575, 9627.085426884434, 9633.855492167622, 9644.373115747489, 9542.618295268216, 9597.136257736836, 9626.75933101671, 9628.518574071304, 9632.566534505964, 9385.15533601979, 9470.195033422167, 9470.668526601605, 9478.857817132679, 9484.762880927963, 38826.805865970775, 39126.021849453995, 39128.41307380392, 39166.60833391658, 39242.41136382957, 3350.731941444679, 3352.195473086466, 3422.093145316493, 3554.733394995386, 3734.7945862977526, 29594.556081658793, 30226.84886575575, 30237.395252094833, 30275.0917472474, 31015.671493751106, 2602.3624212068166, 3006.5941097951713, 3158.4472717274616, 3171.7462602991704, 3270.378628060661, 410277.0, 479153.0, 481741.0, 482314.9999999965, 482347.0, 59856.70071649614, 60393.396066039655, 60439.39560604426, 60448.39551604516, 60485.0, 33644.158896027795, 34111.488327675106, 62865.0, 63108.68445657742, 63297.05054424187, 15486.986691730002, 16128.435504757277, 16133.032018078953, 16140.273687684083, 16178.75731864023, 12315.93842030784, 12421.565245216554, 12457.439415226336, 12462.189957652723, 12467.875321246853, 18499.352522661644, 18533.0, 18563.535911602048, 18575.213717942148, 18615.534611634546, 7538.773836784905, 7651.693932242648, 7676.347510461562, 7739.419543534257, 7750.0, 863.3869952333788, 987.3039507147444, 998.2064258914181, 1003.7503308381113, 1010.3836659637615, 23741.643875341884, 28706.71293287082, 29587.408251834844, 29977.400451990838, 30306.242343941136, 942.7171848445439, 1011.4487604255698, 1041.7447725307347, 1083.2219416802843, 1125.921185517006, 15034.323455444532, 15127.39490420393, 15171.317290721943, 15486.922565387325, 15586.06483610987, 625076.0, 631731.0, 639348.0, 639708.0, 639749.0, 55666.721666392215, 56196.87606247852, 56242.71878640662, 56309.15536266959, 56350.0, 1200.8378868852767, 1233.660743295601, 1305.2690493323769, 1335.4925128451127, 1337.498438085718, 29882.954096606514, 30599.694003060577, 30616.0, 31168.688313116578, 31366.686333136375, 47748.0, 48446.51553484561, 48465.75767121142, 48483.5151648479, 48522.51477485321, 521995.0, 524629.0, 526309.0, 526317.0, 620766.0, 21885.0, 23400.0, 25915.352116197246, 25921.740782592686, 26841.0, 44806.55193448024, 45358.77320613376, 45484.545154549356, 46360.0, 47576.0, 38221.61778382181, 38313.80843095878, 38742.80628596839, 39577.0, 39908.401373978835, 37248.44127338146, 37615.62384376121, 37838.810805945795, 38850.61149388583, 38902.610973889896, 34262.0, 34969.82515087408, 35187.472187917716, 35231.82384088063, 35238.82380588183, 31707.0, 33468.33063338768, 34336.0, 34461.310773784884, 34608.134796630286, 21671.674924876454, 24274.635880461454, 24393.756062439148, 25124.371890702878, 25543.489130217662], "value": 19424.56617000334, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.7688944409744, 372.53247174795644, 376.31886285822657, 387.88557375574203, 402.59338068550755, 15501.302441390137, 15501.689966200669, 18460.261589536418, 20843.895780521114, 21043.894780526094, 17973.7303940441, 19651.901740491277, 20446.18215271391, 20546.69179962302, 20707.482312942186, 5372.2210279509445, 5836.941630583682, 5909.231799866011, 5917.615355001911, 5924.407559244062, 5726.255586773714, 5817.447342502455, 5856.590038697293, 5918.88162236755, 5933.6439813611105, 6042.546808989321, 6135.0, 6139.324674285825, 6142.662153581551, 6144.201253837017, 6134.478569321613, 6139.324674285847, 6180.721867515973, 6674.566153200027, 6756.797296081126, 5834.241548598655, 5929.407059294036, 5941.613795103304, 5944.791932282393, 5960.0761881908375, 17076.743848842278, 19775.802241977683, 24425.633615495783, 24454.87772561126, 24621.261362159163, 2107.557412943284, 2199.7360316761933, 2226.855254408458, 2315.7452680205165, 2489.4149874779414, 9733.2213422926, 11056.668299951014, 13408.0, 14756.557303280919, 15396.384144634201, 1860.2651952478695, 1920.805402576693, 1926.9421917342502, 1944.0959953621634, 1964.9508762280914, 109509.0, 115300.42349788197, 115984.0, 116181.41909290483, 116240.0, 8539.658413663385, 10987.835182472269, 11313.208075434804, 11413.771724565628, 11487.0, 12519.561815336601, 14280.214588197749, 14282.714345713235, 14291.428342866377, 14333.283335833166, 6664.233613134455, 7409.518381305198, 8167.550784706779, 8206.384521160937, 8357.874631880526, 6463.4506066983895, 8249.257566819015, 8255.463394879314, 8365.205305495969, 8432.367572432093, 3874.818180454988, 3961.5840336764227, 4352.978235108868, 4479.350494178326, 4558.1795276849825, 1781.741647461111, 1791.5968906996081, 1835.3943198744382, 1881.5484283771796, 1923.278770461077, 818.4025661267308, 835.7701632051113, 871.9825603487894, 874.8425283448913, 959.0, 19467.513312167026, 20234.392968210977, 20286.594268114553, 20289.28987485431, 20678.0, 811.2860682599393, 829.9460535065201, 854.4531499840107, 888.8977767556813, 924.8057907839294, 7804.297613214724, 8009.519428834288, 10403.58385664565, 10903.781924361627, 10948.562057517769, 523272.0, 552559.0, 556284.0, 556932.0, 571666.0, 95172.0, 131013.0, 131036.3448182753, 135419.32290338486, 138992.0, 1006.0894890124449, 1065.541817018674, 1083.0360978728938, 1084.4957094950885, 1086.4296244471557, 17695.911520442314, 17895.73156402681, 18049.819501804814, 18082.547936301697, 18474.353397631017, 51778.96442071213, 51965.80341965773, 52557.47442525679, 52727.73636131795, 54123.72938135284, 75657.0, 77564.0, 78920.21079789128, 80426.0, 81110.59444702738, 6878.312168783082, 7806.531608103532, 7850.704633735598, 7856.921430785847, 8086.83826323482, 10114.409384668632, 12296.262224266573, 12669.303188324731, 12840.871591283967, 12848.807267891176, 10643.0, 10732.73168170802, 11068.889311107108, 11182.32906025641, 11240.156988225752, 10340.27618066728, 10678.786424271626, 10883.782324353628, 11213.719657008314, 11221.887781122085, 10880.564777409132, 11065.059469945145, 11619.419029048682, 11668.0, 11682.591109311134, 7993.280604745601, 8004.879926800986, 8107.581173294532, 8182.7954301142945, 8191.959040204999, 9519.857202141835, 11217.66347009591, 11290.7741845161, 11322.094232461548, 11324.6036388726], "value": 9386.219332038781, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.512682743971, 1453.7746649269363, 1470.2281302316283, 1617.0, 1812.2660322569357, 7419.925800741991, 7659.846803063942, 8102.878456823152, 8327.667573188291, 8334.499930004189, 8193.754187374374, 8270.0, 8283.95858020709, 8289.83420331593, 8307.792305192374, 2268.1947908492493, 2298.4139044543617, 2300.5053913408615, 2303.021215983209, 2303.873286969216, 2276.84062115652, 2316.270374831931, 2334.4747431827873, 2334.8482348647367, 2339.602267614501, 2245.494763678176, 2271.7955384015436, 2304.4238940264936, 2313.201945328867, 2317.316391664463, 2252.3693365857584, 2266.546690661866, 2289.5420915816903, 2291.564602725485, 2305.1470955746313, 1930.5463216144194, 2305.8501197422283, 2306.4810417656063, 2307.0541078158044, 2315.513742114158, 8077.636506357228, 8291.08798032216, 8306.875396869053, 8317.168283171695, 8322.750317490425, 5015.172496538067, 5185.844424667228, 5196.324477817897, 5225.294585230983, 5226.320578324831, 3402.9489557656657, 3473.808940508271, 3529.858805647771, 3610.5667319921777, 3612.187257866985, 1045.1951996962296, 1088.1294964028825, 1710.9657806843918, 1757.929682812686, 1827.0955876841049, 10773.5690572377, 10866.076383507332, 10876.564937402416, 10880.67357979262, 10912.399818010006, 4530.79611417487, 4681.531846815291, 4716.268978308368, 4731.361266229015, 4735.408073990751, 8533.44532605391, 8587.742367728979, 8601.182887625666, 8610.354223433142, 8612.354073444392, 4975.0796102721115, 5055.595552355876, 5059.645824792229, 5069.569086627678, 5081.060003899291, 4061.2080644274674, 4605.861824145281, 4737.739424331695, 4740.1230772307235, 4760.309755085563, 3481.3385456763135, 3578.8031658258524, 3581.230035542371, 3618.4029635109914, 3665.17533554948, 968.3802366485455, 1108.957579874915, 1115.5705053554277, 1117.234694234452, 1127.1827924754487, 751.6467260387609, 832.1636755061246, 849.8555245608261, 897.7531178925717, 944.414463032924, 5289.3917199521775, 5323.840284791385, 5337.599680024014, 5460.798624302647, 5582.33012038558, 423.83258612847754, 431.0323324137332, 435.9825606975749, 961.4519723757531, 1010.8685870836745, 3597.334493118781, 3789.734718569729, 3851.1527463957887, 3873.2253549290253, 3889.669378102836, 8586.957065214634, 9665.855012174823, 10166.0, 10172.847407288897, 10188.184945204366, 7472.775816725507, 9129.680461183827, 9581.425114493153, 9900.455474948947, 10123.544440500047, 7541.283578060075, 7859.685612575548, 7882.684692612346, 7885.802854928673, 7914.525128492309, 4974.950250497449, 5135.841457503683, 5256.658317209369, 5768.625039372428, 5945.583809133319, 8370.372222083246, 9289.16397524226, 9292.303077269096, 9403.0, 9413.199878010446, 9072.90927090747, 9280.62877484893, 9375.278319297806, 9473.810523789623, 9497.43015419077, 6843.452523797984, 7446.329830315081, 7690.115636701851, 7771.0, 7840.960795196215, 7864.21357864209, 8016.759497215093, 8022.679092836222, 8024.679012839421, 8029.4379393441895, 6966.895496567454, 7116.0, 7133.17968433616, 7197.784066478014, 7250.564966102051, 7005.859882802417, 7039.260877607778, 7046.2249152594195, 7053.4004609608755, 7184.6048467334795, 6603.702833372606, 6620.536562440583, 6684.565503242274, 6691.230508491586, 6702.698378572878, 4729.219678752967, 4789.928151077806, 4795.808167673394, 4835.975820121018, 4926.778294976663, 4651.139539185261, 4828.0, 4847.321375007572, 4886.657933944732, 4935.98812243482], "value": 4350.382691982567, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.1836940211078, 297.3339719029372, 305.86083332083905, 309.4013084681142, 312.578019673441, 5086.923696144556, 5092.9373603690565, 5103.387593488782, 5110.361204849394, 5158.638895277332, 4177.7493350399, 4774.331593576902, 4915.70505769654, 4928.3593132892765, 5079.339685840845, 3429.8113603751785, 3613.7713177519636, 3905.0, 3906.1211227473877, 3979.064919743858, 3927.9410808837893, 3941.5219292765214, 3942.1918506706056, 3944.7435916665327, 3963.0884896473826, 3216.8874089406877, 3659.7309668005873, 3826.215625796705, 3863.884083477486, 3921.470601468808, 3072.523758817387, 3481.5125882376487, 3602.4056030755023, 3853.460515527828, 3913.5303763548413, 2910.122970683918, 2931.7654587632937, 3333.3000069985333, 3339.8664053437833, 3343.916402089943, 3934.665553427962, 4912.459629440758, 4923.347436672346, 4929.580985616227, 4947.282644016634, 3336.4995250712345, 4386.363977223285, 4405.537418571068, 4450.35469856869, 4463.33050042493, 5323.467653234684, 5350.785968561253, 5350.866228344323, 5361.51746342831, 5375.973120134413, 3373.6289008209324, 3660.194757153449, 3669.43123815809, 3672.3022625701033, 3693.4829123922673, 4721.347528365079, 4976.377952755905, 5153.0, 5615.354234263071, 5626.521745651625, 3704.499677630564, 3708.2212735325884, 3716.7398282120535, 3720.479132921393, 3733.533308336458, 3604.819759012039, 3727.589965103836, 3747.9063023424087, 3759.586445490994, 3779.4141908004303, 4107.856225032109, 4122.320491680432, 4122.42286079949, 4157.417961485395, 4377.802998865059, 5164.354455693038, 5175.146100893386, 5377.897531006134, 5394.595405344615, 5435.592330575223, 1097.8023955687893, 1157.7322831499494, 1200.5017917564287, 1268.65112094173, 1283.8716128387086, 788.8974433323631, 832.493187330933, 833.7832163637498, 851.638053827121, 869.6434461870602, 5021.472745361684, 5029.723365214948, 5043.218301163325, 5059.19052951526, 5102.719350435762, 4862.610991120702, 5439.972800135974, 5452.972735136378, 5463.836084917459, 5512.39363670004, 3992.043898489719, 4016.658584020391, 4420.425344705168, 5027.547520723152, 5132.846014619493, 2849.886004559836, 2869.497837878363, 2881.3516958684127, 2890.4102743490994, 2891.8120322178993, 5140.434552199255, 5196.714180720097, 5661.575381846295, 5704.686242256633, 5704.942950570524, 5172.637915345889, 5550.7233336332865, 5567.721613919288, 5586.91619625706, 5599.524040456607, 5382.327209098784, 5610.298712660918, 5633.211350410946, 5653.519450846724, 5674.460926212003, 4992.72540010303, 5158.793648254028, 5444.754986025559, 5481.369642491165, 5484.780608775604, 4337.7397356158735, 5239.4850471773, 5255.817441075727, 5366.1145910925825, 5435.402105768283, 5190.584753219809, 5618.494335509824, 5630.887382252414, 5646.322441307069, 5659.2456338535185, 2961.452131355706, 3283.8670658622736, 3688.3914154165336, 3702.500162478031, 3705.870294539678, 4595.80591488912, 5539.307586551681, 5548.750306236309, 5552.222688823649, 5567.216391804098, 5389.353277606712, 5403.5136837684795, 5404.2163886235485, 5408.405075441777, 5410.918836217381, 4419.602235798665, 5098.847034588968, 5377.758000890048, 5383.7846486140115, 5386.4110087523495, 4150.896227594213, 5259.763310651107, 5266.289050978069, 5269.394019687785, 5297.0, 4822.903541929212, 4845.515448455127, 5134.691918484903, 5320.866978325573, 5386.919196211981, 4633.814647414066, 4881.755912204447, 5162.0, 5205.349331333583, 5296.867578310573], "value": 3888.1000183294454, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.3942209699658, 724.612332402165, 755.0976582983334, 790.3361176611645, 800.487687879757, 15175.848241517582, 15381.92309038456, 15394.615134621612, 15406.07563546188, 15418.845811541882, 13144.408501617427, 13163.0, 13200.339983000835, 13220.933895330534, 13250.536231231908, 661.6129564204946, 679.8096532970776, 815.3355015662216, 822.5147163173726, 841.9326453883674, 826.6982551368737, 832.7834762961643, 839.08539691736, 839.630562552478, 846.1707526623912, 889.9911000890005, 890.0698769785589, 892.2861710631502, 892.7277180459957, 893.7050773244814, 688.5627626457235, 883.7127933421632, 883.7392969074107, 884.2174675412307, 885.3979294080023, 409.91801639672184, 520.0015969338879, 523.1655509462402, 524.2503220394834, 532.3000254665103, 13768.586942391745, 14300.070495417765, 14302.141871487744, 14511.274436278143, 14523.636909077251, 13787.51743688966, 13981.930090349482, 14037.64905877351, 14085.154890706488, 14091.647708807259, 11319.377434241114, 11400.942995285053, 11590.652280431601, 11719.179657423983, 11945.880541194563, 3689.0961714379882, 3716.2381711749026, 3724.683401910841, 3742.6070262622306, 3897.9220415591813, 58620.41379586235, 78688.0, 83010.99999999939, 83175.58412207961, 83316.0, 10560.419176945341, 10874.61938832153, 10920.344779313267, 10968.890311096946, 11176.552937882394, 19192.424227272924, 20248.190072396937, 21586.460338491663, 21737.23919662804, 21750.34748957534, 6864.5881247125335, 7630.694772209161, 7960.960195198987, 7988.360931125496, 8063.6774529018185, 4172.937405938914, 4342.544032876503, 4363.781810909505, 4475.418195634612, 4480.484744254452, 3398.796072235674, 3537.8054207018863, 3543.1496440854526, 3544.680978711877, 3550.6981906538235, 610.8747706720112, 619.5136817598163, 635.1584150999944, 646.1761254400677, 646.7089809585706, 559.7816851427865, 580.3760956971273, 656.5457511611803, 679.9388055074968, 700.8247938015496, 8331.583420828934, 9058.54707264634, 9108.954455227682, 9225.953870230605, 9263.490508022123, 526.8287806462915, 613.7146227004464, 655.8424380967596, 682.2290811383106, 683.5147045597582, 4211.936820947688, 4319.589638984291, 4481.439820022497, 4532.7280363178315, 4547.567981041796, 96476.51761741287, 98801.0, 100561.49719251358, 103433.0, 104978.0, 89639.0, 89720.5513972426, 91543.0, 96291.0, 96686.0, 60033.0, 66745.66627166833, 80891.67516547687, 81767.591162045, 83834.0, 8502.74491765248, 9498.620055197714, 9501.619935202514, 9540.809183816424, 9677.0, 49460.0, 52723.209151861985, 53062.204066938255, 55724.72137639286, 56420.84424803575, 70331.64834175796, 70781.0, 71160.28839711536, 72020.27979720135, 72238.27761722526, 10652.680419587425, 11499.367534785333, 11982.700432489257, 12446.439910204244, 12572.245665259748, 13950.930245348709, 14078.577642670736, 14282.928585357007, 14362.784558231844, 14784.852151478777, 12723.55467558631, 12934.288614126313, 12996.675083122998, 13725.656858578615, 13740.381682824496, 12864.356782160667, 13015.739685206432, 13040.673983150496, 13156.671083222996, 13165.0, 10764.677059688222, 12863.45453459905, 13118.934405327913, 13328.733425331633, 13371.130876493386, 10470.947645261725, 10556.155507559222, 10700.090492308242, 10801.0, 11127.221094523306, 7663.31030207284, 9736.513174341397, 10178.0, 11157.66527004191, 11422.714432139262], "value": 7185.21161629011, "unit": "score"}], "name": "dromaeo_css", "value": 7065.330289958237, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 114.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 142.0, 142.0, 149.0, 114.0, 107.0, 112.0, 102.0, 163.0, 100.0], "value": 129.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 264.0, 197.0, 183.0, 182.0, 181.0, 182.0, 180.0, 181.0, 183.0], "value": 193.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 87.0, 61.0, 60.0, 58.0, 58.0, 82.0, 60.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 91.0, 70.0, 70.0, 69.0, 93.0, 69.0, 70.0, 90.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 91.0, 87.0, 90.0, 86.0, 91.0, 89.0, 90.0, 87.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 93.0], "value": 94.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 79.0, 77.0, 83.0, 84.0, 83.0, 86.0, 79.0, 80.0], "value": 81.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 54.0, 54.0, 54.0, 57.0, 56.0, 55.0, 55.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 64.0, 74.0, 71.0, 68.0, 69.0, 70.0, 69.0, 72.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 87.0, 86.0, 86.0, 88.0, 88.0, 86.0, 86.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 146.0, 145.0, 144.0, 146.0, 147.0, 146.0, 185.0, 157.0], "value": 152.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 173.0, 173.0, 173.0, 174.0, 173.0, 174.0, 174.0, 175.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 65.0, 67.0, 67.0, 67.0, 65.0, 67.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1449.4, "alertThreshold": 2.0}]} 14:53:33 INFO - Return code: 0 14:53:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:53:33 INFO - # TBPL SUCCESS # 14:53:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:53:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:53:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:53:33 INFO - 2016-10-31 14:53:33.685 screenresolution[1669:9934] starting screenresolution argv=screenresolution get 14:53:33 INFO - 2016-10-31 14:53:33.687 screenresolution[1669:9934] Display 0: 1600x1200x32@60 14:53:33 INFO - 2016-10-31 14:53:33.693 screenresolution[1670:9937] starting screenresolution argv=screenresolution list 14:53:33 INFO - Available Modes on Display 0 14:53:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:53:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:53:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:53:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:53:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:53:33 INFO - Intel Iris: 14:53:33 INFO - Chipset Model: Intel Iris 14:53:33 INFO - Type: GPU 14:53:33 INFO - Bus: Built-In 14:53:33 INFO - VRAM (Dynamic, Max): 1536 MB 14:53:33 INFO - Vendor: Intel (0x8086) 14:53:33 INFO - Device ID: 0x0a2e 14:53:33 INFO - Revision ID: 0x0009 14:53:33 INFO - Displays: 14:53:33 INFO - Display: 14:53:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:53:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:53:33 INFO - Display Serial Number: 1600x1200 60 14:53:33 INFO - Main Display: Yes 14:53:33 INFO - Mirror: Off 14:53:33 INFO - Online: Yes 14:53:33 INFO - Rotation: Supported 14:53:33 INFO - Return code: 0 14:53:33 INFO - Running post-action listener: _resource_record_post_action 14:53:33 INFO - [mozharness: 2016-10-31 21:53:33.930095Z] Finished run-tests step (success) 14:53:33 INFO - Running post-run listener: _resource_record_post_run 14:53:33 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 37553152; Write bytes: 709059584; Read time: 247; Write time: 1982 14:53:33 INFO - TinderboxPrint: CPU usage
53.6% 14:53:33 INFO - TinderboxPrint: I/O read bytes / time
37,553,152 / 247 14:53:33 INFO - TinderboxPrint: I/O write bytes / time
709,059,584 / 1,982 14:53:33 INFO - TinderboxPrint: CPU idle
2,256.3 (46.4%) 14:53:33 INFO - TinderboxPrint: CPU system
973.8 (20.0%) 14:53:33 INFO - TinderboxPrint: CPU user
1,631.7 (33.6%) 14:53:33 INFO - TinderboxPrint: Swap in / out
444,948,480 / 0 14:53:33 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 404584960; Write bytes: 399087616; Read time: 30828; Write time: 818 14:53:34 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 35415040; Write bytes: 297524224; Read time: 223; Write time: 1128 14:53:34 INFO - Running post-run listener: _upload_blobber_files 14:53:34 INFO - Blob upload gear active. 14:53:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:53:34 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 14:53:34 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:53:34 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:53:34 INFO - (blobuploader) - INFO - Open directory for files ... 14:53:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:53:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:53:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:36 INFO - (blobuploader) - INFO - Done attempting. 14:53:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:53:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:53:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:37 INFO - (blobuploader) - INFO - Done attempting. 14:53:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:53:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:53:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:53:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:53:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:53:40 INFO - (blobuploader) - INFO - Done attempting. 14:53:40 INFO - (blobuploader) - INFO - Iteration through files over. 14:53:40 INFO - Return code: 0 14:53:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:53:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:53:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1af836eb049a631388e2f9c0d8f9046d674e2ac003bb50c20b48490c6dd2bc1df9a393f87f1de6c3709368cc883e55c6b2a47f76186539a8d8a35bf57bee2210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7005b639960a4f152aacd6f5e7abf0f8bab1d45d44213e06645fcc34fa9d67b97b821b64b9c94e721b780505e000b5cd84902eb47c7b5e7a0173e132f9e55b01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2151e9a15f51e4dbbd61d708ac7b56d10e4f41e4b8652586a1880773a09671081f37575e664d11a75f33bf6515d8ac775474af0e0514f0cd87b8b862da11e2c6"} 14:53:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:53:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:53:40 INFO - Contents: 14:53:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1af836eb049a631388e2f9c0d8f9046d674e2ac003bb50c20b48490c6dd2bc1df9a393f87f1de6c3709368cc883e55c6b2a47f76186539a8d8a35bf57bee2210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7005b639960a4f152aacd6f5e7abf0f8bab1d45d44213e06645fcc34fa9d67b97b821b64b9c94e721b780505e000b5cd84902eb47c7b5e7a0173e132f9e55b01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2151e9a15f51e4dbbd61d708ac7b56d10e4f41e4b8652586a1880773a09671081f37575e664d11a75f33bf6515d8ac775474af0e0514f0cd87b8b862da11e2c6"} 14:53:40 INFO - Running post-run listener: copy_logs_to_upload_dir 14:53:40 INFO - Copying logs to upload dir... 14:53:40 INFO - mkdir: /builds/slave/test/build/upload/logs 14:53:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.075599 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-10-31 14:53:40.798887) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 14:53:40.802690) ========= 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.xF3mEtQ3Yn/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.lvAGmxXgMZ/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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/Fx-Team/sha512/1af836eb049a631388e2f9c0d8f9046d674e2ac003bb50c20b48490c6dd2bc1df9a393f87f1de6c3709368cc883e55c6b2a47f76186539a8d8a35bf57bee2210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7005b639960a4f152aacd6f5e7abf0f8bab1d45d44213e06645fcc34fa9d67b97b821b64b9c94e721b780505e000b5cd84902eb47c7b5e7a0173e132f9e55b01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2151e9a15f51e4dbbd61d708ac7b56d10e4f41e4b8652586a1880773a09671081f37575e664d11a75f33bf6515d8ac775474af0e0514f0cd87b8b862da11e2c6"} build_url:https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/fhHzzYibQrikLUFBWcj0Hw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1af836eb049a631388e2f9c0d8f9046d674e2ac003bb50c20b48490c6dd2bc1df9a393f87f1de6c3709368cc883e55c6b2a47f76186539a8d8a35bf57bee2210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7005b639960a4f152aacd6f5e7abf0f8bab1d45d44213e06645fcc34fa9d67b97b821b64b9c94e721b780505e000b5cd84902eb47c7b5e7a0173e132f9e55b01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2151e9a15f51e4dbbd61d708ac7b56d10e4f41e4b8652586a1880773a09671081f37575e664d11a75f33bf6515d8ac775474af0e0514f0cd87b8b862da11e2c6"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 14:53:40.839253) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 14:53:40.839605) ========= 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.xF3mEtQ3Yn/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.lvAGmxXgMZ/Listeners TMPDIR=/var/folders/mb/mpkj7hkd5b55mcsqlhlvs3x000000w/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.005338 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 14:53:40.890902) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 14:53:40.891640) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 14:53:40.892404) ========= ========= Total master_lag: 0.36 =========