builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0142 starttime: 1475068401.14 results: success (0) buildid: 20160928041920 builduid: f99144e20a9c49509718a383b33bce30 revision: fc513f0359ebca43d8b791a458583aeb3bb37f42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 06:13:21.135736) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 06:13:21.136188) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 06:13:21.136482) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 06:13:21.212152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:13:21.212589) ========= 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.y5Oc9dI4ru/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.MlszoWiDXY/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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-09-28 06:13:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.31M=0.001s 2016-09-28 06:13:21 (9.31 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.583666 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:13:21.821048) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:13:21.821668) ========= 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.y5Oc9dI4ru/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.MlszoWiDXY/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.028722 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:13:21.871882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 06:13:21.872239) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fc513f0359ebca43d8b791a458583aeb3bb37f42 --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 fc513f0359ebca43d8b791a458583aeb3bb37f42 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y5Oc9dI4ru/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.MlszoWiDXY/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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-09-28 06:13:21,948 truncating revision to first 12 chars 2016-09-28 06:13:21,948 Setting DEBUG logging. 2016-09-28 06:13:21,948 attempt 1/10 2016-09-28 06:13:21,948 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fc513f0359eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 06:13:22,725 unpacking tar archive at: fx-team-fc513f0359eb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.028381 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 06:13:22.921973) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 06:13:22.922283) ========= script_repo_revision: fc513f0359ebca43d8b791a458583aeb3bb37f42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 06:13:22.922711) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 06:13:22.922975) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 06:13:22.940795) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-09-28 06:13:22.941210) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--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.y5Oc9dI4ru/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.MlszoWiDXY/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 06:13:23 INFO - MultiFileLogger online at 20160928 06:13:23 in /builds/slave/test 06:13:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:13:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:13:23 INFO - {'append_to_log': False, 06:13:23 INFO - 'base_work_dir': '/builds/slave/test', 06:13:23 INFO - 'blob_upload_branch': 'Fx-Team', 06:13:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:13:23 INFO - 'branch': 'Fx-Team', 06:13:23 INFO - 'buildbot_json_path': 'buildprops.json', 06:13:23 INFO - 'config_files': ('talos/mac_config.py',), 06:13:23 INFO - 'default_actions': ('clobber', 06:13:23 INFO - 'read-buildbot-config', 06:13:23 INFO - 'download-and-extract', 06:13:23 INFO - 'populate-webroot', 06:13:23 INFO - 'create-virtualenv', 06:13:23 INFO - 'install', 06:13:23 INFO - 'run-tests'), 06:13:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:13:23 INFO - 'download_minidump_stackwalk': True, 06:13:23 INFO - 'download_symbols': 'ondemand', 06:13:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:13:23 INFO - 'tooltool.py': '/tools/tooltool.py', 06:13:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:13:23 INFO - '/tools/misc-python/virtualenv.py')}, 06:13:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:13:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:13:23 INFO - 'installer_path': 'installer.exe', 06:13:23 INFO - 'log_level': 'info', 06:13:23 INFO - 'log_name': 'talos', 06:13:23 INFO - 'log_to_console': True, 06:13:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:13:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:13:23 INFO - 'opt_config_files': (), 06:13:23 INFO - 'pip_index': False, 06:13:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:13:23 INFO - 'cmd': ('bash', 06:13:23 INFO - '-c', 06:13:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:13:23 INFO - 'enabled': True, 06:13:23 INFO - 'halt_on_failure': False, 06:13:23 INFO - 'name': 'check_screen_resolution'},), 06:13:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:13:23 INFO - 'cmd': ('bash', 06:13:23 INFO - '-c', 06:13:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:13:23 INFO - 'enabled': True, 06:13:23 INFO - 'halt_on_failure': False, 06:13:23 INFO - 'name': 'check_screen_resolution'},), 06:13:23 INFO - 'run_cmd_checks_enabled': True, 06:13:23 INFO - 'sps_profile': False, 06:13:23 INFO - 'sps_profile_interval': 0, 06:13:23 INFO - 'suite': 'dromaeojs-e10s', 06:13:23 INFO - 'system_bits': '32', 06:13:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:13:23 INFO - 'title': 't-yosemite-r7-0142', 06:13:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:13:23 INFO - 'use_talos_json': True, 06:13:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:13:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:13:23 INFO - 'work_dir': 'build'} 06:13:23 INFO - [mozharness: 2016-09-28 13:13:23.151368Z] Running clobber step. 06:13:23 INFO - Running pre-action listener: _resource_record_pre_action 06:13:23 INFO - Running main action method: clobber 06:13:23 INFO - rmtree: /builds/slave/test/build 06:13:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:13:25 INFO - Running post-action listener: _resource_record_post_action 06:13:25 INFO - [mozharness: 2016-09-28 13:13:25.307449Z] Finished clobber step (success) 06:13:25 INFO - [mozharness: 2016-09-28 13:13:25.307615Z] Running read-buildbot-config step. 06:13:25 INFO - Running pre-action listener: _resource_record_pre_action 06:13:25 INFO - Running main action method: read_buildbot_config 06:13:25 INFO - Using buildbot properties: 06:13:25 INFO - { 06:13:25 INFO - "project": "", 06:13:25 INFO - "product": "firefox", 06:13:25 INFO - "script_repo_revision": "production", 06:13:25 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 06:13:25 INFO - "repository": "", 06:13:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 06:13:25 INFO - "buildid": "20160928041920", 06:13:25 INFO - "pgo_build": "False", 06:13:25 INFO - "basedir": "/builds/slave/test", 06:13:25 INFO - "buildnumber": 0, 06:13:25 INFO - "slavename": "t-yosemite-r7-0142", 06:13:25 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:13:25 INFO - "platform": "yosemite_r7", 06:13:25 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 06:13:25 INFO - "branch": "fx-team", 06:13:25 INFO - "repo_path": "integration/fx-team", 06:13:25 INFO - "revision": "fc513f0359ebca43d8b791a458583aeb3bb37f42", 06:13:25 INFO - "stage_platform": "macosx64", 06:13:25 INFO - "builduid": "f99144e20a9c49509718a383b33bce30", 06:13:25 INFO - "slavebuilddir": "test" 06:13:25 INFO - } 06:13:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:13:25 INFO - Running post-action listener: _resource_record_post_action 06:13:25 INFO - [mozharness: 2016-09-28 13:13:25.310832Z] Finished read-buildbot-config step (success) 06:13:25 INFO - [mozharness: 2016-09-28 13:13:25.310963Z] Running download-and-extract step. 06:13:25 INFO - Running pre-action listener: _resource_record_pre_action 06:13:25 INFO - Running main action method: download_and_extract 06:13:25 INFO - mkdir: /builds/slave/test/build/tests 06:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:25 INFO - trying https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:13:25 INFO - Downloading https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/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 06:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/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 06:13:26 INFO - Downloaded 1199 bytes. 06:13:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:13:26 INFO - Using the following test package requirements: 06:13:26 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:13:26 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:13:26 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:13:26 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:13:26 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:13:26 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:13:26 INFO - u'jsshell-mac.zip'], 06:13:26 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:13:26 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:13:26 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:13:26 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:13:26 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:13:26 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:13:26 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:13:26 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:13:26 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:13:26 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:13:26 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:13:26 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:13:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:13:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:13:26 INFO - Fetch https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:13:26 INFO - Expected file size: 16470423 06:13:34 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 06:13:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:13:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:13:34 INFO - Fetch https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:13:34 INFO - Expected file size: 16470423 06:13:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:13:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:13:41 INFO - Fetch https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:13:42 INFO - Expected file size: 14414062 06:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:43 INFO - trying https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:13:43 INFO - Downloading https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/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 06:13:49 INFO - Downloaded 111545849 bytes. 06:13:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:13:49 INFO - mkdir: /builds/slave/test/properties 06:13:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:13:49 INFO - Writing to file /builds/slave/test/properties/build_url 06:13:49 INFO - Contents: 06:13:49 INFO - build_url:https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:13:49 INFO - Running post-action listener: _resource_record_post_action 06:13:49 INFO - Running post-action listener: set_extra_try_arguments 06:13:49 INFO - [mozharness: 2016-09-28 13:13:49.681841Z] Finished download-and-extract step (success) 06:13:49 INFO - [mozharness: 2016-09-28 13:13:49.681982Z] Running populate-webroot step. 06:13:49 INFO - Running pre-action listener: _resource_record_pre_action 06:13:49 INFO - Running main action method: populate_webroot 06:13:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:13:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:13:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:13:49 INFO - '--tppagecycles', 06:13:49 INFO - '7'], 06:13:49 INFO - 'tests': ['tsvgm']}}, 06:13:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:13:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:13:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:13:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:13:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:13:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:13:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:49 INFO - 'talos_options': ['--disable-e10s'], 06:13:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:13:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:13:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:49 INFO - 'talos_options': ['--disable-e10s'], 06:13:49 INFO - 'tests': ['damp', 'tps']}, 06:13:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:49 INFO - 'tests': ['damp', 'tps']}, 06:13:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:13:49 INFO - 'tests': ['dromaeo_dom']}, 06:13:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:13:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:13:49 INFO - 'tests': ['basic_compositor_video']}, 06:13:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:13:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:13:49 INFO - 'tests': ['a11yr', 06:13:49 INFO - 'ts_paint', 06:13:49 INFO - 'tpaint', 06:13:49 INFO - 'sessionrestore', 06:13:49 INFO - 'sessionrestore_no_auto_restore', 06:13:49 INFO - 'tabpaint']}, 06:13:49 INFO - 'other-e10s': {'tests': ['a11yr', 06:13:49 INFO - 'ts_paint', 06:13:49 INFO - 'tpaint', 06:13:49 INFO - 'sessionrestore', 06:13:49 INFO - 'sessionrestore_no_auto_restore', 06:13:49 INFO - 'tabpaint']}, 06:13:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:13:49 INFO - 'ts_paint', 06:13:49 INFO - 'tpaint', 06:13:49 INFO - 'sessionrestore', 06:13:49 INFO - 'sessionrestore_no_auto_restore', 06:13:49 INFO - 'tabpaint']}, 06:13:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:13:49 INFO - 'ts_paint', 06:13:49 INFO - 'tpaint', 06:13:49 INFO - 'sessionrestore', 06:13:49 INFO - 'sessionrestore_no_auto_restore', 06:13:49 INFO - 'tabpaint']}, 06:13:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:13:49 INFO - 'tests': ['a11yr', 06:13:49 INFO - 'ts_paint', 06:13:49 INFO - 'tpaint', 06:13:49 INFO - 'sessionrestore', 06:13:49 INFO - 'sessionrestore_no_auto_restore', 06:13:49 INFO - 'tabpaint']}, 06:13:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:13:49 INFO - 'tests': ['a11yr', 06:13:49 INFO - 'ts_paint', 06:13:49 INFO - 'tpaint', 06:13:49 INFO - 'sessionrestore', 06:13:49 INFO - 'sessionrestore_no_auto_restore', 06:13:49 INFO - 'tabpaint']}, 06:13:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:13:49 INFO - 'tests': ['tsvgx', 06:13:49 INFO - 'tsvgr_opacity', 06:13:49 INFO - 'tart', 06:13:49 INFO - 'tscrollx', 06:13:49 INFO - 'cart']}, 06:13:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:13:49 INFO - 'tsvgr_opacity', 06:13:49 INFO - 'tart', 06:13:49 INFO - 'tscrollx', 06:13:49 INFO - 'cart']}, 06:13:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:49 INFO - 'talos_options': ['--disable-e10s'], 06:13:49 INFO - 'tests': ['tp5o']}, 06:13:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:49 INFO - 'tests': ['tp5o']}, 06:13:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:49 INFO - 'talos_options': ['--disable-e10s', 06:13:49 INFO - '--xperf_path', 06:13:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:13:49 INFO - 'tests': ['tp5n']}, 06:13:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:13:49 INFO - 'talos_options': ['--xperf_path', 06:13:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:13:49 INFO - 'tests': ['tp5n']}}, 06:13:49 INFO - 'talos.zip': {'path': '', 06:13:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:13:49 INFO - Running post-action listener: _resource_record_post_action 06:13:49 INFO - [mozharness: 2016-09-28 13:13:49.700873Z] Finished populate-webroot step (success) 06:13:49 INFO - [mozharness: 2016-09-28 13:13:49.700987Z] Running create-virtualenv step. 06:13:49 INFO - Running pre-action listener: _resource_record_pre_action 06:13:49 INFO - Running main action method: create_virtualenv 06:13:49 INFO - Creating virtualenv /builds/slave/test/build/venv 06:13:49 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 06:13:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:13:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:13:49 INFO - Using real prefix '/tools/python27' 06:13:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:13:50 INFO - Installing distribute.............................................................................................................................................................................................done. 06:13:53 INFO - Installing pip.................done. 06:13:53 INFO - Return code: 0 06:13:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:13:53 INFO - Reading from file tmpfile_stdout 06:13:53 INFO - Output received: 06:13:53 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) 06:13:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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')]} 06:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105fdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f55570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4bad51370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df3d30>, '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 0x105c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105debb20>, '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.y5Oc9dI4ru/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.MlszoWiDXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 06:13:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:13:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y5Oc9dI4ru/Render', 06:13:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:53 INFO - 'HOME': '/Users/cltbld', 06:13:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:53 INFO - 'LOGNAME': 'cltbld', 06:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:53 INFO - 'MOZ_NO_REMOTE': '1', 06:13:53 INFO - 'NO_EM_RESTART': '1', 06:13:53 INFO - 'PAGER': '/bin/cat', 06:13:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:53 INFO - 'PWD': '/builds/slave/test', 06:13:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:53 INFO - 'SHELL': '/bin/bash', 06:13:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MlszoWiDXY/Listeners', 06:13:53 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 06:13:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:53 INFO - 'USER': 'cltbld', 06:13:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:53 INFO - 'XPC_FLAGS': '0x0', 06:13:53 INFO - 'XPC_SERVICE_NAME': '0', 06:13:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:53 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 06:13:53 INFO - Cleaning up... 06:13:53 INFO - Return code: 0 06:13:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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')]} 06:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105fdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f55570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4bad51370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df3d30>, '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 0x105c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105debb20>, '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.y5Oc9dI4ru/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.MlszoWiDXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 06:13:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:13:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y5Oc9dI4ru/Render', 06:13:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:53 INFO - 'HOME': '/Users/cltbld', 06:13:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:53 INFO - 'LOGNAME': 'cltbld', 06:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:53 INFO - 'MOZ_NO_REMOTE': '1', 06:13:53 INFO - 'NO_EM_RESTART': '1', 06:13:53 INFO - 'PAGER': '/bin/cat', 06:13:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:53 INFO - 'PWD': '/builds/slave/test', 06:13:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:53 INFO - 'SHELL': '/bin/bash', 06:13:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MlszoWiDXY/Listeners', 06:13:53 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 06:13:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:53 INFO - 'USER': 'cltbld', 06:13:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:53 INFO - 'XPC_FLAGS': '0x0', 06:13:53 INFO - 'XPC_SERVICE_NAME': '0', 06:13:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:54 INFO - Downloading/unpacking psutil>=3.1.1 06:13:54 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 06:13:54 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 06:13:54 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 06:13:54 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 06:13:54 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 06:13:54 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 06:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:13:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:13:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:13:58 INFO - Installing collected packages: psutil 06:13:58 INFO - Running setup.py install for psutil 06:13:58 INFO - building 'psutil._psutil_osx' extension 06:13:58 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 06:13:58 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 06:13:58 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 06:13:58 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 06:13:59 INFO - building 'psutil._psutil_posix' extension 06:13:59 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 06:13:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:13:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:13:59 INFO - ^ 06:13:59 INFO - 1 warning generated. 06:13:59 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 06:13:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:13:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:13:59 INFO - Successfully installed psutil 06:13:59 INFO - Cleaning up... 06:13:59 INFO - Return code: 0 06:13:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:13:59 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')]} 06:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:59 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')]} 06:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:59 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 0x105fdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f55570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4bad51370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df3d30>, '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 0x105c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105debb20>, '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.y5Oc9dI4ru/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.MlszoWiDXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 06:13:59 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 06:13:59 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 06:13:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y5Oc9dI4ru/Render', 06:13:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:13:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:13:59 INFO - 'HOME': '/Users/cltbld', 06:13:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:13:59 INFO - 'LOGNAME': 'cltbld', 06:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:59 INFO - 'MOZ_NO_REMOTE': '1', 06:13:59 INFO - 'NO_EM_RESTART': '1', 06:13:59 INFO - 'PAGER': '/bin/cat', 06:13:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:59 INFO - 'PWD': '/builds/slave/test', 06:13:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:13:59 INFO - 'SHELL': '/bin/bash', 06:13:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MlszoWiDXY/Listeners', 06:13:59 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 06:13:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:13:59 INFO - 'USER': 'cltbld', 06:13:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:13:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:59 INFO - 'XPC_FLAGS': '0x0', 06:13:59 INFO - 'XPC_SERVICE_NAME': '0', 06:13:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:13:59 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 06:13:59 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 06:13:59 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 06:13:59 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 06:13:59 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 06:13:59 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 06:14:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:14:02 INFO - Installing collected packages: mozsystemmonitor 06:14:02 INFO - Running setup.py install for mozsystemmonitor 06:14:02 INFO - Successfully installed mozsystemmonitor 06:14:02 INFO - Cleaning up... 06:14:02 INFO - Return code: 0 06:14:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:14:02 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')]} 06:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:02 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')]} 06:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:02 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 0x105fdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f55570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4bad51370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df3d30>, '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 0x105c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105debb20>, '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.y5Oc9dI4ru/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.MlszoWiDXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 06:14:02 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 06:14:02 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 06:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y5Oc9dI4ru/Render', 06:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:02 INFO - 'HOME': '/Users/cltbld', 06:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:02 INFO - 'LOGNAME': 'cltbld', 06:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:02 INFO - 'MOZ_NO_REMOTE': '1', 06:14:02 INFO - 'NO_EM_RESTART': '1', 06:14:02 INFO - 'PAGER': '/bin/cat', 06:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:02 INFO - 'PWD': '/builds/slave/test', 06:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:02 INFO - 'SHELL': '/bin/bash', 06:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MlszoWiDXY/Listeners', 06:14:02 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 06:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:02 INFO - 'USER': 'cltbld', 06:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:02 INFO - 'XPC_FLAGS': '0x0', 06:14:02 INFO - 'XPC_SERVICE_NAME': '0', 06:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:02 INFO - Downloading/unpacking jsonschema==2.5.1 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:14:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14:05 INFO - Downloading functools32-3.2.3-2.tar.gz 06:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:14:05 INFO - warning: no files found matching '*.txt' 06:14:05 INFO - no previously-included directories found matching 'build' 06:14:05 INFO - no previously-included directories found matching 'dist' 06:14:05 INFO - no previously-included directories found matching '.git*' 06:14:05 INFO - Installing collected packages: jsonschema, functools32 06:14:05 INFO - Running setup.py install for functools32 06:14:05 INFO - warning: no files found matching '*.txt' 06:14:05 INFO - no previously-included directories found matching 'build' 06:14:05 INFO - no previously-included directories found matching 'dist' 06:14:05 INFO - no previously-included directories found matching '.git*' 06:14:05 INFO - Successfully installed jsonschema functools32 06:14:05 INFO - Cleaning up... 06:14:05 INFO - Return code: 0 06:14:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:05 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 0x105fdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f55570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4bad51370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df3d30>, '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 0x105c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105debb20>, '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.y5Oc9dI4ru/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.MlszoWiDXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 06:14:05 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 06:14:05 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 06:14:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y5Oc9dI4ru/Render', 06:14:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:05 INFO - 'HOME': '/Users/cltbld', 06:14:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:05 INFO - 'LOGNAME': 'cltbld', 06:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:05 INFO - 'MOZ_NO_REMOTE': '1', 06:14:05 INFO - 'NO_EM_RESTART': '1', 06:14:05 INFO - 'PAGER': '/bin/cat', 06:14:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:05 INFO - 'PWD': '/builds/slave/test', 06:14:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:05 INFO - 'SHELL': '/bin/bash', 06:14:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MlszoWiDXY/Listeners', 06:14:05 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 06:14:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:05 INFO - 'USER': 'cltbld', 06:14:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:05 INFO - 'XPC_FLAGS': '0x0', 06:14:05 INFO - 'XPC_SERVICE_NAME': '0', 06:14:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:14:06 INFO - Cleaning up... 06:14:06 INFO - Return code: 0 06:14:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:06 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 0x105fdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f55570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4bad51370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df3d30>, '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 0x105c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105debb20>, '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.y5Oc9dI4ru/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.MlszoWiDXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 06:14:06 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 06:14:06 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 06:14:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y5Oc9dI4ru/Render', 06:14:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:06 INFO - 'HOME': '/Users/cltbld', 06:14:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:06 INFO - 'LOGNAME': 'cltbld', 06:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:06 INFO - 'MOZ_NO_REMOTE': '1', 06:14:06 INFO - 'NO_EM_RESTART': '1', 06:14:06 INFO - 'PAGER': '/bin/cat', 06:14:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:06 INFO - 'PWD': '/builds/slave/test', 06:14:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:06 INFO - 'SHELL': '/bin/bash', 06:14:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MlszoWiDXY/Listeners', 06:14:06 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 06:14:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:06 INFO - 'USER': 'cltbld', 06:14:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:06 INFO - 'XPC_FLAGS': '0x0', 06:14:06 INFO - 'XPC_SERVICE_NAME': '0', 06:14:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:06 INFO - Downloading/unpacking blobuploader==1.2.4 06:14:06 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 06:14:06 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 06:14:06 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 06:14:06 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 06:14:06 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 06:14:06 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 06:14:08 INFO - Downloading blobuploader-1.2.4.tar.gz 06:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:14:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:14:09 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 06:14:09 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 06:14:09 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 06:14:09 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 06:14:09 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 06:14:09 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 06:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:14:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:14:09 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 06:14:09 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 06:14:09 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 06:14:09 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 06:14:09 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 06:14:09 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 06:14:10 INFO - Downloading docopt-0.6.1.tar.gz 06:14:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:14:10 INFO - Installing collected packages: blobuploader, requests, docopt 06:14:10 INFO - Running setup.py install for blobuploader 06:14:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:14:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:14:10 INFO - Running setup.py install for requests 06:14:10 INFO - Running setup.py install for docopt 06:14:10 INFO - Successfully installed blobuploader requests docopt 06:14:10 INFO - Cleaning up... 06:14:11 INFO - Return code: 0 06:14:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:11 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 0x105fdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f55570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4bad51370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df3d30>, '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 0x105c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105debb20>, '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.y5Oc9dI4ru/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.MlszoWiDXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 06:14:11 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 06:14:11 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 06:14:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y5Oc9dI4ru/Render', 06:14:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:11 INFO - 'HOME': '/Users/cltbld', 06:14:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:11 INFO - 'LOGNAME': 'cltbld', 06:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:11 INFO - 'MOZ_NO_REMOTE': '1', 06:14:11 INFO - 'NO_EM_RESTART': '1', 06:14:11 INFO - 'PAGER': '/bin/cat', 06:14:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:11 INFO - 'PWD': '/builds/slave/test', 06:14:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:11 INFO - 'SHELL': '/bin/bash', 06:14:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MlszoWiDXY/Listeners', 06:14:11 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 06:14:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:11 INFO - 'USER': 'cltbld', 06:14:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:11 INFO - 'XPC_FLAGS': '0x0', 06:14:11 INFO - 'XPC_SERVICE_NAME': '0', 06:14:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:11 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-RVYYb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:11 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-K5fVyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:11 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-T6okES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:11 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-rQ1BQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:11 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-ohKmkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:11 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-AVajbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:11 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-vaiVRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:12 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-VP8le0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:12 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-vOMCSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:12 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-IBbn8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:12 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-jqTV4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:12 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-uKG2uB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:12 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-CUJnRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:12 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-4zDYW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:12 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-V_tZ8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:12 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-kCAnu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:13 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-xH21NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:14:13 INFO - Running setup.py install for manifestparser 06:14:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:14:13 INFO - Running setup.py install for mozcrash 06:14:13 INFO - Running setup.py install for mozdebug 06:14:13 INFO - Running setup.py install for mozdevice 06:14:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:14:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:14:13 INFO - Running setup.py install for mozfile 06:14:13 INFO - Running setup.py install for mozhttpd 06:14:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:14:14 INFO - Running setup.py install for mozinfo 06:14:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:14:14 INFO - Running setup.py install for mozInstall 06:14:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:14:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:14:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:14:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:14:14 INFO - Running setup.py install for mozleak 06:14:14 INFO - Running setup.py install for mozlog 06:14:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:14:14 INFO - Running setup.py install for moznetwork 06:14:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:14:14 INFO - Running setup.py install for mozprocess 06:14:14 INFO - Running setup.py install for mozprofile 06:14:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:14:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:14:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:14:15 INFO - Running setup.py install for mozrunner 06:14:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:14:15 INFO - Running setup.py install for mozscreenshot 06:14:15 INFO - Running setup.py install for moztest 06:14:15 INFO - Running setup.py install for mozversion 06:14:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:14:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:14:15 INFO - Cleaning up... 06:14:15 INFO - Return code: 0 06:14:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:15 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 0x105fdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f55570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4bad51370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df3d30>, '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 0x105c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105debb20>, '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.y5Oc9dI4ru/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.MlszoWiDXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 06:14:15 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 06:14:15 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 06:14:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y5Oc9dI4ru/Render', 06:14:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:15 INFO - 'HOME': '/Users/cltbld', 06:14:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:15 INFO - 'LOGNAME': 'cltbld', 06:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:15 INFO - 'MOZ_NO_REMOTE': '1', 06:14:15 INFO - 'NO_EM_RESTART': '1', 06:14:15 INFO - 'PAGER': '/bin/cat', 06:14:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:15 INFO - 'PWD': '/builds/slave/test', 06:14:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:15 INFO - 'SHELL': '/bin/bash', 06:14:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MlszoWiDXY/Listeners', 06:14:15 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 06:14:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:15 INFO - 'USER': 'cltbld', 06:14:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:15 INFO - 'XPC_FLAGS': '0x0', 06:14:15 INFO - 'XPC_SERVICE_NAME': '0', 06:14:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:16 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-7nGuum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:16 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)) 06:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:16 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-mg5aV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:16 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)) 06:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:16 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-J79mXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:16 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)) 06:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:16 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-FhVUuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:16 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)) 06:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:16 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-QuFF9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:16 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)) 06:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:16 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-HtzrWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:16 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)) 06:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:16 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-tEjFBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:16 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)) 06:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:16 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-bBnKbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:16 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)) 06:14:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:16 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-tw4618-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:17 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)) 06:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:17 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-LXt4xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:17 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)) 06:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:17 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-aqfKO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:17 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)) 06:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:17 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-i0RVMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:17 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)) 06:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:17 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-wbE7ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:17 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)) 06:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:17 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-RZPFSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:17 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)) 06:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:17 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-sGimUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:17 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)) 06:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:17 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-cS7jgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:17 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)) 06:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:17 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-yjzadz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:17 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)) 06:14:17 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)) 06:14:17 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)) 06:14:17 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)) 06:14:17 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)) 06:14:17 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)) 06:14:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:14:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:20 INFO - Downloading blessings-1.6.tar.gz 06:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:14:20 INFO - Installing collected packages: blessings 06:14:20 INFO - Running setup.py install for blessings 06:14:20 INFO - Successfully installed blessings 06:14:20 INFO - Cleaning up... 06:14:20 INFO - Return code: 0 06:14:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:14:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:14:21 INFO - Reading from file tmpfile_stdout 06:14:21 INFO - Current package versions: 06:14:21 INFO - blessings == 1.6 06:14:21 INFO - blobuploader == 1.2.4 06:14:21 INFO - docopt == 0.6.1 06:14:21 INFO - functools32 == 3.2.3-2 06:14:21 INFO - jsonschema == 2.5.1 06:14:21 INFO - manifestparser == 1.1 06:14:21 INFO - mozInstall == 1.12 06:14:21 INFO - mozcrash == 0.17 06:14:21 INFO - mozdebug == 0.1 06:14:21 INFO - mozdevice == 0.48 06:14:21 INFO - mozfile == 1.2 06:14:21 INFO - mozhttpd == 0.7 06:14:21 INFO - mozinfo == 0.9 06:14:21 INFO - mozleak == 0.1 06:14:21 INFO - mozlog == 3.4 06:14:21 INFO - moznetwork == 0.27 06:14:21 INFO - mozprocess == 0.23 06:14:21 INFO - mozprofile == 0.28 06:14:21 INFO - mozrunner == 6.12 06:14:21 INFO - mozscreenshot == 0.1 06:14:21 INFO - mozsystemmonitor == 0.3 06:14:21 INFO - moztest == 0.7 06:14:21 INFO - mozversion == 1.4 06:14:21 INFO - psutil == 3.1.1 06:14:21 INFO - requests == 1.2.3 06:14:21 INFO - wsgiref == 0.1.2 06:14:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:21 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')]} 06:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:21 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')]} 06:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:21 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 0x105fdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f55570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4bad51370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df3d30>, '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 0x105c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105debb20>, '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.y5Oc9dI4ru/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.MlszoWiDXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 06:14:21 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 06:14:21 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 06:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y5Oc9dI4ru/Render', 06:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:21 INFO - 'HOME': '/Users/cltbld', 06:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:21 INFO - 'LOGNAME': 'cltbld', 06:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:21 INFO - 'MOZ_NO_REMOTE': '1', 06:14:21 INFO - 'NO_EM_RESTART': '1', 06:14:21 INFO - 'PAGER': '/bin/cat', 06:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:21 INFO - 'PWD': '/builds/slave/test', 06:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:21 INFO - 'SHELL': '/bin/bash', 06:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MlszoWiDXY/Listeners', 06:14:21 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 06:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:21 INFO - 'USER': 'cltbld', 06:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:21 INFO - 'XPC_FLAGS': '0x0', 06:14:21 INFO - 'XPC_SERVICE_NAME': '0', 06:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:21 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)) 06:14:21 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)) 06:14:21 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)) 06:14:21 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)) 06:14:21 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)) 06:14:21 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)) 06:14:21 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)) 06:14:21 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)) 06:14:21 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)) 06:14:21 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)) 06:14:21 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)) 06:14:21 INFO - Cleaning up... 06:14:21 INFO - Return code: 0 06:14:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:14:21 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')]} 06:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:21 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')]} 06:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105fdf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f55570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4bad51370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df3d30>, '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 0x105c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105debb20>, '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.y5Oc9dI4ru/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.MlszoWiDXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 06:14:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y5Oc9dI4ru/Render', 06:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:21 INFO - 'HOME': '/Users/cltbld', 06:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:21 INFO - 'LOGNAME': 'cltbld', 06:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:21 INFO - 'MOZ_NO_REMOTE': '1', 06:14:21 INFO - 'NO_EM_RESTART': '1', 06:14:21 INFO - 'PAGER': '/bin/cat', 06:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:21 INFO - 'PWD': '/builds/slave/test', 06:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:21 INFO - 'SHELL': '/bin/bash', 06:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MlszoWiDXY/Listeners', 06:14:21 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 06:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:21 INFO - 'USER': 'cltbld', 06:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:21 INFO - 'XPC_FLAGS': '0x0', 06:14:21 INFO - 'XPC_SERVICE_NAME': '0', 06:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:14:21 INFO - Cleaning up... 06:14:21 INFO - Return code: 0 06:14:21 INFO - Running post-action listener: _resource_record_post_action 06:14:21 INFO - Running post-action listener: _start_resource_monitoring 06:14:21 INFO - Starting resource monitoring. 06:14:21 INFO - [mozharness: 2016-09-28 13:14:21.580949Z] Finished create-virtualenv step (success) 06:14:21 INFO - [mozharness: 2016-09-28 13:14:21.582003Z] Running install step. 06:14:21 INFO - Running pre-action listener: _resource_record_pre_action 06:14:21 INFO - Running main action method: install 06:14:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:14:21 INFO - Reading from file tmpfile_stdout 06:14:21 INFO - Detecting whether we're running mozinstall >=1.0... 06:14:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:14:21 INFO - Reading from file tmpfile_stdout 06:14:21 INFO - Output received: 06:14:21 INFO - Usage: mozinstall [options] installer 06:14:21 INFO - Options: 06:14:21 INFO - -h, --help show this help message and exit 06:14:21 INFO - -d DEST, --destination=DEST 06:14:21 INFO - Directory to install application into. [default: 06:14:21 INFO - "/builds/slave/test"] 06:14:21 INFO - --app=APP Application being installed. [default: firefox] 06:14:21 INFO - mkdir: /builds/slave/test/build/application 06:14:21 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'] 06:14:21 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 06:14:56 INFO - Reading from file tmpfile_stdout 06:14:56 INFO - Output received: 06:14:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:14:56 INFO - Running post-action listener: _resource_record_post_action 06:14:56 INFO - [mozharness: 2016-09-28 13:14:56.772474Z] Finished install step (success) 06:14:56 INFO - [mozharness: 2016-09-28 13:14:56.772638Z] Running run-tests step. 06:14:56 INFO - Running pre-action listener: _resource_record_pre_action 06:14:56 INFO - Running main action method: run_tests 06:14:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:14:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:14:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:14:56 INFO - 2016-09-28 06:14:56.787 screenresolution[1650:8191] starting screenresolution argv=screenresolution get 06:14:56 INFO - 2016-09-28 06:14:56.790 screenresolution[1650:8191] Display 0: 1600x1200x32@60 06:14:56 INFO - 2016-09-28 06:14:56.796 screenresolution[1651:8193] starting screenresolution argv=screenresolution list 06:14:56 INFO - Available Modes on Display 0 06:14:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:14:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:14:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:14:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:14:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:14:57 INFO - Intel Iris: 06:14:57 INFO - Chipset Model: Intel Iris 06:14:57 INFO - Type: GPU 06:14:57 INFO - Bus: Built-In 06:14:57 INFO - VRAM (Dynamic, Max): 1536 MB 06:14:57 INFO - Vendor: Intel (0x8086) 06:14:57 INFO - Device ID: 0x0a2e 06:14:57 INFO - Revision ID: 0x0009 06:14:57 INFO - Displays: 06:14:57 INFO - Display: 06:14:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:14:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:14:57 INFO - Display Serial Number: 1600x1200 60 06:14:57 INFO - Main Display: Yes 06:14:57 INFO - Mirror: Off 06:14:57 INFO - Online: Yes 06:14:57 INFO - Rotation: Supported 06:14:57 INFO - Return code: 0 06:14:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:14:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:14:57 INFO - Python 2.7.3 06:14:57 INFO - Return code: 0 06:14:57 INFO - grabbing minidump binary from tooltool 06:14:57 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')]} 06:14:57 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 0x105df3d30>, '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 0x105c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105debb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:14:57 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 06:14:57 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 06:14:57 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 06:14:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:14:57 INFO - Return code: 0 06:14:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:14:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:14:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:14:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:14:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:14:57 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0142', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:14:57 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0142 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:14:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y5Oc9dI4ru/Render', 06:14:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:14:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:14:57 INFO - 'HOME': '/Users/cltbld', 06:14:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:14:57 INFO - 'LOGNAME': 'cltbld', 06:14:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:14:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:57 INFO - 'MOZ_NO_REMOTE': '1', 06:14:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:14:57 INFO - 'NO_EM_RESTART': '1', 06:14:57 INFO - 'PAGER': '/bin/cat', 06:14:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:57 INFO - 'PWD': '/builds/slave/test', 06:14:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:14:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:14:57 INFO - 'SHELL': '/bin/bash', 06:14:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MlszoWiDXY/Listeners', 06:14:57 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 06:14:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:14:57 INFO - 'USER': 'cltbld', 06:14:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:14:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:57 INFO - 'XPC_FLAGS': '0x0', 06:14:57 INFO - 'XPC_SERVICE_NAME': '0', 06:14:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:14:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0142', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:14:57 INFO - mozversion application_buildid: 20160928041920 06:14:57 INFO - mozversion application_changeset: fc513f0359ebca43d8b791a458583aeb3bb37f42 06:14:57 INFO - mozversion application_display_name: Nightly 06:14:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:14:57 INFO - mozversion application_name: Firefox 06:14:57 INFO - mozversion application_remotingname: firefox 06:14:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:14:57 INFO - mozversion application_vendor: Mozilla 06:14:57 INFO - mozversion application_version: 52.0a1 06:14:57 INFO - mozversion platform_buildid: 20160928041920 06:14:57 INFO - mozversion platform_changeset: fc513f0359ebca43d8b791a458583aeb3bb37f42 06:14:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:14:57 INFO - mozversion platform_version: 52.0a1 06:14:57 INFO - using testdate: 1475068497 06:14:57 INFO - actual date: 1475068497 06:14:57 INFO - starting webserver on 'localhost:49276' 06:14:57 INFO - SUITE-START | Running 2 tests 06:14:57 INFO - TEST-START | dromaeo_css 06:14:57 INFO - operating with platform_type : mac_ 06:14:57 INFO - Initialising browser for dromaeo_css test... 06:14:57 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmptLwNR9/profile http://localhost:49276/getInfo.html) 06:15:00 INFO - PROCESS | 1661 | 2016-09-28 06:15:00.306 plugin-container[1664:8371] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x474b, name = 'com.apple.tsm.portname' 06:15:00 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:15:00 INFO - PROCESS | 1661 | 2016-09-28 06:15:00.309 plugin-container[1664:8371] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d1f, name = 'com.apple.CFPasteboardClient' 06:15:00 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:15:00 INFO - PROCESS | 1661 | 2016-09-28 06:15:00.309 plugin-container[1664:8371] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:15:00 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 06:15:00 INFO - PROCESS | 1661 | colorDepth:24 06:15:00 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 06:15:00 INFO - PROCESS | 1661 | __metrics 06:15:00 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 06:15:01 INFO - TEST-INFO | 1661: exit 0 06:15:01 INFO - Browser initialized. 06:15:01 INFO - Running cycle 1/1 for dromaeo_css test... 06:15:01 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmptLwNR9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:15:03 INFO - PROCESS | 1665 | 2016-09-28 06:15:03.587 plugin-container[1666:8483] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8823, name = 'com.apple.tsm.portname' 06:15:03 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:15:03 INFO - PROCESS | 1665 | 2016-09-28 06:15:03.590 plugin-container[1666:8483] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d03, name = 'com.apple.CFPasteboardClient' 06:15:03 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:15:03 INFO - PROCESS | 1665 | 2016-09-28 06:15:03.590 plugin-container[1666:8483] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:15:13 INFO - PROCESS | 1665 | RSS: Main: 239915008 06:15:13 INFO - PROCESS | 1665 | 06:16:02 INFO - PROCESS | 1665 | 1475068562774 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] 06:18:14 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 06:18:16 INFO - PROCESS | 1665 | RSS: Main: 255152128 06:18:16 INFO - PROCESS | 1665 | 06:21:18 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 06:21:19 INFO - PROCESS | 1665 | RSS: Main: 265490432 06:21:19 INFO - PROCESS | 1665 | 06:24:21 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 06:24:21 INFO - PROCESS | 1665 | RSS: Main: 270065664 06:24:21 INFO - PROCESS | 1665 | 06:27:23 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 06:27:24 INFO - PROCESS | 1665 | RSS: Main: 269594624 06:27:24 INFO - PROCESS | 1665 | 06:30:27 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 06:30:27 INFO - PROCESS | 1665 | RSS: Main: 274898944 06:30:27 INFO - PROCESS | 1665 | 06:33:30 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 06:33:30 INFO - PROCESS | 1665 | RSS: Main: 277639168 06:33:30 INFO - PROCESS | 1665 | 06:33:30 INFO - PROCESS | 1665 | __start_tp_report 06:33:30 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 06:33:30 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 06:33:30 INFO - PROCESS | 1665 | |i|pagename|runs| 06:33:30 INFO - PROCESS | 1665 | |0;dojo.html;3268.1012721501584;3368.4273673475514;3387.1532116970757;3393.9321213575713;3430.5883294004725;5601.775928962837;5670.8582285442935;5698.145278208266;5721.199032135499;5788.942110578893;5668.348139963905;5710.7430165642545;5728.369879313273;5797.82606521804;5853.560982926287;5195.740212989354;5213.296205012312;5248.737563121847;5335.573154147659;5371;5351.143816989283;5372.167314066326;5389.434109418514;5403.83788486346;5412.322369272754;5159.7678104485385;5205.55752761012;5267.104592219332;5313.495217954288;5358.196270559409;5152.252923326134;5175.844724658228;5189.481051894781;5293.841184764425;5344.038073146832;5201.141811601081;5225.634205605571;5229.346331708536;5271.37194285856;5292.761825717852;4294.699371044028;5601.047821870292;5734;5736.627119237236;5746.195532625436;6103.034636161418;6104.762330457774;6168.444839964424;6176.81469555914;6267.435930766207;6240.438360547527;6246.906296405557;6263.561550691454;6265.154204182468;6265.906011409833;5885.440883116097;5913.965056115163;5922.063966648632;5923.792667256668;5982.551308651781;6152.89247935367;6175.2898416681755;6183.072539119078;6183.721732521957;6198.659073750897;6196.225471816023;6198.0702894565275;6202;6207.34822843604;6208.751649933952;6254.3745625437095;6283.214598175228;6286.182796236551;6296.307406185316;6297.464715499143;5961.7615295387695;6110.3765049759795;6146.692665366714;6151.446369826647;6173.166622505994;6210.5652604317265;6233.594816336924;6238.095476156022;6238.6880655967925;6243.43809057187;4675.485696573374;4910.8281210157475;4932.112219800399;4937.1113199624415;4954.455009948902;4340.717853339523;4377.934330985037;4412.646988240933;4493.056458143761;4514.029483661028;5894.705264736832;5912.733926973297;6013.6692481913915;6054.606450580698;6105.908411373833;6209.875802484015;6219.689015549295;6235.407636274546;6254.6872656366995;6264.686765661699;5738.139279108167;5806.564507661942;5966.671833049224;6004.789832355847;6039.818805435844;4513.932291015637;4722.386089808303;5400.567954563626;5438.8912221755345;5449.64577302474;6317.936820631919;6327.4938004959495;6333.746650133943;6334.271558770801;6335.524835637346;6145.446909778141;6252.437280644764;6265.561410701207;6276.780312689034;6289.08808222796;6159.260888693386;6198.318184999556;6216.160818289473;6256.812295631138;6362.459190968634;6198.845028874314;6230.719617617308;6253.874922501615;6269.74921003173;6273.780417685359;6245.250569931637;6248.094026366242;6249.937500624936;6263.78076767311;6264.091706702411;5920.37836027211;6052.244848993742;6103.664298463627;6118.984682626333;6138.447539721446;6131.386861313833;6164.106204600397;6204.441600255998;6212.88761820983;6216.502679785697;5775.104858746901;5876.911846322394;6018.187544681412;6018.217631708025;6041.150297130313;6047.697615119138;6100.572959892765;6130.754769809336;6149.815505534841;6188.628682279078;5952.5833191676165;6002.949483840398;6019.157317975574;6042.456178943916;6069.9984502558345 06:33:30 INFO - PROCESS | 1665 | |1;ext.html;472.7966974201094;482.4331410592553;527.588480984832;529.9692098867702;539.870431096537;38581.61418385815;40829.183416331696;40871.795641021825;40935.77192684217;40963.38554921671;42167;42328.57671423285;42627;42689.35965960513;42802.57197428025;9816.312858099955;9923.503824808768;10006.899931000706;10014.198864090891;10050.74873128174;9709.805803883917;9790.216782657406;9791.167750741195;9804.166645835112;9829.115379615832;9791;9809.607615695364;9825;9833;9838.212942964547;9781.364211326241;9811.656592019317;9814.90185098147;9815.852762208573;9830.066143716336;9769.951150244275;9855.2608554358;9859.852102218472;9863.950680246553;9899.059589339002;39675.60324396748;40175;40277.99305017369;40535.39196912049;40561.18877622431;3162.7469802415753;3311.122552523583;3430.828458577086;3811.8475260989526;3943.5662077171487;30321.69678303233;30693.846530767427;30735;30851.845740771154;31846.522302165486;2986;3167.2398624330226;3243.9026829195163;3264.396086723964;3356.4461863792444;383217;386896;387175;388160;388408;53563.73218133884;57875.421245787846;58107;58132.41867581355;58183.12725309124;26302.86848565745;28407.43185136327;30278.54582181269;35659.10852228715;51119.744401277756;13979.930100349637;16148.596285092732;16150;16325.83674163267;16379.42672006498;10734.892651073389;12422;12528.686782830502;12645.936770316273;12704;19307;19327.613447730968;19334.163254490803;19348.129334179997;19432.931188784754;7949.165337639581;8014.599270036475;8032.718854840053;8078.474899131537;8118;720.7818786251219;1005.9899401006043;1028.275066078413;1051.2746205118444;1059.4596755654673;29673.54304023343;30162.327290152316;30371;30599.694003059685;30663.38673226523;1030.9175265978704;1058.5077938758361;1106.7288514314046;1108.3017698849835;1116.4640972333325;13938.721225575431;14864.405423782928;15583.987040842308;15711.842881571267;16309.755353669705;533218.3339083358;536148.1925903689;536889;538776;539332;56511.71744141253;56644.43355566474;56945.715271423374;56973;57348.71325643345;1209.9231683801424;1291.4963164365904;1312.1405479411;1318.9472421103048;1329.1493444195723;29604.111876643736;29694;29766.255843603216;30202.69797301999;30531.084067478012;53317.733411332694;54955.45044549663;54989.62525936883;58271.70864145652;58274.4172558269;489686;493372;498925;499516;501031.4948425235;41100.58899411087;41638.16723665449;41855.7907210462;41921.580784192985;42070.94822629336;47205.76397117993;47456.050878981536;47474.28788568105;48586.75706621444;49011.01977960492;34059.65940340565;36003.27993440169;38285.808570956964;38869.02827429337;40083.799581001906;38944;39058.6094139055;39726.60273397229;40036.59963400329;40140.99647508719;36806.07984800402;37207.069823254635;37659.43510847395;38380.04049898775;38645.2270954585;32916.670833292315;34417.65582344145;34513.32728378632;34899;35067.123321917155;25457.23628291154;25568.48863022692;25767.6134857981;25991.350216244744;26163.476730464903 06:33:30 INFO - PROCESS | 1665 | |2;jquery.html;360.1536389484711;369.2227860353955;371.76207227374476;377.3848626738416;386.248746188663;19117.61764764704;19472.805271947294;19666.410007699757;20108.798912010894;20249.987500624946;9091.272698184146;10006.299559030871;19195.520111997208;19251.711224331648;19849.900750496265;4315.741055536662;5362.981033603623;5651.378348381675;5657.264555607765;5663.377028526858;5356.625036247464;5411.404745477994;5520.723963801814;5561.666300021991;5564.248826408423;5423.674579525222;5454.699991500466;5561.972190139044;5594.328680558318;5600.383957764642;5214.374275086976;5527.281453411051;5879.735411906475;6172.814815555518;6226.719797609118;5835.883282334329;6012.819615411545;6068.3021452533085;6070;6089.908651370233;11873.515810523684;12405.62783116508;13400;13405.798913016313;13429.529966451226;2028.9188432462684;2044.9284275050302;2064.318774804326;2076.3667081540125;2562.359410147463;9957.90042099577;10145.188384929188;10170.338927969658;14331.28343582827;15805.60485987848;1838.1452624529659;1840.7146892231726;1848.159087615132;1900.515368581017;1954.1108795498014;101122.4943875276;109088;109238;109295.81408371868;109583;11426.542938282542;11615.709607259887;11625.128115391379;11653.242539234923;11880.643580692593;14421.35103920326;14436.927815360856;14444.422223110958;14459.710805783825;14473.348699308557;8253.09215986241;8427.578621068922;8440.029396619468;8449.577521124042;8577.442466239674;8283.047449543259;8310.335173186131;8438;8487.787805304917;8526.57367131641;3923.8822835314986;4193.97903010483;4456.844010459618;4575.496695363508;4619.3071039343695;1724.1206984438027;1937.643649445394;1962.8822270663807;1968.055333439957;2008.648486514854;786.622421237809;797.2266901105918;870.8127752533236;887.2547060469237;956.4500412262977;18514.722279165824;20591.79408205929;20800.89599552023;20929.89535052315;21117.27377204829;300.46217271084953;339.2756464947355;377.8607498392349;386.3162202900906;827.7227128911882;5073.518015788494;5152.02111598795;6064.636121832704;6111.816645500642;6234.37656234382;490311;532050;541744.2912785411;544091;555813;84545;107934;115356;124773;128244;374.91751814600747;429.60261757873843;453.920563901316;455.94528656561425;459.46013434214666;11268.098552115975;11312.511247525532;11446.885531144582;15024.624384390478;20065.699014514503;49666.255006175656;52766.944661105794;55329.723351382985;55383.446165537825;55495.72252138875;75443;75643.62178189073;76004.61997689976;76586.6170669143;77273.22726772886;5451.882364115426;6641.269460359454;7630.122535908219;8200.671973121009;8316.916830831615;10817.56729730802;13037.282949437871;13210.669733256746;13352.666183345495;13590.456381745014;11150.944245278723;11353.37556434404;11385.316880987168;11624.825627615422;11684.415779211175;10173.626560414545;10904.563817447213;10983.725406864573;11126.388048657402;11259.324440533594;10590.576376944837;11378.54485820558;11631;11720.179587428798;11910.52357905674;8270;8360.958195208985;8485.618147183515;8499.490030598185;8503.489790612335;9884.654037108667;11502.769944601228;11560.70518903268;11734.94132529332;11913.642590722293 06:33:30 INFO - PROCESS | 1665 | |3;mootools.html;1471.889608279379;1523.4972459088501;1679.5549179467444;1763.3916298876884;1771.867109966752;7921.247481489264;8204.630791614376;8396.370272229577;8968.641254349826;8969.955150224248;8488.575571221445;8809.03100658927;8821.206091451768;8929.330300227493;8952.283817294618;2367.124164059296;2372.466195106105;2396.945344048622;2406.8916898739512;2410.939726506843;2362.7164740231196;2378.4648454097864;2381.654660074288;2406.5186962607463;2411.9517609647796;2389.593769059264;2390.1395497620842;2402.327348342467;2406.68713067301;2408.0728919366084;2368.4789346343778;2374.6675465434855;2384.4873352229356;2386.7971222446026;2394.1381102802975;2355.9764402355927;2362.078789272185;2374.4538756086026;2375.70303712036;2379.976200237993;8874.245689116433;8980.820383592292;8992.370534062618;9037.005929347766;9047.140521650499;4813.109574728686;5004.948960718253;5356.6518176318805;5371.811986580451;5372.194170874361;3443.1736383267835;3570.410882204433;3635.8909232723063;3639.363111455511;3647.6352364763575;1049.7795462952713;1083.0469187115289;1085.7611325508376;1088.0533935476108;1105.3478447715806;11595.362255075968;11613.709657258636;11667.533298668042;11686.24039437434;11694.707632309175;4499.662525310615;4690.249560070372;4769.59458446029;4792.0895029944195;4800.66395352322;7920.5247685139075;9969.252306077073;10030.949845250872;10040.297179197532;10043.849342259871;5310.150375939831;5324.361076670747;5330.813421530228;5331.866703332447;5339.652922560099;3938.724289299779;4339.566043395698;4519.231730605805;4847.2729090636685;4862.294967229732;3816.2749077675153;3846.9038274042814;3906.648401643809;3942.7634341939574;3973.900652483653;1267.176335382009;1278.2266728629045;1278.7826069568196;1284.8137020132028;1287.2855565161237;753.9736109236151;795.316028215734;897.0894542039835;913.7761248494162;923.8221267883368;4713.538802971021;5494.230807686927;5830.650160990354;5848.766049357978;5912.201852749909;831.5218749219223;885.455444901381;888.2449917570013;900.8018235988072;913.9223166030962;3825.713071519647;3839.3856982882603;3843.6925045996254;3925.293447179535;3930.941035884464;8680.435771674822;10538;10815.67552973412;10900.945495272632;10908.890911090946;10789.19081068923;10865.239433239756;10865.456727163768;10866.891331086588;10890.836637450444;7629.54222746637;7965.761027169194;8181.75454736347;8182.713605023796;8323.417360784808;5824.825255242349;5854.882902341844;5881.38245484218;5973.283206015306;6067.423594758491;8036.87944680842;10166.288359814742;10219.540120694735;10291.125254353165;10327.380357178594;10019.54912028975;10410.427426491615;10455.529501172314;10469.424181670081;10472.842907356548;6029.78895738647;6942.097527321416;7149.785506434815;7166.749163779243;7672.117706463828;8353.331733461187;8421.115782842713;8592.140785921358;8611.8708219378;8613.138686131337;7235.674394652148;7436.144843342869;7670.923290767021;7677.078750549969;7711.922880771345;7214.422846172189;7357.668904899186;7359.632018399166;7494.250574942462;7520.285572870568;6989.545679530815;7019.438444924292;7027.648617568999;7055.929440705732;7058.294170582901;4133.9793301033305;4856.1987272099705;4953.678010929278;5021.472745361831;5024.0956627807345;4727.669063165683;4961.355023846877;4992.400911890451;5021.397432308147;5052.8484145475695 06:33:30 INFO - PROCESS | 1665 | |4;prototype.html;303.89971309467876;305.0436880380009;311.6447250134846;316.9857356418961;317.52212919556064;4599.6320294376455;5490.313710786152;5579.85612949346;5620.325560932689;5711.114777209529;4651.581357677808;4735.550122738343;5068.72122033288;5428.4300148484435;5537.36320323163;4183.184279065584;4226.72526285792;4231.1960727461765;4232.174725928445;4254.383114448403;3920.941185882214;4168.270552653289;4234.36976763945;4246.152923478281;4251.574842515754;3434.6221915589267;3744.9438258426144;4091.304478238692;4126.174765046988;4169.477466132991;4166.708330416872;4177.624013838754;4180.686448516343;4189;4194.224068547298;3609.9097522561883;3611.9638803611892;3627.805177867405;3628.183658676803;3638.599754027055;4415.403920470728;5272.578193744491;5312.415634280226;5369.704666243355;5386.973065134688;4589;4759.833405830814;4763.833265835679;4773.904521909542;4776.713397196179;5263.4208738058105;5410.646368829572;5841.795537156179;5854.326752423441;5879;3689.4465830125428;3901.8244179012013;3955.406688996645;3957.406389041638;3972.272061653161;5419.458054194589;5894.941050589482;6158.168647232611;6213.316535181127;6231.40801623845;3416.214270717749;3872.3804191329814;4017.799110044486;4019.879403617896;4020.6984476164403;3774.6036666150208;4006.0585762345827;4061.5329237137516;4091.6112969267874;4097.078157414558;4741.644376671763;4762.761861906891;4767.308740232716;4787.832425865078;4797.496262892416;4982;5815.331236907725;5866.296044474605;5887.587868849225;5909.763609455574;1170.1750266062406;1300.6878349196313;1301.2452777389092;1368.9794653080212;1393.6933874547583;757.4659864795306;761.3072104384983;774.5430196184278;819.6352623082671;834.966601335952;3638.526991491089;3984.7011474139554;4489.326601009875;4594.47163576193;4727.2909063640045;4125.66994640428;4610.838620648328;4752.312928910256;5006.247813265328;5013.448520662724;4028.4561584186345;4270.29540125882;4585.143017078022;4592.586667199901;4622.699524530894;2381.48798008429;2882.0978154417985;2922.129836904383;3158.652548219694;3194.3132226571397;5964.5526585505395;6065.423784740443;6115.318287470892;6242.344553821874;6270.811875643738;5202.557782588522;5823.679697616672;6218.906716399258;6237.4426485140875;6271.216097987752;6215.595986260879;6300.2754683212015;6326.778562750282;6360.968195159087;6449.96775016122;5881;6123.203983482119;6154.630722156685;6168.444839964424;6205.596636218631;4912.680675756064;6016.87966240664;6020.64162895015;6031.698415079316;6050.97292407031;6308.899215509955;6367.52243581724;6383.138276332821;6390.297067322684;6460.418562329413;3342.9832850836565;3722.2927643747603;3867.5165604299464;3997.000749812547;4047.4131250969035;5613.915791263216;6109.389061093855;6129.172561704113;6174.746217630623;6212.378762123752;4568.428946381702;5567.886422715392;5652.6043176978865;5830.53355731532;5862.794802181903;5070;5285.127953887565;5566.805161819317;5919.372172652555;5958.76164953397;4312.708337442508;4514.961558841419;4880.95119048805;5014.545781723259;5635.351934527582;5845.444682755132;5867.5305975521005;5880.970595147168;5938.2280303560265;5972.850678733066;5765.538756899522;5781.913271300849;5791;5839.970800146142;5865.621578929034 06:33:30 INFO - PROCESS | 1665 | |5;yui.html;707.2644449772237;747.9065116860393;751.7293774241268;760.0499375780274;811.7077851973288;14854.183019933913;15907;15940.601484962881;15940.601484962881;15949.601259968507;14387.496437624684;14538.12771233724;14543.272836358192;14545.345459454324;14550.199739014377;667.3593350383613;697.3619138488277;812.7561731480562;827.2182787266036;851.221132663612;835.0063424524797;839.2027573804879;848.0501837941483;849.3078141314809;850.4897061762955;876.2201640539924;896.730980705789;901.3195037746492;902.4179404284233;902.4900930974012;874.3486102853415;894.9463032218055;895.7850115972152;896.3814967672286;897.8967418746862;661.0943008078915;663.3035312921461;664.5514277862424;664.5846346033729;666.2305037681485;14385.496507622183;14670.266486675624;14673.70652586953;14714.264286785618;14725.55823325302;14275.714485710332;14369.640758981004;14377.35301911406;14386.280685965765;14503.70992580153;11640.359780212086;11744.412779361082;11871.46578403974;11881.465334059989;11943.701407464796;3733.3653278942643;3760.905977350561;3771.1572795005013;3797.259534390795;3920.392339187402;104859;104945.47527262391;106130;110807.3378899309;110877.44561277222;10808.621698240524;10877;10988.340699558052;11031.117510599133;11123.499442525106;22183.889080554494;22215.333539993826;22226.777527235834;22231.333060008226;22236.332910012727;6964;7747.922520774833;7920.76237712858;8042.517448953082;8138.3082437993435;3949.921001579952;4435.866923992286;4465.642748580106;4499.9650080481015;4693.530646935279;3118.828464434478;3160.604924384452;3549.5208146899836;3624.4382120771324;3626.818659067036;574.9597528173072;608.4888693497484;662.9270780214173;668.3583759590847;675.6284043775904;517.5290485658034;544.705858836224;579.7912751409489;625.1997443272618;629.9181106456223;7749;8156.1028286888395;8967.551622418852;9050.502222377701;9148.954255228815;519.4934938434996;554.3071161048689;573.243318819163;582.7668932426978;597.137136837266;3720.330340538675;4393.51671316155;4412.573654397965;4415;4566.0411313623845;138599;142248.2887585576;146172.538274618;148092.07631694828;149233;119180;120893;122156.50887130301;122927;124237;52807.471925281025;89118;89886;107013;110762.44618776854;9516.95241523788;9602.85595716051;9761.658341957997;9788.168005719308;9816.214702823614;46212.306815397125;49744.25383619176;58551.70724146352;59097.40902590919;60284.39715602788;83965;88980.5550972241;90267;90299.93650285622;90606.54696726475;12697.619071427873;12862.742745144858;13067.607971760483;13137.934310328386;13324.267165306;14007.43970241179;14020.859791401956;14282;14411.495597654031;14818.481353152589;13340.533081342106;13459.327033648475;13540.72918541604;13618.93190534041;14028.929855350658;12217.816732749194;12217.938910305747;13314.267715275753;13483.123596966167;13917.652058698613;10305.227107966783;12065.517379304729;13263.336833158497;13477.46090156422;13593.32033398346;9448.858242142662;9689.885663148829;11278.943605281922;11316.7736645265;11490.310581365145;8872.068432814462;9341.813163736822;9750.741188096887;9924.730968115571;10495.632652857113 06:33:30 INFO - PROCESS | 1665 | __end_tp_report 06:33:30 INFO - PROCESS | 1665 | __start_cc_report 06:33:30 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,371 06:33:30 INFO - PROCESS | 1665 | __end_cc_report 06:33:30 INFO - PROCESS | 1665 | __startTimestamp1475069610756__endTimestamp 06:33:30 INFO - PROCESS | 1665 | 06:33:30 INFO - PROCESS | 1665 | ------- Summary: start ------- 06:33:30 INFO - PROCESS | 1665 | Number of tests: 6 06:33:30 INFO - PROCESS | 1665 | 06:33:30 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5763.62 Median:6041.15 stddev:655.17 (10.8%) stddev-sans-first:627.25 06:33:30 INFO - PROCESS | 1665 | Values: 3268.1 3368.4 3387.2 3393.9 3430.6 5601.8 5670.9 5698.1 5721.2 5788.9 5668.3 5710.7 5728.4 5797.8 5853.6 5195.7 5213.3 5248.7 5335.6 5371.0 5351.1 5372.2 5389.4 5403.8 5412.3 5159.8 5205.6 5267.1 5313.5 5358.2 5152.3 5175.8 5189.5 5293.8 5344.0 5201.1 5225.6 5229.3 5271.4 5292.8 4294.7 5601.0 5734.0 5736.6 5746.2 6103.0 6104.8 6168.4 6176.8 6267.4 6240.4 6246.9 6263.6 6265.2 6265.9 5885.4 5914.0 5922.1 5923.8 5982.6 6152.9 6175.3 6183.1 6183.7 6198.7 6196.2 6198.1 6202.0 6207.3 6208.8 6254.4 6283.2 6286.2 6296.3 6297.5 5961.8 6110.4 6146.7 6151.4 6173.2 6210.6 6233.6 6238.1 6238.7 6243.4 4675.5 4910.8 4932.1 4937.1 4954.5 4340.7 4377.9 4412.6 4493.1 4514.0 5894.7 5912.7 6013.7 6054.6 6105.9 6209.9 6219.7 6235.4 6254.7 6264.7 5738.1 5806.6 5966.7 6004.8 6039.8 4513.9 4722.4 5400.6 5438.9 5449.6 6317.9 6327.5 6333.7 6334.3 6335.5 6145.4 6252.4 6265.6 6276.8 6289.1 6159.3 6198.3 6216.2 6256.8 6362.5 6198.8 6230.7 6253.9 6269.7 6273.8 6245.3 6248.1 6249.9 6263.8 6264.1 5920.4 6052.2 6103.7 6119.0 6138.4 6131.4 6164.1 6204.4 6212.9 6216.5 5775.1 5876.9 6018.2 6018.2 6041.2 6047.7 6100.6 6130.8 6149.8 6188.6 5952.6 6002.9 6019.2 6042.5 6070.0 06:33:30 INFO - PROCESS | 1665 | 06:33:30 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:62054.58 Median:39001.30 stddev:126882.45 (325.3%) stddev-sans-first:127154.14 06:33:30 INFO - PROCESS | 1665 | Values: 472.8 482.4 527.6 530.0 539.9 38581.6 40829.2 40871.8 40935.8 40963.4 42167.0 42328.6 42627.0 42689.4 42802.6 9816.3 9923.5 10006.9 10014.2 10050.7 9709.8 9790.2 9791.2 9804.2 9829.1 9791.0 9809.6 9825.0 9833.0 9838.2 9781.4 9811.7 9814.9 9815.9 9830.1 9770.0 9855.3 9859.9 9864.0 9899.1 39675.6 40175.0 40278.0 40535.4 40561.2 3162.7 3311.1 3430.8 3811.8 3943.6 30321.7 30693.8 30735.0 30851.8 31846.5 2986.0 3167.2 3243.9 3264.4 3356.4 383217.0 386896.0 387175.0 388160.0 388408.0 53563.7 57875.4 58107.0 58132.4 58183.1 26302.9 28407.4 30278.5 35659.1 51119.7 13979.9 16148.6 16150.0 16325.8 16379.4 10734.9 12422.0 12528.7 12645.9 12704.0 19307.0 19327.6 19334.2 19348.1 19432.9 7949.2 8014.6 8032.7 8078.5 8118.0 720.8 1006.0 1028.3 1051.3 1059.5 29673.5 30162.3 30371.0 30599.7 30663.4 1030.9 1058.5 1106.7 1108.3 1116.5 13938.7 14864.4 15584.0 15711.8 16309.8 533218.3 536148.2 536889.0 538776.0 539332.0 56511.7 56644.4 56945.7 56973.0 57348.7 1209.9 1291.5 1312.1 1318.9 1329.1 29604.1 29694.0 29766.3 30202.7 30531.1 53317.7 54955.5 54989.6 58271.7 58274.4 489686.0 493372.0 498925.0 499516.0 501031.5 41100.6 41638.2 41855.8 41921.6 42070.9 47205.8 47456.1 47474.3 48586.8 49011.0 34059.7 36003.3 38285.8 38869.0 40083.8 38944.0 39058.6 39726.6 40036.6 40141.0 36806.1 37207.1 37659.4 38380.0 38645.2 32916.7 34417.7 34513.3 34899.0 35067.1 25457.2 25568.5 25767.6 25991.4 26163.5 06:33:30 INFO - PROCESS | 1665 | 06:33:30 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:31659.98 Median:373.34 stddev:89149.64 (23879.0%) stddev-sans-first:89368.75 06:33:30 INFO - PROCESS | 1665 | Values: 360.2 369.2 371.8 377.4 386.2 19117.6 19472.8 19666.4 20108.8 20250.0 9091.3 10006.3 19195.5 19251.7 19849.9 4315.7 5363.0 5651.4 5657.3 5663.4 5356.6 5411.4 5520.7 5561.7 5564.2 5423.7 5454.7 5562.0 5594.3 5600.4 5214.4 5527.3 5879.7 6172.8 6226.7 5835.9 6012.8 6068.3 6070.0 6089.9 11873.5 12405.6 13400.0 13405.8 13429.5 2028.9 2044.9 2064.3 2076.4 2562.4 9957.9 10145.2 10170.3 14331.3 15805.6 1838.1 1840.7 1848.2 1900.5 1954.1 101122.5 109088.0 109238.0 109295.8 109583.0 11426.5 11615.7 11625.1 11653.2 11880.6 14421.4 14436.9 14444.4 14459.7 14473.3 8253.1 8427.6 8440.0 8449.6 8577.4 8283.0 8310.3 8438.0 8487.8 8526.6 3923.9 4194.0 4456.8 4575.5 4619.3 1724.1 1937.6 1962.9 1968.1 2008.6 786.6 797.2 870.8 887.3 956.5 18514.7 20591.8 20800.9 20929.9 21117.3 300.5 339.3 377.9 386.3 827.7 5073.5 5152.0 6064.6 6111.8 6234.4 490311.0 532050.0 541744.3 544091.0 555813.0 84545.0 107934.0 115356.0 124773.0 128244.0 374.9 429.6 453.9 455.9 459.5 11268.1 11312.5 11446.9 15024.6 20065.7 49666.3 52766.9 55329.7 55383.4 55495.7 75443.0 75643.6 76004.6 76586.6 77273.2 5451.9 6641.3 7630.1 8200.7 8316.9 10817.6 13037.3 13210.7 13352.7 13590.5 11150.9 11353.4 11385.3 11624.8 11684.4 10173.6 10904.6 10983.7 11126.4 11259.3 10590.6 11378.5 11631.0 11720.2 11910.5 8270.0 8361.0 8485.6 8499.5 8503.5 9884.7 11502.8 11560.7 11734.9 11913.6 06:33:30 INFO - PROCESS | 1665 | 06:33:30 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5679.06 Median:4796.38 stddev:3200.41 (66.7%) stddev-sans-first:3193.77 06:33:30 INFO - PROCESS | 1665 | Values: 1471.9 1523.5 1679.6 1763.4 1771.9 7921.2 8204.6 8396.4 8968.6 8970.0 8488.6 8809.0 8821.2 8929.3 8952.3 2367.1 2372.5 2396.9 2406.9 2410.9 2362.7 2378.5 2381.7 2406.5 2412.0 2389.6 2390.1 2402.3 2406.7 2408.1 2368.5 2374.7 2384.5 2386.8 2394.1 2356.0 2362.1 2374.5 2375.7 2380.0 8874.2 8980.8 8992.4 9037.0 9047.1 4813.1 5004.9 5356.7 5371.8 5372.2 3443.2 3570.4 3635.9 3639.4 3647.6 1049.8 1083.0 1085.8 1088.1 1105.3 11595.4 11613.7 11667.5 11686.2 11694.7 4499.7 4690.2 4769.6 4792.1 4800.7 7920.5 9969.3 10030.9 10040.3 10043.8 5310.2 5324.4 5330.8 5331.9 5339.7 3938.7 4339.6 4519.2 4847.3 4862.3 3816.3 3846.9 3906.6 3942.8 3973.9 1267.2 1278.2 1278.8 1284.8 1287.3 754.0 795.3 897.1 913.8 923.8 4713.5 5494.2 5830.7 5848.8 5912.2 831.5 885.5 888.2 900.8 913.9 3825.7 3839.4 3843.7 3925.3 3930.9 8680.4 10538.0 10815.7 10900.9 10908.9 10789.2 10865.2 10865.5 10866.9 10890.8 7629.5 7965.8 8181.8 8182.7 8323.4 5824.8 5854.9 5881.4 5973.3 6067.4 8036.9 10166.3 10219.5 10291.1 10327.4 10019.5 10410.4 10455.5 10469.4 10472.8 6029.8 6942.1 7149.8 7166.7 7672.1 8353.3 8421.1 8592.1 8611.9 8613.1 7235.7 7436.1 7670.9 7677.1 7711.9 7214.4 7357.7 7359.6 7494.3 7520.3 6989.5 7019.4 7027.6 7055.9 7058.3 4134.0 4856.2 4953.7 5021.5 5024.1 4727.7 4961.4 4992.4 5021.4 5052.8 06:33:30 INFO - PROCESS | 1665 | 06:33:30 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4646.05 Median:4896.82 stddev:1491.08 (30.4%) stddev-sans-first:1459.21 06:33:30 INFO - PROCESS | 1665 | Values: 303.9 305.0 311.6 317.0 317.5 4599.6 5490.3 5579.9 5620.3 5711.1 4651.6 4735.6 5068.7 5428.4 5537.4 4183.2 4226.7 4231.2 4232.2 4254.4 3920.9 4168.3 4234.4 4246.2 4251.6 3434.6 3744.9 4091.3 4126.2 4169.5 4166.7 4177.6 4180.7 4189.0 4194.2 3609.9 3612.0 3627.8 3628.2 3638.6 4415.4 5272.6 5312.4 5369.7 5387.0 4589.0 4759.8 4763.8 4773.9 4776.7 5263.4 5410.6 5841.8 5854.3 5879.0 3689.4 3901.8 3955.4 3957.4 3972.3 5419.5 5894.9 6158.2 6213.3 6231.4 3416.2 3872.4 4017.8 4019.9 4020.7 3774.6 4006.1 4061.5 4091.6 4097.1 4741.6 4762.8 4767.3 4787.8 4797.5 4982.0 5815.3 5866.3 5887.6 5909.8 1170.2 1300.7 1301.2 1369.0 1393.7 757.5 761.3 774.5 819.6 835.0 3638.5 3984.7 4489.3 4594.5 4727.3 4125.7 4610.8 4752.3 5006.2 5013.4 4028.5 4270.3 4585.1 4592.6 4622.7 2381.5 2882.1 2922.1 3158.7 3194.3 5964.6 6065.4 6115.3 6242.3 6270.8 5202.6 5823.7 6218.9 6237.4 6271.2 6215.6 6300.3 6326.8 6361.0 6450.0 5881.0 6123.2 6154.6 6168.4 6205.6 4912.7 6016.9 6020.6 6031.7 6051.0 6308.9 6367.5 6383.1 6390.3 6460.4 3343.0 3722.3 3867.5 3997.0 4047.4 5613.9 6109.4 6129.2 6174.7 6212.4 4568.4 5567.9 5652.6 5830.5 5862.8 5070.0 5285.1 5566.8 5919.4 5958.8 4312.7 4515.0 4881.0 5014.5 5635.4 5845.4 5867.5 5881.0 5938.2 5972.9 5765.5 5781.9 5791.0 5840.0 5865.6 06:33:30 INFO - PROCESS | 1665 | 06:33:30 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:23540.54 Median:3858.83 stddev:37349.79 (967.9%) stddev-sans-first:37415.22 06:33:30 INFO - PROCESS | 1665 | Values: 707.3 747.9 751.7 760.0 811.7 14854.2 15907.0 15940.6 15940.6 15949.6 14387.5 14538.1 14543.3 14545.3 14550.2 667.4 697.4 812.8 827.2 851.2 835.0 839.2 848.1 849.3 850.5 876.2 896.7 901.3 902.4 902.5 874.3 894.9 895.8 896.4 897.9 661.1 663.3 664.6 664.6 666.2 14385.5 14670.3 14673.7 14714.3 14725.6 14275.7 14369.6 14377.4 14386.3 14503.7 11640.4 11744.4 11871.5 11881.5 11943.7 3733.4 3760.9 3771.2 3797.3 3920.4 104859.0 104945.5 106130.0 110807.3 110877.4 10808.6 10877.0 10988.3 11031.1 11123.5 22183.9 22215.3 22226.8 22231.3 22236.3 6964.0 7747.9 7920.8 8042.5 8138.3 3949.9 4435.9 4465.6 4500.0 4693.5 3118.8 3160.6 3549.5 3624.4 3626.8 575.0 608.5 662.9 668.4 675.6 517.5 544.7 579.8 625.2 629.9 7749.0 8156.1 8967.6 9050.5 9149.0 519.5 554.3 573.2 582.8 597.1 3720.3 4393.5 4412.6 4415.0 4566.0 138599.0 142248.3 146172.5 148092.1 149233.0 119180.0 120893.0 122156.5 122927.0 124237.0 52807.5 89118.0 89886.0 107013.0 110762.4 9517.0 9602.9 9761.7 9788.2 9816.2 46212.3 49744.3 58551.7 59097.4 60284.4 83965.0 88980.6 90267.0 90299.9 90606.5 12697.6 12862.7 13067.6 13137.9 13324.3 14007.4 14020.9 14282.0 14411.5 14818.5 13340.5 13459.3 13540.7 13618.9 14028.9 12217.8 12217.9 13314.3 13483.1 13917.7 10305.2 12065.5 13263.3 13477.5 13593.3 9448.9 9689.9 11278.9 11316.8 11490.3 8872.1 9341.8 9750.7 9924.7 10495.6 06:33:30 INFO - PROCESS | 1665 | -------- Summary: end -------- 06:33:30 INFO - PROCESS | 1665 | 06:33:31 INFO - TEST-INFO | 1665: exit 0 06:33:31 INFO - TEST-OK | dromaeo_css | took 1114018ms 06:33:31 INFO - TEST-START | kraken 06:33:31 INFO - operating with platform_type : mac_ 06:33:31 INFO - Initialising browser for kraken test... 06:33:31 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmpYqyoNS/profile http://localhost:49276/getInfo.html) 06:33:34 INFO - PROCESS | 1673 | 2016-09-28 06:33:34.207 plugin-container[1674:10432] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x891f, name = 'com.apple.tsm.portname' 06:33:34 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:33:34 INFO - PROCESS | 1673 | 2016-09-28 06:33:34.210 plugin-container[1674:10432] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e03, name = 'com.apple.CFPasteboardClient' 06:33:34 INFO - PROCESS | 1673 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:33:34 INFO - PROCESS | 1673 | 2016-09-28 06:33:34.210 plugin-container[1674:10432] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:33:34 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 06:33:34 INFO - PROCESS | 1673 | colorDepth:24 06:33:34 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 06:33:34 INFO - PROCESS | 1673 | __metrics 06:33:34 ERROR - PROCESS | 1673 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 06:33:35 INFO - TEST-INFO | 1673: exit 0 06:33:35 INFO - Browser initialized. 06:33:35 INFO - Running cycle 1/1 for kraken test... 06:33:35 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmpYqyoNS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:33:37 INFO - PROCESS | 1675 | 2016-09-28 06:33:37.614 plugin-container[1676:10545] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x881f, name = 'com.apple.tsm.portname' 06:33:37 INFO - PROCESS | 1675 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:33:37 INFO - PROCESS | 1675 | 2016-09-28 06:33:37.616 plugin-container[1676:10545] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 06:33:37 INFO - PROCESS | 1675 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:33:37 INFO - PROCESS | 1675 | 2016-09-28 06:33:37.616 plugin-container[1676:10545] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:33:47 INFO - PROCESS | 1675 | RSS: Main: 239964160 06:33:47 INFO - PROCESS | 1675 | 06:33:49 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 06:33:50 INFO - PROCESS | 1675 | RSS: Main: 253394944 06:33:50 INFO - PROCESS | 1675 | 06:33:53 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 06:33:54 INFO - PROCESS | 1675 | RSS: Main: 261980160 06:33:54 INFO - PROCESS | 1675 | 06:33:57 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 06:33:58 INFO - PROCESS | 1675 | RSS: Main: 261951488 06:33:58 INFO - PROCESS | 1675 | 06:34:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 06:34:00 INFO - PROCESS | 1675 | RSS: Main: 263053312 06:34:00 INFO - PROCESS | 1675 | 06:34:02 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:34:03 INFO - PROCESS | 1675 | RSS: Main: 263131136 06:34:03 INFO - PROCESS | 1675 | 06:34:06 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 06:34:06 INFO - PROCESS | 1675 | RSS: Main: 263692288 06:34:06 INFO - PROCESS | 1675 | 06:34:09 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 06:34:10 INFO - PROCESS | 1675 | RSS: Main: 264798208 06:34:10 INFO - PROCESS | 1675 | 06:34:13 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 06:34:14 INFO - PROCESS | 1675 | RSS: Main: 265490432 06:34:14 INFO - PROCESS | 1675 | 06:34:15 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:34:16 INFO - PROCESS | 1675 | RSS: Main: 264945664 06:34:16 INFO - PROCESS | 1675 | 06:34:18 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:34:19 INFO - PROCESS | 1675 | RSS: Main: 265076736 06:34:19 INFO - PROCESS | 1675 | 06:34:21 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:34:22 INFO - PROCESS | 1675 | RSS: Main: 265043968 06:34:22 INFO - PROCESS | 1675 | 06:34:24 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:34:25 INFO - PROCESS | 1675 | RSS: Main: 265334784 06:34:25 INFO - PROCESS | 1675 | 06:34:28 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:34:29 INFO - PROCESS | 1675 | RSS: Main: 265560064 06:34:29 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 06:34:31 INFO - PROCESS | 1675 | RSS: Main: 266952704 06:34:31 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | __start_tp_report 06:34:31 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 06:34:31 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 06:34:31 INFO - PROCESS | 1675 | |i|pagename|runs| 06:34:31 INFO - PROCESS | 1675 | |0;ai-astar;110;119;121;165;138;119;114;119;119;117 06:34:31 INFO - PROCESS | 1675 | |1;audio-beat-detection;144;128;142;176;112;112;113;111;143;116 06:34:31 INFO - PROCESS | 1675 | |2;audio-dft;197;202;207;225;200;198;197;202;208;213 06:34:31 INFO - PROCESS | 1675 | |3;audio-fft;96;72;49;76;71;86;83;53;96;85 06:34:31 INFO - PROCESS | 1675 | |4;audio-oscillator;87;72;87;73;69;72;119;96;70;89 06:34:31 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;91;89;91;90;91;88;93;89;96;132 06:34:31 INFO - PROCESS | 1675 | |6;imaging-darkroom;100;101;99;103;100;170;133;101;101;102 06:34:31 INFO - PROCESS | 1675 | |7;imaging-desaturate;123;149;139;94;92;90;110;90;126;87 06:34:31 INFO - PROCESS | 1675 | |8;json-parse-financial;57;57;57;56;57;59;60;61;85;68 06:34:31 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;66;74;69;84;67;100;105;104;71;72 06:34:31 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;85;89;88;87;105;72;97;108;109;89 06:34:31 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;154;157;140;143;155;150;154;174;178;149 06:34:31 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;171;172;178;175;171;195;154;208;235;221 06:34:31 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;70;68;69;69;67;70;89;87;90;89 06:34:31 INFO - PROCESS | 1675 | __end_tp_report 06:34:31 INFO - PROCESS | 1675 | __start_cc_report 06:34:31 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,940 06:34:31 INFO - PROCESS | 1675 | __end_cc_report 06:34:31 INFO - PROCESS | 1675 | __startTimestamp1475069671414__endTimestamp 06:34:31 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | ------- Summary: start ------- 06:34:31 INFO - PROCESS | 1675 | Number of tests: 14 06:34:31 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:124.10 Median:119.00 stddev:16.09 (13.5%) stddev-sans-first:16.24 06:34:31 INFO - PROCESS | 1675 | Values: 110.0 119.0 121.0 165.0 138.0 119.0 114.0 119.0 119.0 117.0 06:34:31 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:135.00 stddev:21.40 (15.9%) stddev-sans-first:22.06 06:34:31 INFO - PROCESS | 1675 | Values: 144.0 128.0 142.0 176.0 112.0 112.0 113.0 111.0 143.0 116.0 06:34:31 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:204.90 Median:204.50 stddev:8.80 (4.3%) stddev-sans-first:8.86 06:34:31 INFO - PROCESS | 1675 | Values: 197.0 202.0 207.0 225.0 200.0 198.0 197.0 202.0 208.0 213.0 06:34:31 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:76.70 Median:84.00 stddev:16.07 (19.1%) stddev-sans-first:15.45 06:34:31 INFO - PROCESS | 1675 | Values: 96.0 72.0 49.0 76.0 71.0 86.0 83.0 53.0 96.0 85.0 06:34:31 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:83.40 Median:80.00 stddev:15.77 (19.7%) stddev-sans-first:16.67 06:34:31 INFO - PROCESS | 1675 | Values: 87.0 72.0 87.0 73.0 69.0 72.0 119.0 96.0 70.0 89.0 06:34:31 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:95.00 Median:91.00 stddev:13.20 (14.5%) stddev-sans-first:13.92 06:34:31 INFO - PROCESS | 1675 | Values: 91.0 89.0 91.0 90.0 91.0 88.0 93.0 89.0 96.0 132.0 06:34:31 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:111.00 Median:102.50 stddev:23.08 (22.5%) stddev-sans-first:24.14 06:34:31 INFO - PROCESS | 1675 | Values: 100.0 101.0 99.0 103.0 100.0 170.0 133.0 101.0 101.0 102.0 06:34:31 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:110.00 Median:88.50 stddev:22.84 (25.8%) stddev-sans-first:23.74 06:34:31 INFO - PROCESS | 1675 | Values: 123.0 149.0 139.0 94.0 92.0 90.0 110.0 90.0 126.0 87.0 06:34:31 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:59.50 stddev:8.91 (15.0%) stddev-sans-first:9.28 06:34:31 INFO - PROCESS | 1675 | Values: 57.0 57.0 57.0 56.0 57.0 59.0 60.0 61.0 85.0 68.0 06:34:31 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:81.20 Median:70.00 stddev:15.88 (22.7%) stddev-sans-first:15.86 06:34:31 INFO - PROCESS | 1675 | Values: 66.0 74.0 69.0 84.0 67.0 100.0 105.0 104.0 71.0 72.0 06:34:31 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:92.90 Median:87.50 stddev:11.73 (13.4%) stddev-sans-first:12.09 06:34:31 INFO - PROCESS | 1675 | Values: 85.0 89.0 88.0 87.0 105.0 72.0 97.0 108.0 109.0 89.0 06:34:31 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:155.40 Median:154.50 stddev:12.13 (7.9%) stddev-sans-first:12.86 06:34:31 INFO - PROCESS | 1675 | Values: 154.0 157.0 140.0 143.0 155.0 150.0 154.0 174.0 178.0 149.0 06:34:31 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.00 Median:186.50 stddev:25.83 (13.9%) stddev-sans-first:26.66 06:34:31 INFO - PROCESS | 1675 | Values: 171.0 172.0 178.0 175.0 171.0 195.0 154.0 208.0 235.0 221.0 06:34:31 INFO - PROCESS | 1675 | 06:34:31 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.80 Median:78.50 stddev:10.35 (13.2%) stddev-sans-first:10.68 06:34:31 INFO - PROCESS | 1675 | Values: 70.0 68.0 69.0 69.0 67.0 70.0 89.0 87.0 90.0 89.0 06:34:31 INFO - PROCESS | 1675 | -------- Summary: end -------- 06:34:31 INFO - PROCESS | 1675 | 06:34:32 INFO - TEST-INFO | 1675: exit 0 06:34:32 INFO - TEST-OK | kraken | took 60853ms 06:34:32 INFO - SUITE-END | took 1174s 06:34:32 INFO - Completed test suite (00:19:35) 06:34:32 INFO - javascript benchmark 06:34:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7194.388422245023, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3268.1012721501584, 3368.4273673475514, 3387.1532116970757, 3393.9321213575713, 3430.5883294004725, 5601.775928962837, 5670.8582285442935, 5698.145278208266, 5721.199032135499, 5788.942110578893, 5668.348139963905, 5710.7430165642545, 5728.369879313273, 5797.82606521804, 5853.560982926287, 5195.740212989354, 5213.296205012312, 5248.737563121847, 5335.573154147659, 5371.0, 5351.143816989283, 5372.167314066326, 5389.434109418514, 5403.83788486346, 5412.322369272754, 5159.7678104485385, 5205.55752761012, 5267.104592219332, 5313.495217954288, 5358.196270559409, 5152.252923326134, 5175.844724658228, 5189.481051894781, 5293.841184764425, 5344.038073146832, 5201.141811601081, 5225.634205605571, 5229.346331708536, 5271.37194285856, 5292.761825717852, 4294.699371044028, 5601.047821870292, 5734.0, 5736.627119237236, 5746.195532625436, 6103.034636161418, 6104.762330457774, 6168.444839964424, 6176.81469555914, 6267.435930766207, 6240.438360547527, 6246.906296405557, 6263.561550691454, 6265.154204182468, 6265.906011409833, 5885.440883116097, 5913.965056115163, 5922.063966648632, 5923.792667256668, 5982.551308651781, 6152.89247935367, 6175.2898416681755, 6183.072539119078, 6183.721732521957, 6198.659073750897, 6196.225471816023, 6198.0702894565275, 6202.0, 6207.34822843604, 6208.751649933952, 6254.3745625437095, 6283.214598175228, 6286.182796236551, 6296.307406185316, 6297.464715499143, 5961.7615295387695, 6110.3765049759795, 6146.692665366714, 6151.446369826647, 6173.166622505994, 6210.5652604317265, 6233.594816336924, 6238.095476156022, 6238.6880655967925, 6243.43809057187, 4675.485696573374, 4910.8281210157475, 4932.112219800399, 4937.1113199624415, 4954.455009948902, 4340.717853339523, 4377.934330985037, 4412.646988240933, 4493.056458143761, 4514.029483661028, 5894.705264736832, 5912.733926973297, 6013.6692481913915, 6054.606450580698, 6105.908411373833, 6209.875802484015, 6219.689015549295, 6235.407636274546, 6254.6872656366995, 6264.686765661699, 5738.139279108167, 5806.564507661942, 5966.671833049224, 6004.789832355847, 6039.818805435844, 4513.932291015637, 4722.386089808303, 5400.567954563626, 5438.8912221755345, 5449.64577302474, 6317.936820631919, 6327.4938004959495, 6333.746650133943, 6334.271558770801, 6335.524835637346, 6145.446909778141, 6252.437280644764, 6265.561410701207, 6276.780312689034, 6289.08808222796, 6159.260888693386, 6198.318184999556, 6216.160818289473, 6256.812295631138, 6362.459190968634, 6198.845028874314, 6230.719617617308, 6253.874922501615, 6269.74921003173, 6273.780417685359, 6245.250569931637, 6248.094026366242, 6249.937500624936, 6263.78076767311, 6264.091706702411, 5920.37836027211, 6052.244848993742, 6103.664298463627, 6118.984682626333, 6138.447539721446, 6131.386861313833, 6164.106204600397, 6204.441600255998, 6212.88761820983, 6216.502679785697, 5775.104858746901, 5876.911846322394, 6018.187544681412, 6018.217631708025, 6041.150297130313, 6047.697615119138, 6100.572959892765, 6130.754769809336, 6149.815505534841, 6188.628682279078, 5952.5833191676165, 6002.949483840398, 6019.157317975574, 6042.456178943916, 6069.9984502558345], "value": 5721.21761104986, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.7966974201094, 482.4331410592553, 527.588480984832, 529.9692098867702, 539.870431096537, 38581.61418385815, 40829.183416331696, 40871.795641021825, 40935.77192684217, 40963.38554921671, 42167.0, 42328.57671423285, 42627.0, 42689.35965960513, 42802.57197428025, 9816.312858099955, 9923.503824808768, 10006.899931000706, 10014.198864090891, 10050.74873128174, 9709.805803883917, 9790.216782657406, 9791.167750741195, 9804.166645835112, 9829.115379615832, 9791.0, 9809.607615695364, 9825.0, 9833.0, 9838.212942964547, 9781.364211326241, 9811.656592019317, 9814.90185098147, 9815.852762208573, 9830.066143716336, 9769.951150244275, 9855.2608554358, 9859.852102218472, 9863.950680246553, 9899.059589339002, 39675.60324396748, 40175.0, 40277.99305017369, 40535.39196912049, 40561.18877622431, 3162.7469802415753, 3311.122552523583, 3430.828458577086, 3811.8475260989526, 3943.5662077171487, 30321.69678303233, 30693.846530767427, 30735.0, 30851.845740771154, 31846.522302165486, 2986.0, 3167.2398624330226, 3243.9026829195163, 3264.396086723964, 3356.4461863792444, 383217.0, 386896.0, 387175.0, 388160.0, 388408.0, 53563.73218133884, 57875.421245787846, 58107.0, 58132.41867581355, 58183.12725309124, 26302.86848565745, 28407.43185136327, 30278.54582181269, 35659.10852228715, 51119.744401277756, 13979.930100349637, 16148.596285092732, 16150.0, 16325.83674163267, 16379.42672006498, 10734.892651073389, 12422.0, 12528.686782830502, 12645.936770316273, 12704.0, 19307.0, 19327.613447730968, 19334.163254490803, 19348.129334179997, 19432.931188784754, 7949.165337639581, 8014.599270036475, 8032.718854840053, 8078.474899131537, 8118.0, 720.7818786251219, 1005.9899401006043, 1028.275066078413, 1051.2746205118444, 1059.4596755654673, 29673.54304023343, 30162.327290152316, 30371.0, 30599.694003059685, 30663.38673226523, 1030.9175265978704, 1058.5077938758361, 1106.7288514314046, 1108.3017698849835, 1116.4640972333325, 13938.721225575431, 14864.405423782928, 15583.987040842308, 15711.842881571267, 16309.755353669705, 533218.3339083358, 536148.1925903689, 536889.0, 538776.0, 539332.0, 56511.71744141253, 56644.43355566474, 56945.715271423374, 56973.0, 57348.71325643345, 1209.9231683801424, 1291.4963164365904, 1312.1405479411, 1318.9472421103048, 1329.1493444195723, 29604.111876643736, 29694.0, 29766.255843603216, 30202.69797301999, 30531.084067478012, 53317.733411332694, 54955.45044549663, 54989.62525936883, 58271.70864145652, 58274.4172558269, 489686.0, 493372.0, 498925.0, 499516.0, 501031.4948425235, 41100.58899411087, 41638.16723665449, 41855.7907210462, 41921.580784192985, 42070.94822629336, 47205.76397117993, 47456.050878981536, 47474.28788568105, 48586.75706621444, 49011.01977960492, 34059.65940340565, 36003.27993440169, 38285.808570956964, 38869.02827429337, 40083.799581001906, 38944.0, 39058.6094139055, 39726.60273397229, 40036.59963400329, 40140.99647508719, 36806.07984800402, 37207.069823254635, 37659.43510847395, 38380.04049898775, 38645.2270954585, 32916.670833292315, 34417.65582344145, 34513.32728378632, 34899.0, 35067.123321917155, 25457.23628291154, 25568.48863022692, 25767.6134857981, 25991.350216244744, 26163.476730464903], "value": 19723.39616159586, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.1536389484711, 369.2227860353955, 371.76207227374476, 377.3848626738416, 386.248746188663, 19117.61764764704, 19472.805271947294, 19666.410007699757, 20108.798912010894, 20249.987500624946, 9091.272698184146, 10006.299559030871, 19195.520111997208, 19251.711224331648, 19849.900750496265, 4315.741055536662, 5362.981033603623, 5651.378348381675, 5657.264555607765, 5663.377028526858, 5356.625036247464, 5411.404745477994, 5520.723963801814, 5561.666300021991, 5564.248826408423, 5423.674579525222, 5454.699991500466, 5561.972190139044, 5594.328680558318, 5600.383957764642, 5214.374275086976, 5527.281453411051, 5879.735411906475, 6172.814815555518, 6226.719797609118, 5835.883282334329, 6012.819615411545, 6068.3021452533085, 6070.0, 6089.908651370233, 11873.515810523684, 12405.62783116508, 13400.0, 13405.798913016313, 13429.529966451226, 2028.9188432462684, 2044.9284275050302, 2064.318774804326, 2076.3667081540125, 2562.359410147463, 9957.90042099577, 10145.188384929188, 10170.338927969658, 14331.28343582827, 15805.60485987848, 1838.1452624529659, 1840.7146892231726, 1848.159087615132, 1900.515368581017, 1954.1108795498014, 101122.4943875276, 109088.0, 109238.0, 109295.81408371868, 109583.0, 11426.542938282542, 11615.709607259887, 11625.128115391379, 11653.242539234923, 11880.643580692593, 14421.35103920326, 14436.927815360856, 14444.422223110958, 14459.710805783825, 14473.348699308557, 8253.09215986241, 8427.578621068922, 8440.029396619468, 8449.577521124042, 8577.442466239674, 8283.047449543259, 8310.335173186131, 8438.0, 8487.787805304917, 8526.57367131641, 3923.8822835314986, 4193.97903010483, 4456.844010459618, 4575.496695363508, 4619.3071039343695, 1724.1206984438027, 1937.643649445394, 1962.8822270663807, 1968.055333439957, 2008.648486514854, 786.622421237809, 797.2266901105918, 870.8127752533236, 887.2547060469237, 956.4500412262977, 18514.722279165824, 20591.79408205929, 20800.89599552023, 20929.89535052315, 21117.27377204829, 300.46217271084953, 339.2756464947355, 377.8607498392349, 386.3162202900906, 827.7227128911882, 5073.518015788494, 5152.02111598795, 6064.636121832704, 6111.816645500642, 6234.37656234382, 490311.0, 532050.0, 541744.2912785411, 544091.0, 555813.0, 84545.0, 107934.0, 115356.0, 124773.0, 128244.0, 374.91751814600747, 429.60261757873843, 453.920563901316, 455.94528656561425, 459.46013434214666, 11268.098552115975, 11312.511247525532, 11446.885531144582, 15024.624384390478, 20065.699014514503, 49666.255006175656, 52766.944661105794, 55329.723351382985, 55383.446165537825, 55495.72252138875, 75443.0, 75643.62178189073, 76004.61997689976, 76586.6170669143, 77273.22726772886, 5451.882364115426, 6641.269460359454, 7630.122535908219, 8200.671973121009, 8316.916830831615, 10817.56729730802, 13037.282949437871, 13210.669733256746, 13352.666183345495, 13590.456381745014, 11150.944245278723, 11353.37556434404, 11385.316880987168, 11624.825627615422, 11684.415779211175, 10173.626560414545, 10904.563817447213, 10983.725406864573, 11126.388048657402, 11259.324440533594, 10590.576376944837, 11378.54485820558, 11631.0, 11720.179587428798, 11910.52357905674, 8270.0, 8360.958195208985, 8485.618147183515, 8499.490030598185, 8503.489790612335, 9884.654037108667, 11502.769944601228, 11560.70518903268, 11734.94132529332, 11913.642590722293], "value": 8555.76104987291, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.889608279379, 1523.4972459088501, 1679.5549179467444, 1763.3916298876884, 1771.867109966752, 7921.247481489264, 8204.630791614376, 8396.370272229577, 8968.641254349826, 8969.955150224248, 8488.575571221445, 8809.03100658927, 8821.206091451768, 8929.330300227493, 8952.283817294618, 2367.124164059296, 2372.466195106105, 2396.945344048622, 2406.8916898739512, 2410.939726506843, 2362.7164740231196, 2378.4648454097864, 2381.654660074288, 2406.5186962607463, 2411.9517609647796, 2389.593769059264, 2390.1395497620842, 2402.327348342467, 2406.68713067301, 2408.0728919366084, 2368.4789346343778, 2374.6675465434855, 2384.4873352229356, 2386.7971222446026, 2394.1381102802975, 2355.9764402355927, 2362.078789272185, 2374.4538756086026, 2375.70303712036, 2379.976200237993, 8874.245689116433, 8980.820383592292, 8992.370534062618, 9037.005929347766, 9047.140521650499, 4813.109574728686, 5004.948960718253, 5356.6518176318805, 5371.811986580451, 5372.194170874361, 3443.1736383267835, 3570.410882204433, 3635.8909232723063, 3639.363111455511, 3647.6352364763575, 1049.7795462952713, 1083.0469187115289, 1085.7611325508376, 1088.0533935476108, 1105.3478447715806, 11595.362255075968, 11613.709657258636, 11667.533298668042, 11686.24039437434, 11694.707632309175, 4499.662525310615, 4690.249560070372, 4769.59458446029, 4792.0895029944195, 4800.66395352322, 7920.5247685139075, 9969.252306077073, 10030.949845250872, 10040.297179197532, 10043.849342259871, 5310.150375939831, 5324.361076670747, 5330.813421530228, 5331.866703332447, 5339.652922560099, 3938.724289299779, 4339.566043395698, 4519.231730605805, 4847.2729090636685, 4862.294967229732, 3816.2749077675153, 3846.9038274042814, 3906.648401643809, 3942.7634341939574, 3973.900652483653, 1267.176335382009, 1278.2266728629045, 1278.7826069568196, 1284.8137020132028, 1287.2855565161237, 753.9736109236151, 795.316028215734, 897.0894542039835, 913.7761248494162, 923.8221267883368, 4713.538802971021, 5494.230807686927, 5830.650160990354, 5848.766049357978, 5912.201852749909, 831.5218749219223, 885.455444901381, 888.2449917570013, 900.8018235988072, 913.9223166030962, 3825.713071519647, 3839.3856982882603, 3843.6925045996254, 3925.293447179535, 3930.941035884464, 8680.435771674822, 10538.0, 10815.67552973412, 10900.945495272632, 10908.890911090946, 10789.19081068923, 10865.239433239756, 10865.456727163768, 10866.891331086588, 10890.836637450444, 7629.54222746637, 7965.761027169194, 8181.75454736347, 8182.713605023796, 8323.417360784808, 5824.825255242349, 5854.882902341844, 5881.38245484218, 5973.283206015306, 6067.423594758491, 8036.87944680842, 10166.288359814742, 10219.540120694735, 10291.125254353165, 10327.380357178594, 10019.54912028975, 10410.427426491615, 10455.529501172314, 10469.424181670081, 10472.842907356548, 6029.78895738647, 6942.097527321416, 7149.785506434815, 7166.749163779243, 7672.117706463828, 8353.331733461187, 8421.115782842713, 8592.140785921358, 8611.8708219378, 8613.138686131337, 7235.674394652148, 7436.144843342869, 7670.923290767021, 7677.078750549969, 7711.922880771345, 7214.422846172189, 7357.668904899186, 7359.632018399166, 7494.250574942462, 7520.285572870568, 6989.545679530815, 7019.438444924292, 7027.648617568999, 7055.929440705732, 7058.294170582901, 4133.9793301033305, 4856.1987272099705, 4953.678010929278, 5021.472745361831, 5024.0956627807345, 4727.669063165683, 4961.355023846877, 4992.400911890451, 5021.397432308147, 5052.8484145475695], "value": 4561.739704039316, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.89971309467876, 305.0436880380009, 311.6447250134846, 316.9857356418961, 317.52212919556064, 4599.6320294376455, 5490.313710786152, 5579.85612949346, 5620.325560932689, 5711.114777209529, 4651.581357677808, 4735.550122738343, 5068.72122033288, 5428.4300148484435, 5537.36320323163, 4183.184279065584, 4226.72526285792, 4231.1960727461765, 4232.174725928445, 4254.383114448403, 3920.941185882214, 4168.270552653289, 4234.36976763945, 4246.152923478281, 4251.574842515754, 3434.6221915589267, 3744.9438258426144, 4091.304478238692, 4126.174765046988, 4169.477466132991, 4166.708330416872, 4177.624013838754, 4180.686448516343, 4189.0, 4194.224068547298, 3609.9097522561883, 3611.9638803611892, 3627.805177867405, 3628.183658676803, 3638.599754027055, 4415.403920470728, 5272.578193744491, 5312.415634280226, 5369.704666243355, 5386.973065134688, 4589.0, 4759.833405830814, 4763.833265835679, 4773.904521909542, 4776.713397196179, 5263.4208738058105, 5410.646368829572, 5841.795537156179, 5854.326752423441, 5879.0, 3689.4465830125428, 3901.8244179012013, 3955.406688996645, 3957.406389041638, 3972.272061653161, 5419.458054194589, 5894.941050589482, 6158.168647232611, 6213.316535181127, 6231.40801623845, 3416.214270717749, 3872.3804191329814, 4017.799110044486, 4019.879403617896, 4020.6984476164403, 3774.6036666150208, 4006.0585762345827, 4061.5329237137516, 4091.6112969267874, 4097.078157414558, 4741.644376671763, 4762.761861906891, 4767.308740232716, 4787.832425865078, 4797.496262892416, 4982.0, 5815.331236907725, 5866.296044474605, 5887.587868849225, 5909.763609455574, 1170.1750266062406, 1300.6878349196313, 1301.2452777389092, 1368.9794653080212, 1393.6933874547583, 757.4659864795306, 761.3072104384983, 774.5430196184278, 819.6352623082671, 834.966601335952, 3638.526991491089, 3984.7011474139554, 4489.326601009875, 4594.47163576193, 4727.2909063640045, 4125.66994640428, 4610.838620648328, 4752.312928910256, 5006.247813265328, 5013.448520662724, 4028.4561584186345, 4270.29540125882, 4585.143017078022, 4592.586667199901, 4622.699524530894, 2381.48798008429, 2882.0978154417985, 2922.129836904383, 3158.652548219694, 3194.3132226571397, 5964.5526585505395, 6065.423784740443, 6115.318287470892, 6242.344553821874, 6270.811875643738, 5202.557782588522, 5823.679697616672, 6218.906716399258, 6237.4426485140875, 6271.216097987752, 6215.595986260879, 6300.2754683212015, 6326.778562750282, 6360.968195159087, 6449.96775016122, 5881.0, 6123.203983482119, 6154.630722156685, 6168.444839964424, 6205.596636218631, 4912.680675756064, 6016.87966240664, 6020.64162895015, 6031.698415079316, 6050.97292407031, 6308.899215509955, 6367.52243581724, 6383.138276332821, 6390.297067322684, 6460.418562329413, 3342.9832850836565, 3722.2927643747603, 3867.5165604299464, 3997.000749812547, 4047.4131250969035, 5613.915791263216, 6109.389061093855, 6129.172561704113, 6174.746217630623, 6212.378762123752, 4568.428946381702, 5567.886422715392, 5652.6043176978865, 5830.53355731532, 5862.794802181903, 5070.0, 5285.127953887565, 5566.805161819317, 5919.372172652555, 5958.76164953397, 4312.708337442508, 4514.961558841419, 4880.95119048805, 5014.545781723259, 5635.351934527582, 5845.444682755132, 5867.5305975521005, 5880.970595147168, 5938.2280303560265, 5972.850678733066, 5765.538756899522, 5781.913271300849, 5791.0, 5839.970800146142, 5865.621578929034], "value": 4162.359805168779, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.2644449772237, 747.9065116860393, 751.7293774241268, 760.0499375780274, 811.7077851973288, 14854.183019933913, 15907.0, 15940.601484962881, 15940.601484962881, 15949.601259968507, 14387.496437624684, 14538.12771233724, 14543.272836358192, 14545.345459454324, 14550.199739014377, 667.3593350383613, 697.3619138488277, 812.7561731480562, 827.2182787266036, 851.221132663612, 835.0063424524797, 839.2027573804879, 848.0501837941483, 849.3078141314809, 850.4897061762955, 876.2201640539924, 896.730980705789, 901.3195037746492, 902.4179404284233, 902.4900930974012, 874.3486102853415, 894.9463032218055, 895.7850115972152, 896.3814967672286, 897.8967418746862, 661.0943008078915, 663.3035312921461, 664.5514277862424, 664.5846346033729, 666.2305037681485, 14385.496507622183, 14670.266486675624, 14673.70652586953, 14714.264286785618, 14725.55823325302, 14275.714485710332, 14369.640758981004, 14377.35301911406, 14386.280685965765, 14503.70992580153, 11640.359780212086, 11744.412779361082, 11871.46578403974, 11881.465334059989, 11943.701407464796, 3733.3653278942643, 3760.905977350561, 3771.1572795005013, 3797.259534390795, 3920.392339187402, 104859.0, 104945.47527262391, 106130.0, 110807.3378899309, 110877.44561277222, 10808.621698240524, 10877.0, 10988.340699558052, 11031.117510599133, 11123.499442525106, 22183.889080554494, 22215.333539993826, 22226.777527235834, 22231.333060008226, 22236.332910012727, 6964.0, 7747.922520774833, 7920.76237712858, 8042.517448953082, 8138.3082437993435, 3949.921001579952, 4435.866923992286, 4465.642748580106, 4499.9650080481015, 4693.530646935279, 3118.828464434478, 3160.604924384452, 3549.5208146899836, 3624.4382120771324, 3626.818659067036, 574.9597528173072, 608.4888693497484, 662.9270780214173, 668.3583759590847, 675.6284043775904, 517.5290485658034, 544.705858836224, 579.7912751409489, 625.1997443272618, 629.9181106456223, 7749.0, 8156.1028286888395, 8967.551622418852, 9050.502222377701, 9148.954255228815, 519.4934938434996, 554.3071161048689, 573.243318819163, 582.7668932426978, 597.137136837266, 3720.330340538675, 4393.51671316155, 4412.573654397965, 4415.0, 4566.0411313623845, 138599.0, 142248.2887585576, 146172.538274618, 148092.07631694828, 149233.0, 119180.0, 120893.0, 122156.50887130301, 122927.0, 124237.0, 52807.471925281025, 89118.0, 89886.0, 107013.0, 110762.44618776854, 9516.95241523788, 9602.85595716051, 9761.658341957997, 9788.168005719308, 9816.214702823614, 46212.306815397125, 49744.25383619176, 58551.70724146352, 59097.40902590919, 60284.39715602788, 83965.0, 88980.5550972241, 90267.0, 90299.93650285622, 90606.54696726475, 12697.619071427873, 12862.742745144858, 13067.607971760483, 13137.934310328386, 13324.267165306, 14007.43970241179, 14020.859791401956, 14282.0, 14411.495597654031, 14818.481353152589, 13340.533081342106, 13459.327033648475, 13540.72918541604, 13618.93190534041, 14028.929855350658, 12217.816732749194, 12217.938910305747, 13314.267715275753, 13483.123596966167, 13917.652058698613, 10305.227107966783, 12065.517379304729, 13263.336833158497, 13477.46090156422, 13593.32033398346, 9448.858242142662, 9689.885663148829, 11278.943605281922, 11316.7736645265, 11490.310581365145, 8872.068432814462, 9341.813163736822, 9750.741188096887, 9924.730968115571, 10495.632652857113], "value": 7563.466932746024, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 119.0, 121.0, 165.0, 138.0, 119.0, 114.0, 119.0, 119.0, 117.0], "value": 124.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 128.0, 142.0, 176.0, 112.0, 112.0, 113.0, 111.0, 143.0, 116.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 202.0, 207.0, 225.0, 200.0, 198.0, 197.0, 202.0, 208.0, 213.0], "value": 204.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 72.0, 49.0, 76.0, 71.0, 86.0, 83.0, 53.0, 96.0, 85.0], "value": 76.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 87.0, 73.0, 69.0, 72.0, 119.0, 96.0, 70.0, 89.0], "value": 83.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 91.0, 90.0, 91.0, 88.0, 93.0, 89.0, 96.0, 132.0], "value": 95.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 101.0, 99.0, 103.0, 100.0, 170.0, 133.0, 101.0, 101.0, 102.0], "value": 111.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 149.0, 139.0, 94.0, 92.0, 90.0, 110.0, 90.0, 126.0, 87.0], "value": 110.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 56.0, 57.0, 59.0, 60.0, 61.0, 85.0, 68.0], "value": 61.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 69.0, 84.0, 67.0, 100.0, 105.0, 104.0, 71.0, 72.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 88.0, 87.0, 105.0, 72.0, 97.0, 108.0, 109.0, 89.0], "value": 92.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 157.0, 140.0, 143.0, 155.0, 150.0, 154.0, 174.0, 178.0, 149.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 178.0, 175.0, 171.0, 195.0, 154.0, 208.0, 235.0, 221.0], "value": 188.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 69.0, 67.0, 70.0, 89.0, 87.0, 90.0, 89.0], "value": 76.8, "unit": "score"}]}]} 06:34:32 INFO - Return code: 0 06:34:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:34:32 ERROR - # TBPL SUCCESS # 06:34:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:34:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:34:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:34:32 INFO - 2016-09-28 06:34:32.739 screenresolution[1680:10929] starting screenresolution argv=screenresolution get 06:34:32 INFO - 2016-09-28 06:34:32.742 screenresolution[1680:10929] Display 0: 1600x1200x32@60 06:34:32 INFO - 2016-09-28 06:34:32.748 screenresolution[1681:10932] starting screenresolution argv=screenresolution list 06:34:32 INFO - Available Modes on Display 0 06:34:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:34:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:34:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:34:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:34:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:34:32 INFO - Intel Iris: 06:34:32 INFO - Chipset Model: Intel Iris 06:34:32 INFO - Type: GPU 06:34:32 INFO - Bus: Built-In 06:34:32 INFO - VRAM (Dynamic, Max): 1536 MB 06:34:32 INFO - Vendor: Intel (0x8086) 06:34:32 INFO - Device ID: 0x0a2e 06:34:32 INFO - Revision ID: 0x0009 06:34:32 INFO - Displays: 06:34:32 INFO - Display: 06:34:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:34:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:34:32 INFO - Display Serial Number: 1600x1200 60 06:34:32 INFO - Main Display: Yes 06:34:32 INFO - Mirror: Off 06:34:32 INFO - Online: Yes 06:34:32 INFO - Rotation: Supported 06:34:32 INFO - Return code: 0 06:34:32 INFO - Running post-action listener: _resource_record_post_action 06:34:32 INFO - [mozharness: 2016-09-28 13:34:32.983336Z] Finished run-tests step (success) 06:34:32 INFO - Running post-run listener: _resource_record_post_run 06:34:33 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 33640960; Write bytes: 709474816; Read time: 318; Write time: 1942 06:34:33 INFO - TinderboxPrint: CPU usage
54.6% 06:34:33 INFO - TinderboxPrint: I/O read bytes / time
33,640,960 / 318 06:34:33 INFO - TinderboxPrint: I/O write bytes / time
709,474,816 / 1,942 06:34:33 INFO - TinderboxPrint: CPU idle
2,198.2 (45.4%) 06:34:33 INFO - TinderboxPrint: CPU system
985.0 (20.3%) 06:34:33 INFO - TinderboxPrint: CPU user
1,658.5 (34.3%) 06:34:33 INFO - TinderboxPrint: Swap in / out
436,551,680 / 0 06:34:33 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 407816704; Write bytes: 402122240; Read time: 31391; Write time: 687 06:34:33 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 29815296; Write bytes: 296688640; Read time: 285; Write time: 1166 06:34:33 INFO - Running post-run listener: _upload_blobber_files 06:34:33 INFO - Blob upload gear active. 06:34:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:34:33 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 06:34:33 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'] 06:34:33 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 06:34:33 INFO - (blobuploader) - INFO - Open directory for files ... 06:34:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:34:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:34:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:34 INFO - (blobuploader) - INFO - Done attempting. 06:34:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:34:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:34:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:35 INFO - (blobuploader) - INFO - Done attempting. 06:34:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:34:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:34:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:37 INFO - (blobuploader) - INFO - Done attempting. 06:34:37 INFO - (blobuploader) - INFO - Iteration through files over. 06:34:37 INFO - Return code: 0 06:34:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:34:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:34:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16e35df16fe321c7c9779a7806e062e15f045a6099834f5fe07641fd1490eacc213518edbb523df4475a0687e59b640389d3aa11347ab7f53731241b31187ec6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a771790b5dcae6baad01eba036c6e63ce255b25b0c07b4932cf84c8fa8d493e6f131bcfc3e87e07d4c232f5856b35fcdc73039004e2ae606b5df4a4d9d06152", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/66f52f960beb7c69ff7f1404f63d6fe08db41de291500f097f75ad27682b1b72c5c91c6fcaf90a72410fcf74d50a2c14f971bd3a920277a0cb39ac589ac2a885"} 06:34:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:34:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:34:37 INFO - Contents: 06:34:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16e35df16fe321c7c9779a7806e062e15f045a6099834f5fe07641fd1490eacc213518edbb523df4475a0687e59b640389d3aa11347ab7f53731241b31187ec6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a771790b5dcae6baad01eba036c6e63ce255b25b0c07b4932cf84c8fa8d493e6f131bcfc3e87e07d4c232f5856b35fcdc73039004e2ae606b5df4a4d9d06152", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/66f52f960beb7c69ff7f1404f63d6fe08db41de291500f097f75ad27682b1b72c5c91c6fcaf90a72410fcf74d50a2c14f971bd3a920277a0cb39ac589ac2a885"} 06:34:37 INFO - Running post-run listener: copy_logs_to_upload_dir 06:34:37 INFO - Copying logs to upload dir... 06:34:37 INFO - mkdir: /builds/slave/test/build/upload/logs 06:34:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.080922 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-09-28 06:34:38.099064) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 06:34:38.103420) ========= 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.y5Oc9dI4ru/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.MlszoWiDXY/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16e35df16fe321c7c9779a7806e062e15f045a6099834f5fe07641fd1490eacc213518edbb523df4475a0687e59b640389d3aa11347ab7f53731241b31187ec6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a771790b5dcae6baad01eba036c6e63ce255b25b0c07b4932cf84c8fa8d493e6f131bcfc3e87e07d4c232f5856b35fcdc73039004e2ae606b5df4a4d9d06152", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/66f52f960beb7c69ff7f1404f63d6fe08db41de291500f097f75ad27682b1b72c5c91c6fcaf90a72410fcf74d50a2c14f971bd3a920277a0cb39ac589ac2a885"} build_url:https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011088 build_url: 'https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16e35df16fe321c7c9779a7806e062e15f045a6099834f5fe07641fd1490eacc213518edbb523df4475a0687e59b640389d3aa11347ab7f53731241b31187ec6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a771790b5dcae6baad01eba036c6e63ce255b25b0c07b4932cf84c8fa8d493e6f131bcfc3e87e07d4c232f5856b35fcdc73039004e2ae606b5df4a4d9d06152", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/66f52f960beb7c69ff7f1404f63d6fe08db41de291500f097f75ad27682b1b72c5c91c6fcaf90a72410fcf74d50a2c14f971bd3a920277a0cb39ac589ac2a885"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 06:34:38.144786) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-09-28 06:34:38.145175) ========= 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.y5Oc9dI4ru/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.MlszoWiDXY/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.004961 ========= master_lag: 2.30 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-09-28 06:34:40.453009) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 06:34:40.453356) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 06:34:40.454307) ========= ========= Total master_lag: 2.48 =========