builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0246 starttime: 1480753721.96 results: success (0) buildid: 20161202221844 builduid: b24133900846405a94f0b13723963c53 revision: 557548714db55136b51e1129d649e2599797985f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-03 00:28:41.964800) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-03 00:28:41.965214) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-03 00:28:41.965494) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-03 00:28:42.145091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 00:28:42.145439) ========= 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.SlZBYVFMMG/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.C77yp6vnDY/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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-12-03 00:28:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.8M=0.001s 2016-12-03 00:28:42 (17.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.418956 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 00:28:42.594540) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 00:28:42.594829) ========= 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.SlZBYVFMMG/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.C77yp6vnDY/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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.024762 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 00:28:42.642458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-03 00:28:42.642771) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 557548714db55136b51e1129d649e2599797985f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 557548714db55136b51e1129d649e2599797985f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SlZBYVFMMG/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.C77yp6vnDY/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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-12-03 00:28:42,741 truncating revision to first 12 chars 2016-12-03 00:28:42,741 Setting DEBUG logging. 2016-12-03 00:28:42,741 attempt 1/10 2016-12-03 00:28:42,741 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/557548714db5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-03 00:28:43,540 unpacking tar archive at: mozilla-central-557548714db5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.073475 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-03 00:28:43.739500) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-03 00:28:43.739801) ========= script_repo_revision: 557548714db55136b51e1129d649e2599797985f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-03 00:28:43.740186) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-03 00:28:43.740464) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-03 00:28:43.761292) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-12-03 00:28:43.761587) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SlZBYVFMMG/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.C77yp6vnDY/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 00:28:43 INFO - MultiFileLogger online at 20161203 00:28:43 in /builds/slave/test 00:28:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 00:28:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:28:43 INFO - {'append_to_log': False, 00:28:43 INFO - 'base_work_dir': '/builds/slave/test', 00:28:43 INFO - 'blob_upload_branch': 'Firefox', 00:28:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:28:43 INFO - 'branch': 'Firefox', 00:28:43 INFO - 'buildbot_json_path': 'buildprops.json', 00:28:43 INFO - 'config_files': ('talos/mac_config.py',), 00:28:43 INFO - 'default_actions': ('clobber', 00:28:43 INFO - 'read-buildbot-config', 00:28:43 INFO - 'download-and-extract', 00:28:43 INFO - 'populate-webroot', 00:28:43 INFO - 'create-virtualenv', 00:28:43 INFO - 'install', 00:28:43 INFO - 'run-tests'), 00:28:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:28:43 INFO - 'download_minidump_stackwalk': True, 00:28:43 INFO - 'download_symbols': 'ondemand', 00:28:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:28:43 INFO - 'tooltool.py': '/tools/tooltool.py', 00:28:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:28:43 INFO - '/tools/misc-python/virtualenv.py')}, 00:28:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:28:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:28:43 INFO - 'installer_path': 'installer.exe', 00:28:43 INFO - 'log_level': 'info', 00:28:43 INFO - 'log_name': 'talos', 00:28:43 INFO - 'log_to_console': True, 00:28:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:28:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:28:43 INFO - 'opt_config_files': (), 00:28:43 INFO - 'pip_index': False, 00:28:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:28:43 INFO - 'cmd': ('bash', 00:28:43 INFO - '-c', 00:28:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:28:43 INFO - 'enabled': True, 00:28:43 INFO - 'halt_on_failure': False, 00:28:43 INFO - 'name': 'check_screen_resolution'},), 00:28:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:28:43 INFO - 'cmd': ('bash', 00:28:43 INFO - '-c', 00:28:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:28:43 INFO - 'enabled': True, 00:28:43 INFO - 'halt_on_failure': False, 00:28:43 INFO - 'name': 'check_screen_resolution'},), 00:28:43 INFO - 'run_cmd_checks_enabled': True, 00:28:43 INFO - 'sps_profile': False, 00:28:43 INFO - 'sps_profile_interval': 0, 00:28:43 INFO - 'suite': 'dromaeojs-e10s', 00:28:43 INFO - 'system_bits': '32', 00:28:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:28:43 INFO - 'title': 't-yosemite-r7-0246', 00:28:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:28:43 INFO - 'use_talos_json': True, 00:28:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:28:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:28:43 INFO - 'work_dir': 'build'} 00:28:43 INFO - [mozharness: 2016-12-03 08:28:43.969882Z] Running clobber step. 00:28:43 INFO - Running pre-action listener: _resource_record_pre_action 00:28:43 INFO - Running main action method: clobber 00:28:43 INFO - rmtree: /builds/slave/test/build 00:28:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:28:46 INFO - Running post-action listener: _resource_record_post_action 00:28:46 INFO - [mozharness: 2016-12-03 08:28:46.250521Z] Finished clobber step (success) 00:28:46 INFO - [mozharness: 2016-12-03 08:28:46.250640Z] Running read-buildbot-config step. 00:28:46 INFO - Running pre-action listener: _resource_record_pre_action 00:28:46 INFO - Running main action method: read_buildbot_config 00:28:46 INFO - Using buildbot properties: 00:28:46 INFO - { 00:28:46 INFO - "project": "", 00:28:46 INFO - "product": "firefox", 00:28:46 INFO - "script_repo_revision": "production", 00:28:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 00:28:46 INFO - "repository": "", 00:28:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 00:28:46 INFO - "buildid": "20161202221844", 00:28:46 INFO - "pgo_build": "False", 00:28:46 INFO - "basedir": "/builds/slave/test", 00:28:46 INFO - "buildnumber": 36, 00:28:46 INFO - "slavename": "t-yosemite-r7-0246", 00:28:46 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 00:28:46 INFO - "platform": "yosemite_r7", 00:28:46 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 00:28:46 INFO - "branch": "mozilla-central", 00:28:46 INFO - "repo_path": "mozilla-central", 00:28:46 INFO - "revision": "557548714db55136b51e1129d649e2599797985f", 00:28:46 INFO - "stage_platform": "macosx64", 00:28:46 INFO - "builduid": "b24133900846405a94f0b13723963c53", 00:28:46 INFO - "slavebuilddir": "test" 00:28:46 INFO - } 00:28:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 00:28:46 INFO - Running post-action listener: _resource_record_post_action 00:28:46 INFO - [mozharness: 2016-12-03 08:28:46.253827Z] Finished read-buildbot-config step (success) 00:28:46 INFO - [mozharness: 2016-12-03 08:28:46.253933Z] Running download-and-extract step. 00:28:46 INFO - Running pre-action listener: _resource_record_pre_action 00:28:46 INFO - Running main action method: download_and_extract 00:28:46 INFO - mkdir: /builds/slave/test/build/tests 00:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:28:46 INFO - trying https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 00:28:46 INFO - Downloading https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 00:28:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 00:28:46 INFO - Downloaded 1199 bytes. 00:28:46 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 00:28:46 INFO - Using the following test package requirements: 00:28:46 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 00:28:46 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:28:46 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 00:28:46 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:28:46 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 00:28:46 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:28:46 INFO - u'jsshell-mac.zip'], 00:28:46 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:28:46 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 00:28:46 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 00:28:46 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:28:46 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 00:28:46 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:28:46 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 00:28:46 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:28:46 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 00:28:46 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 00:28:46 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 00:28:46 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:28:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 00:28:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:28:46 INFO - Fetch https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 00:28:48 INFO - Expected file size: 16283750 00:28:48 INFO - Obtained file size: 16283750 00:28:54 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 00:28:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 00:28:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:28:54 INFO - Fetch https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 00:28:55 INFO - Expected file size: 16283750 00:28:55 INFO - Obtained file size: 16283750 00:29:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 00:29:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:29:01 INFO - Fetch https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 00:29:03 INFO - Expected file size: 14409734 00:29:03 INFO - Obtained file size: 14409734 00:29:03 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')]} 00:29:03 INFO - trying https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 00:29:03 INFO - Downloading https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 00:29:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 00:29:07 INFO - Downloaded 107591633 bytes. 00:29:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 00:29:07 INFO - mkdir: /builds/slave/test/properties 00:29:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:29:07 INFO - Writing to file /builds/slave/test/properties/build_url 00:29:07 INFO - Contents: 00:29:07 INFO - build_url:https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 00:29:08 INFO - Running post-action listener: _resource_record_post_action 00:29:08 INFO - Running post-action listener: set_extra_try_arguments 00:29:08 INFO - [mozharness: 2016-12-03 08:29:08.198783Z] Finished download-and-extract step (success) 00:29:08 INFO - [mozharness: 2016-12-03 08:29:08.198904Z] Running populate-webroot step. 00:29:08 INFO - Running pre-action listener: _resource_record_pre_action 00:29:08 INFO - Running main action method: populate_webroot 00:29:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:29:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:29:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:29:08 INFO - '--tppagecycles', 00:29:08 INFO - '7'], 00:29:08 INFO - 'tests': ['tsvgm']}}, 00:29:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:29:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:29:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:29:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:29:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:29:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:29:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 00:29:08 INFO - 'talos_options': ['--disable-e10s'], 00:29:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:29:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:29:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:29:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 00:29:08 INFO - 'talos_options': ['--disable-e10s'], 00:29:08 INFO - 'tests': ['damp', 'tps']}, 00:29:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:29:08 INFO - 'tests': ['damp', 'tps']}, 00:29:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:29:08 INFO - 'tests': ['dromaeo_dom']}, 00:29:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:29:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:29:08 INFO - 'tests': ['basic_compositor_video']}, 00:29:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:29:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:29:08 INFO - 'tests': ['a11yr', 00:29:08 INFO - 'ts_paint', 00:29:08 INFO - 'tpaint', 00:29:08 INFO - 'sessionrestore', 00:29:08 INFO - 'sessionrestore_no_auto_restore', 00:29:08 INFO - 'tabpaint']}, 00:29:08 INFO - 'other-e10s': {'tests': ['a11yr', 00:29:08 INFO - 'ts_paint', 00:29:08 INFO - 'tpaint', 00:29:08 INFO - 'sessionrestore', 00:29:08 INFO - 'sessionrestore_no_auto_restore', 00:29:08 INFO - 'tabpaint']}, 00:29:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:29:08 INFO - 'ts_paint', 00:29:08 INFO - 'tpaint', 00:29:08 INFO - 'sessionrestore', 00:29:08 INFO - 'sessionrestore_no_auto_restore', 00:29:08 INFO - 'tabpaint']}, 00:29:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:29:08 INFO - 'ts_paint', 00:29:08 INFO - 'tpaint', 00:29:08 INFO - 'sessionrestore', 00:29:08 INFO - 'sessionrestore_no_auto_restore', 00:29:08 INFO - 'tabpaint']}, 00:29:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:29:08 INFO - 'tests': ['a11yr', 00:29:08 INFO - 'ts_paint', 00:29:08 INFO - 'tpaint', 00:29:08 INFO - 'sessionrestore', 00:29:08 INFO - 'sessionrestore_no_auto_restore', 00:29:08 INFO - 'tabpaint']}, 00:29:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:29:08 INFO - 'tests': ['a11yr', 00:29:08 INFO - 'ts_paint', 00:29:08 INFO - 'tpaint', 00:29:08 INFO - 'sessionrestore', 00:29:08 INFO - 'sessionrestore_no_auto_restore', 00:29:08 INFO - 'tabpaint']}, 00:29:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:29:08 INFO - 'tests': ['tsvgx', 00:29:08 INFO - 'tsvgr_opacity', 00:29:08 INFO - 'tart', 00:29:08 INFO - 'tscrollx', 00:29:08 INFO - 'cart', 00:29:08 INFO - 'tsvg_static']}, 00:29:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:29:08 INFO - 'tsvgr_opacity', 00:29:08 INFO - 'tart', 00:29:08 INFO - 'tscrollx', 00:29:08 INFO - 'cart', 00:29:08 INFO - 'tsvg_static']}, 00:29:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 00:29:08 INFO - 'talos_options': ['--disable-e10s'], 00:29:08 INFO - 'tests': ['tp5o']}, 00:29:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:29:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 00:29:08 INFO - 'talos_options': ['--disable-e10s', 00:29:08 INFO - '--xperf_path', 00:29:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:29:08 INFO - 'tests': ['tp5n']}, 00:29:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:29:08 INFO - 'talos_options': ['--xperf_path', 00:29:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:29:08 INFO - 'tests': ['tp5n']}}, 00:29:08 INFO - 'talos.zip': {'path': '', 00:29:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:29:08 INFO - Running post-action listener: _resource_record_post_action 00:29:08 INFO - [mozharness: 2016-12-03 08:29:08.216796Z] Finished populate-webroot step (success) 00:29:08 INFO - [mozharness: 2016-12-03 08:29:08.216906Z] Running create-virtualenv step. 00:29:08 INFO - Running pre-action listener: _resource_record_pre_action 00:29:08 INFO - Running main action method: create_virtualenv 00:29:08 INFO - Creating virtualenv /builds/slave/test/build/venv 00:29:08 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 00:29:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:29:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:29:08 INFO - Using real prefix '/tools/python27' 00:29:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:29:09 INFO - Installing distribute.............................................................................................................................................................................................done. 00:29:11 INFO - Installing pip.................done. 00:29:11 INFO - Return code: 0 00:29:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:29:12 INFO - Reading from file tmpfile_stdout 00:29:12 INFO - Output received: 00:29:12 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) 00:29:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:12 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 0x10609e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac34721a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb3d30>, '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 0x105d1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eabb20>, '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.SlZBYVFMMG/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.C77yp6vnDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 00:29:12 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 00:29:12 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 00:29:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SlZBYVFMMG/Render', 00:29:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:29:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:29:12 INFO - 'HOME': '/Users/cltbld', 00:29:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:29:12 INFO - 'LOGNAME': 'cltbld', 00:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:12 INFO - 'MOZ_NO_REMOTE': '1', 00:29:12 INFO - 'NO_EM_RESTART': '1', 00:29:12 INFO - 'PAGER': '/bin/cat', 00:29:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:12 INFO - 'PWD': '/builds/slave/test', 00:29:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:29:12 INFO - 'SHELL': '/bin/bash', 00:29:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C77yp6vnDY/Listeners', 00:29:12 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 00:29:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:29:12 INFO - 'USER': 'cltbld', 00:29:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:29:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:12 INFO - 'XPC_FLAGS': '0x0', 00:29:12 INFO - 'XPC_SERVICE_NAME': '0', 00:29:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:12 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 00:29:12 INFO - Cleaning up... 00:29:12 INFO - Return code: 0 00:29:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:12 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 0x10609e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac34721a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb3d30>, '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 0x105d1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eabb20>, '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.SlZBYVFMMG/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.C77yp6vnDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 00:29:12 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 00:29:12 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 00:29:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SlZBYVFMMG/Render', 00:29:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:29:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:29:12 INFO - 'HOME': '/Users/cltbld', 00:29:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:29:12 INFO - 'LOGNAME': 'cltbld', 00:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:12 INFO - 'MOZ_NO_REMOTE': '1', 00:29:12 INFO - 'NO_EM_RESTART': '1', 00:29:12 INFO - 'PAGER': '/bin/cat', 00:29:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:12 INFO - 'PWD': '/builds/slave/test', 00:29:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:29:12 INFO - 'SHELL': '/bin/bash', 00:29:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C77yp6vnDY/Listeners', 00:29:12 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 00:29:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:29:12 INFO - 'USER': 'cltbld', 00:29:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:29:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:12 INFO - 'XPC_FLAGS': '0x0', 00:29:12 INFO - 'XPC_SERVICE_NAME': '0', 00:29:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:12 INFO - Downloading/unpacking psutil>=3.1.1 00:29:12 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 00:29:12 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 00:29:12 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 00:29:12 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 00:29:12 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 00:29:12 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 00:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:29:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:29:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:29:16 INFO - Installing collected packages: psutil 00:29:16 INFO - Running setup.py install for psutil 00:29:16 INFO - building 'psutil._psutil_osx' extension 00:29:16 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 00:29:17 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 00:29:17 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 00:29:17 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 00:29:17 INFO - building 'psutil._psutil_posix' extension 00:29:17 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 00:29:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:29:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:29:17 INFO - ^ 00:29:17 INFO - 1 warning generated. 00:29:17 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 00:29:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:29:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:29:17 INFO - Successfully installed psutil 00:29:17 INFO - Cleaning up... 00:29:17 INFO - Return code: 0 00:29:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10609e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac34721a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb3d30>, '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 0x105d1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eabb20>, '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.SlZBYVFMMG/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.C77yp6vnDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 00:29:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:29:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SlZBYVFMMG/Render', 00:29:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:29:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:29:17 INFO - 'HOME': '/Users/cltbld', 00:29:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:29:17 INFO - 'LOGNAME': 'cltbld', 00:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:17 INFO - 'MOZ_NO_REMOTE': '1', 00:29:17 INFO - 'NO_EM_RESTART': '1', 00:29:17 INFO - 'PAGER': '/bin/cat', 00:29:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:17 INFO - 'PWD': '/builds/slave/test', 00:29:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:29:17 INFO - 'SHELL': '/bin/bash', 00:29:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C77yp6vnDY/Listeners', 00:29:17 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 00:29:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:29:17 INFO - 'USER': 'cltbld', 00:29:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:29:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:17 INFO - 'XPC_FLAGS': '0x0', 00:29:17 INFO - 'XPC_SERVICE_NAME': '0', 00:29:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:29:18 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 00:29:18 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 00:29:18 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 00:29:18 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 00:29:18 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 00:29:18 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 00:29:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:29:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:29:20 INFO - Installing collected packages: mozsystemmonitor 00:29:20 INFO - Running setup.py install for mozsystemmonitor 00:29:20 INFO - Successfully installed mozsystemmonitor 00:29:20 INFO - Cleaning up... 00:29:21 INFO - Return code: 0 00:29:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:29: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')]} 00:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29: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')]} 00:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10609e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac34721a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb3d30>, '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 0x105d1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eabb20>, '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.SlZBYVFMMG/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.C77yp6vnDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 00:29: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==2.5.1'] in /builds/slave/test/build 00:29: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==2.5.1 00:29:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SlZBYVFMMG/Render', 00:29:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:29:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:29:21 INFO - 'HOME': '/Users/cltbld', 00:29:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:29:21 INFO - 'LOGNAME': 'cltbld', 00:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:21 INFO - 'MOZ_NO_REMOTE': '1', 00:29:21 INFO - 'NO_EM_RESTART': '1', 00:29:21 INFO - 'PAGER': '/bin/cat', 00:29:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:21 INFO - 'PWD': '/builds/slave/test', 00:29:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:29:21 INFO - 'SHELL': '/bin/bash', 00:29:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C77yp6vnDY/Listeners', 00:29:21 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 00:29:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:29:21 INFO - 'USER': 'cltbld', 00:29:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:29:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:21 INFO - 'XPC_FLAGS': '0x0', 00:29:21 INFO - 'XPC_SERVICE_NAME': '0', 00:29:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:21 INFO - Downloading/unpacking jsonschema==2.5.1 00:29:21 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 00:29:21 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 00:29:21 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 00:29:21 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 00:29:21 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 00:29:21 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 00:29:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:29:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:29:23 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 00:29:23 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 00:29:23 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 00:29:23 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 00:29:23 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 00:29:23 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 00:29:24 INFO - Downloading functools32-3.2.3-2.tar.gz 00:29:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:29:24 INFO - warning: no files found matching '*.txt' 00:29:24 INFO - no previously-included directories found matching 'build' 00:29:24 INFO - no previously-included directories found matching 'dist' 00:29:24 INFO - no previously-included directories found matching '.git*' 00:29:24 INFO - Installing collected packages: jsonschema, functools32 00:29:24 INFO - Running setup.py install for functools32 00:29:24 INFO - warning: no files found matching '*.txt' 00:29:24 INFO - no previously-included directories found matching 'build' 00:29:24 INFO - no previously-included directories found matching 'dist' 00:29:24 INFO - no previously-included directories found matching '.git*' 00:29:24 INFO - Successfully installed jsonschema functools32 00:29:24 INFO - Cleaning up... 00:29:24 INFO - Return code: 0 00:29:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10609e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac34721a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb3d30>, '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 0x105d1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eabb20>, '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.SlZBYVFMMG/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.C77yp6vnDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 00:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:29:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SlZBYVFMMG/Render', 00:29:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:29:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:29:24 INFO - 'HOME': '/Users/cltbld', 00:29:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:29:24 INFO - 'LOGNAME': 'cltbld', 00:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:24 INFO - 'MOZ_NO_REMOTE': '1', 00:29:24 INFO - 'NO_EM_RESTART': '1', 00:29:24 INFO - 'PAGER': '/bin/cat', 00:29:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:24 INFO - 'PWD': '/builds/slave/test', 00:29:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:29:24 INFO - 'SHELL': '/bin/bash', 00:29:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C77yp6vnDY/Listeners', 00:29:24 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 00:29:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:29:24 INFO - 'USER': 'cltbld', 00:29:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:29:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:24 INFO - 'XPC_FLAGS': '0x0', 00:29:24 INFO - 'XPC_SERVICE_NAME': '0', 00:29:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:29:24 INFO - Cleaning up... 00:29:24 INFO - Return code: 0 00:29:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10609e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac34721a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb3d30>, '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 0x105d1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eabb20>, '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.SlZBYVFMMG/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.C77yp6vnDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 00:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:29:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SlZBYVFMMG/Render', 00:29:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:29:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:29:24 INFO - 'HOME': '/Users/cltbld', 00:29:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:29:24 INFO - 'LOGNAME': 'cltbld', 00:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:24 INFO - 'MOZ_NO_REMOTE': '1', 00:29:24 INFO - 'NO_EM_RESTART': '1', 00:29:24 INFO - 'PAGER': '/bin/cat', 00:29:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:24 INFO - 'PWD': '/builds/slave/test', 00:29:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:29:24 INFO - 'SHELL': '/bin/bash', 00:29:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C77yp6vnDY/Listeners', 00:29:24 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 00:29:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:29:24 INFO - 'USER': 'cltbld', 00:29:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:29:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:24 INFO - 'XPC_FLAGS': '0x0', 00:29:24 INFO - 'XPC_SERVICE_NAME': '0', 00:29:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:29:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:25 INFO - Downloading/unpacking blobuploader==1.2.4 00:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:29:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:29:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:29:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:29:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:29:27 INFO - Downloading blobuploader-1.2.4.tar.gz 00:29:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:29:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:29:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:29:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:29:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:29:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:29:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:29:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:29:28 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 00:29:28 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 00:29:28 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 00:29:28 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 00:29:28 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 00:29:28 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 00:29:28 INFO - Downloading docopt-0.6.1.tar.gz 00:29:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:29:29 INFO - Installing collected packages: blobuploader, requests, docopt 00:29:29 INFO - Running setup.py install for blobuploader 00:29:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:29:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:29:29 INFO - Running setup.py install for requests 00:29:29 INFO - Running setup.py install for docopt 00:29:29 INFO - Successfully installed blobuploader requests docopt 00:29:29 INFO - Cleaning up... 00:29:30 INFO - Return code: 0 00:29:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:30 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 0x10609e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac34721a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb3d30>, '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 0x105d1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eabb20>, '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.SlZBYVFMMG/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.C77yp6vnDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 00:29:30 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 00:29:30 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 00:29:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SlZBYVFMMG/Render', 00:29:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:29:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:29:30 INFO - 'HOME': '/Users/cltbld', 00:29:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:29:30 INFO - 'LOGNAME': 'cltbld', 00:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:30 INFO - 'MOZ_NO_REMOTE': '1', 00:29:30 INFO - 'NO_EM_RESTART': '1', 00:29:30 INFO - 'PAGER': '/bin/cat', 00:29:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:30 INFO - 'PWD': '/builds/slave/test', 00:29:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:29:30 INFO - 'SHELL': '/bin/bash', 00:29:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C77yp6vnDY/Listeners', 00:29:30 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 00:29:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:29:30 INFO - 'USER': 'cltbld', 00:29:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:29:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:30 INFO - 'XPC_FLAGS': '0x0', 00:29:30 INFO - 'XPC_SERVICE_NAME': '0', 00:29:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:29:30 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-xm3C4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:29:30 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-vFhhxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:29:30 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-iY2QcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:29:30 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-6IiJTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:29:30 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-k3n8_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:29:30 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-YnfbIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:29:30 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-OVSYzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:29:30 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-TKPXxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:29:31 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-_nij82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:29:31 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-AVDZ0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:29:31 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-nVJII4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:29:31 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-IfAgAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:29:31 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-27ngB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:29:31 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-qSkZA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:29:31 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-Koitzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:29:31 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-0VU_i6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:29:31 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-1JrMTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:29:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:29:32 INFO - Running setup.py install for manifestparser 00:29:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:29:32 INFO - Running setup.py install for mozcrash 00:29:32 INFO - Running setup.py install for mozdebug 00:29:32 INFO - Running setup.py install for mozdevice 00:29:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:29:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:29:32 INFO - Running setup.py install for mozfile 00:29:32 INFO - Running setup.py install for mozhttpd 00:29:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:29:32 INFO - Running setup.py install for mozinfo 00:29:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:29:33 INFO - Running setup.py install for mozInstall 00:29:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:29:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:29:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:29:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:29:33 INFO - Running setup.py install for mozleak 00:29:33 INFO - Running setup.py install for mozlog 00:29:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:29:33 INFO - Running setup.py install for moznetwork 00:29:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:29:33 INFO - Running setup.py install for mozprocess 00:29:33 INFO - Running setup.py install for mozprofile 00:29:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:29:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:29:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:29:33 INFO - Running setup.py install for mozrunner 00:29:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:29:34 INFO - Running setup.py install for mozscreenshot 00:29:34 INFO - Running setup.py install for moztest 00:29:34 INFO - Running setup.py install for mozversion 00:29:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:29:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:29:34 INFO - Cleaning up... 00:29:34 INFO - Return code: 0 00:29:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:29:34 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')]} 00:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:34 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')]} 00:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:34 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 0x10609e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac34721a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb3d30>, '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 0x105d1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eabb20>, '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.SlZBYVFMMG/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.C77yp6vnDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 00:29:34 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 00:29:34 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 00:29:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SlZBYVFMMG/Render', 00:29:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:29:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:29:34 INFO - 'HOME': '/Users/cltbld', 00:29:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:29:34 INFO - 'LOGNAME': 'cltbld', 00:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:34 INFO - 'MOZ_NO_REMOTE': '1', 00:29:34 INFO - 'NO_EM_RESTART': '1', 00:29:34 INFO - 'PAGER': '/bin/cat', 00:29:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:34 INFO - 'PWD': '/builds/slave/test', 00:29:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:29:34 INFO - 'SHELL': '/bin/bash', 00:29:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C77yp6vnDY/Listeners', 00:29:34 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 00:29:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:29:34 INFO - 'USER': 'cltbld', 00:29:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:29:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:34 INFO - 'XPC_FLAGS': '0x0', 00:29:34 INFO - 'XPC_SERVICE_NAME': '0', 00:29:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:29:34 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-7cNsYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:29:34 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)) 00:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:29:34 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-bkb4Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:29:35 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-FFwpBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:29:35 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)) 00:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:29:35 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-pd2wO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:29:35 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-12wiIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:29:35 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)) 00:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:29:35 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-xG3U1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:29:35 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)) 00:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:29:35 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-XvZ3s7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:29:35 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)) 00:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:29:35 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-2_vlZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:29:35 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)) 00:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:29:35 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-f7ghXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:29:35 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)) 00:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:29:35 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-dXTaW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:29:35 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)) 00:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:29:35 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-P6Er8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:29:36 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)) 00:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:29:36 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-Me_hPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:29:36 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)) 00:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:29:36 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-LoD475-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:29:36 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)) 00:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:29:36 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-zHlQYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:29:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:29:36 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-VIVkvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:29:36 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)) 00:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:29:36 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-lLpFce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:29:36 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)) 00:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:29:36 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-rYSyrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:29:36 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)) 00:29:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:29:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:29:36 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)) 00:29:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:29:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:29:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:29:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:29:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:29:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:29:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:29:39 INFO - Downloading blessings-1.6.tar.gz 00:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:29:39 INFO - Installing collected packages: blessings 00:29:39 INFO - Running setup.py install for blessings 00:29:39 INFO - Successfully installed blessings 00:29:39 INFO - Cleaning up... 00:29:39 INFO - Return code: 0 00:29:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:29:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:29:39 INFO - Reading from file tmpfile_stdout 00:29:39 INFO - Current package versions: 00:29:39 INFO - blessings == 1.6 00:29:39 INFO - blobuploader == 1.2.4 00:29:39 INFO - docopt == 0.6.1 00:29:39 INFO - functools32 == 3.2.3-2 00:29:39 INFO - jsonschema == 2.5.1 00:29:39 INFO - manifestparser == 1.1 00:29:39 INFO - mozInstall == 1.12 00:29:39 INFO - mozcrash == 1.0 00:29:39 INFO - mozdebug == 0.1 00:29:39 INFO - mozdevice == 0.49 00:29:39 INFO - mozfile == 1.2 00:29:39 INFO - mozhttpd == 0.7 00:29:39 INFO - mozinfo == 0.9 00:29:39 INFO - mozleak == 0.1 00:29:39 INFO - mozlog == 3.4 00:29:39 INFO - moznetwork == 0.27 00:29:39 INFO - mozprocess == 0.23 00:29:39 INFO - mozprofile == 0.28 00:29:39 INFO - mozrunner == 6.13 00:29:39 INFO - mozscreenshot == 0.1 00:29:39 INFO - mozsystemmonitor == 0.3 00:29:39 INFO - moztest == 0.7 00:29:39 INFO - mozversion == 1.4 00:29:39 INFO - psutil == 3.1.1 00:29:39 INFO - requests == 1.2.3 00:29:39 INFO - wsgiref == 0.1.2 00:29:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:39 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 0x10609e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac34721a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb3d30>, '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 0x105d1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eabb20>, '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.SlZBYVFMMG/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.C77yp6vnDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 00:29:39 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 00:29:39 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 00:29:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SlZBYVFMMG/Render', 00:29:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:29:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:29:39 INFO - 'HOME': '/Users/cltbld', 00:29:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:29:39 INFO - 'LOGNAME': 'cltbld', 00:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:39 INFO - 'MOZ_NO_REMOTE': '1', 00:29:39 INFO - 'NO_EM_RESTART': '1', 00:29:39 INFO - 'PAGER': '/bin/cat', 00:29:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:39 INFO - 'PWD': '/builds/slave/test', 00:29:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:29:39 INFO - 'SHELL': '/bin/bash', 00:29:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C77yp6vnDY/Listeners', 00:29:39 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 00:29:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:29:39 INFO - 'USER': 'cltbld', 00:29:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:29:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:39 INFO - 'XPC_FLAGS': '0x0', 00:29:39 INFO - 'XPC_SERVICE_NAME': '0', 00:29:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:40 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)) 00:29:40 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)) 00:29:40 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)) 00:29:40 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)) 00:29:40 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)) 00:29:40 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)) 00:29:40 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)) 00:29:40 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)) 00:29:40 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)) 00:29:40 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)) 00:29:40 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)) 00:29:40 INFO - Cleaning up... 00:29:40 INFO - Return code: 0 00:29:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:29:40 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')]} 00:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:40 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')]} 00:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:29:40 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 0x10609e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106014570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac34721a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb3d30>, '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 0x105d1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eabb20>, '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.SlZBYVFMMG/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.C77yp6vnDY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 00:29:40 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 00:29:40 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 00:29:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SlZBYVFMMG/Render', 00:29:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:29:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:29:40 INFO - 'HOME': '/Users/cltbld', 00:29:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:29:40 INFO - 'LOGNAME': 'cltbld', 00:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:40 INFO - 'MOZ_NO_REMOTE': '1', 00:29:40 INFO - 'NO_EM_RESTART': '1', 00:29:40 INFO - 'PAGER': '/bin/cat', 00:29:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:40 INFO - 'PWD': '/builds/slave/test', 00:29:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:29:40 INFO - 'SHELL': '/bin/bash', 00:29:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C77yp6vnDY/Listeners', 00:29:40 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 00:29:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:29:40 INFO - 'USER': 'cltbld', 00:29:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:29:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:40 INFO - 'XPC_FLAGS': '0x0', 00:29:40 INFO - 'XPC_SERVICE_NAME': '0', 00:29:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:29:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:29:40 INFO - Cleaning up... 00:29:40 INFO - Return code: 0 00:29:40 INFO - Running post-action listener: _resource_record_post_action 00:29:40 INFO - Running post-action listener: _start_resource_monitoring 00:29:40 INFO - Starting resource monitoring. 00:29:40 INFO - [mozharness: 2016-12-03 08:29:40.448887Z] Finished create-virtualenv step (success) 00:29:40 INFO - [mozharness: 2016-12-03 08:29:40.449904Z] Running install step. 00:29:40 INFO - Running pre-action listener: _resource_record_pre_action 00:29:40 INFO - Running main action method: install 00:29:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:29:40 INFO - Reading from file tmpfile_stdout 00:29:40 INFO - Detecting whether we're running mozinstall >=1.0... 00:29:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:29:40 INFO - Reading from file tmpfile_stdout 00:29:40 INFO - Output received: 00:29:40 INFO - Usage: mozinstall [options] installer 00:29:40 INFO - Options: 00:29:40 INFO - -h, --help show this help message and exit 00:29:40 INFO - -d DEST, --destination=DEST 00:29:40 INFO - Directory to install application into. [default: 00:29:40 INFO - "/builds/slave/test"] 00:29:40 INFO - --app=APP Application being installed. [default: firefox] 00:29:40 INFO - mkdir: /builds/slave/test/build/application 00:29:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 00:30:14 INFO - Reading from file tmpfile_stdout 00:30:14 INFO - Output received: 00:30:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:30:14 INFO - Running post-action listener: _resource_record_post_action 00:30:14 INFO - [mozharness: 2016-12-03 08:30:14.164634Z] Finished install step (success) 00:30:14 INFO - [mozharness: 2016-12-03 08:30:14.164772Z] Running run-tests step. 00:30:14 INFO - Running pre-action listener: _resource_record_pre_action 00:30:14 INFO - Running main action method: run_tests 00:30:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:30:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:30:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:30:14 INFO - 2016-12-03 00:30:14.179 screenresolution[1635:8759] starting screenresolution argv=screenresolution get 00:30:14 INFO - 2016-12-03 00:30:14.181 screenresolution[1635:8759] Display 0: 1600x1200x32@60 00:30:14 INFO - 2016-12-03 00:30:14.186 screenresolution[1636:8761] starting screenresolution argv=screenresolution list 00:30:14 INFO - Available Modes on Display 0 00:30:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:30:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:30:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:30:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:30:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:30:14 INFO - Intel Iris: 00:30:14 INFO - Chipset Model: Intel Iris 00:30:14 INFO - Type: GPU 00:30:14 INFO - Bus: Built-In 00:30:14 INFO - VRAM (Dynamic, Max): 1536 MB 00:30:14 INFO - Vendor: Intel (0x8086) 00:30:14 INFO - Device ID: 0x0a2e 00:30:14 INFO - Revision ID: 0x0009 00:30:14 INFO - Displays: 00:30:14 INFO - Display: 00:30:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:30:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:30:14 INFO - Display Serial Number: 1600x1200 60 00:30:14 INFO - Main Display: Yes 00:30:14 INFO - Mirror: Off 00:30:14 INFO - Online: Yes 00:30:14 INFO - Rotation: Supported 00:30:14 INFO - Return code: 0 00:30:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:30:14 INFO - Python 2.7.3 00:30:14 INFO - Return code: 0 00:30:14 INFO - grabbing minidump binary from tooltool 00:30:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:14 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb3d30>, '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 0x105d1adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eabb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:30:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:30:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 00:30:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:30:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:30:14 INFO - Return code: 0 00:30:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:30:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:30:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:30:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:30:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:30:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0246', '--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 00:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0246 --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 00:30:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SlZBYVFMMG/Render', 00:30:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:30:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:30:14 INFO - 'HOME': '/Users/cltbld', 00:30:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:30:14 INFO - 'LOGNAME': 'cltbld', 00:30:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:30:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:14 INFO - 'MOZ_NO_REMOTE': '1', 00:30:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:30:14 INFO - 'NO_EM_RESTART': '1', 00:30:14 INFO - 'PAGER': '/bin/cat', 00:30:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:14 INFO - 'PWD': '/builds/slave/test', 00:30:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:30:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:30:14 INFO - 'SHELL': '/bin/bash', 00:30:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C77yp6vnDY/Listeners', 00:30:14 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 00:30:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:30:14 INFO - 'USER': 'cltbld', 00:30:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:30:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:14 INFO - 'XPC_FLAGS': '0x0', 00:30:14 INFO - 'XPC_SERVICE_NAME': '0', 00:30:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:30:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0246', '--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 00:30:14 INFO - mozversion application_buildid: 20161202221844 00:30:14 INFO - mozversion application_changeset: 557548714db55136b51e1129d649e2599797985f 00:30:14 INFO - mozversion application_display_name: Nightly 00:30:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:30:14 INFO - mozversion application_name: Firefox 00:30:14 INFO - mozversion application_remotingname: firefox 00:30:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:30:14 INFO - mozversion application_vendor: Mozilla 00:30:14 INFO - mozversion application_version: 53.0a1 00:30:14 INFO - mozversion platform_buildid: 20161202221844 00:30:14 INFO - mozversion platform_changeset: 557548714db55136b51e1129d649e2599797985f 00:30:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:30:14 INFO - mozversion platform_version: 53.0a1 00:30:14 INFO - using testdate: 1480753814 00:30:14 INFO - actual date: 1480753814 00:30:14 INFO - starting webserver on 'localhost:49243' 00:30:14 INFO - SUITE-START | Running 2 tests 00:30:14 INFO - TEST-START | dromaeo_css 00:30:14 INFO - operating with platform_type : mac_ 00:30:14 INFO - Initialising browser for dromaeo_css test... 00:30:14 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpusAFJt/profile http://localhost:49243/getInfo.html) 00:30:18 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 00:30:18 INFO - PROCESS | 1646 | colorDepth:24 00:30:18 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 00:30:18 INFO - PROCESS | 1646 | __metrics 00:30:18 INFO - PROCESS | 1646 | 2016-12-03 00:30:18.224 plugin-container[1649:8941] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 00:30:18 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:30:18 INFO - PROCESS | 1646 | 2016-12-03 00:30:18.227 plugin-container[1649:8941] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 00:30:18 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:30:18 INFO - PROCESS | 1646 | 2016-12-03 00:30:18.227 plugin-container[1649:8941] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:30:18 ERROR - PROCESS | 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 00:30:19 INFO - TEST-INFO | 1646: exit 0 00:30:19 INFO - Browser initialized. 00:30:19 INFO - Running cycle 1/1 for dromaeo_css test... 00:30:19 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpusAFJt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:30:21 INFO - PROCESS | 1650 | 2016-12-03 00:30:21.653 plugin-container[1651:9062] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8733, name = 'com.apple.tsm.portname' 00:30:21 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:30:21 INFO - PROCESS | 1650 | 2016-12-03 00:30:21.653 plugin-container[1651:9062] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 00:30:21 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:30:21 INFO - PROCESS | 1650 | 2016-12-03 00:30:21.653 plugin-container[1651:9062] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:30:31 INFO - PROCESS | 1650 | RSS: Main: 241709056 00:30:31 INFO - PROCESS | 1650 | 00:31:20 INFO - PROCESS | 1650 | 1480753880958 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] 00:33:33 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 00:33:36 INFO - PROCESS | 1650 | RSS: Main: 249831424 00:33:36 INFO - PROCESS | 1650 | 00:36:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 00:36:39 INFO - PROCESS | 1650 | RSS: Main: 261734400 00:36:39 INFO - PROCESS | 1650 | 00:39:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 00:39:41 INFO - PROCESS | 1650 | RSS: Main: 270839808 00:39:41 INFO - PROCESS | 1650 | 00:42:43 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 00:42:44 INFO - PROCESS | 1650 | RSS: Main: 269451264 00:42:44 INFO - PROCESS | 1650 | 00:45:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 00:45:47 INFO - PROCESS | 1650 | RSS: Main: 274051072 00:45:47 INFO - PROCESS | 1650 | 00:48:50 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 00:48:50 INFO - PROCESS | 1650 | RSS: Main: 276660224 00:48:50 INFO - PROCESS | 1650 | 00:48:50 INFO - PROCESS | 1650 | __start_tp_report 00:48:50 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 00:48:50 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 00:48:50 INFO - PROCESS | 1650 | |i|pagename|runs| 00:48:50 INFO - PROCESS | 1650 | |0;dojo.html;3340.5991281046277;3382.238996225848;3394.949075763864;3413.7951722896614;3443.603985541662;4393.494748103969;5673.43265673433;5681.488666020057;5720.399358067405;5757.625754325966;5586.441355864412;5665.660060396379;5668.064769313059;5698.230738850254;5706.714664266791;4622.838200662977;5096.898062038757;5133.897322053556;5190.532852043315;5225.007248622768;3729.6643302102807;3955.564887862333;4766.237402015661;4953.687272872691;5295.232191332274;4275.2945763949065;5304.098303288451;5308.787648494055;5313.043652142613;5316.548093412064;4070.0435397681667;5105.463926287724;5220.660657057317;5280.577553795706;5298.602604804655;3789.8673546425744;5084.034033533617;5133.178691409356;5181.326427564431;5223.451537588575;5510.8071217507195;5675.318961724578;5685.232493613392;5687.0900655895275;5714.228579141804;6136.447719705248;6167.105769663373;6282.685865706742;6310.116583678288;6318.4629306509005;6199.411055949678;6203.31763506014;6212;6254.593451425642;6322.083297921776;5832.533397328203;5832.533397328203;5836.766529338822;5861.413858614104;5862.003459411911;6305.117283580303;6311.211098612674;6320;6331.5251356147555;6335.936640633627;5985.850353741192;5995.370486098984;6052.969735151384;6094.8171554853425;6128.80869161996;6187.535934804908;6256.906146407808;6282.057691346335;6287.276963149205;6306.936930630727;6196.47329976948;6230.376962303824;6236.126942228092;6256.812295631138;6262.843428914313;6116.914073580098;6129.693515324216;6169.722362493699;6268;6291.591046581958;4900.26496025599;4921.630877684116;4949.628777841676;4978.5270399312;5006.199008158677;4338.154059958341;4364.5635436456105;4366.694331396771;4369.71596846204;4409.4267745193565;5562.805301814417;5785.363610002981;5820.708964551755;5841.240638717025;5884.9705751470965;5319.281896943863;6272.6236425814595;6276.6547839868335;6349.714262858182;6355;4743.31221972812;5045.722485263345;5756.280464941882;5831.737571809279;5931.6441013539325;4431.113777244564;4581.0072618411095;5442.782288708408;5452.182172674051;5461.2354270402175;6220.315765265726;6244.219472565929;6290.748370065329;6405.51958603116;6416.022066318912;6147.631142131487;6193.628382297076;6229.719662615284;6232.968835155795;6268.341824108403;5256.78972841082;6318;6357.841053973502;6373.8725225496155;6400;6072.271327440735;6141.969290153521;6212.627242365473;6221.47117495018;6237.75048998035;5288.524032837063;6177.382261773787;6210.472109870531;6226.968865155826;6250.9062364065485;6089.5432842537875;6112.938870611237;6126.392418651802;6158.04550294705;6176.505879529716;4784.856454306377;5286.5990512513445;5823.068309070529;6136.8772624548155;6206.379362063757;5431.972840135774;5673.659580425187;5891.3224979127945;5909.940900590939;6083.239595050619;6070.878582428415;6075.149479072845;6120.816375508742;6133.3866613338305;6133.977404287646;5848.473637372657;5909.85225369352;5962.70186490665;5973.581849270509;6022.247219097613 00:48:50 INFO - PROCESS | 1650 | |1;ext.html;453.24308404963705;520.2118790033101;526.8682829292677;545.9344878614564;559.2170960655083;28382.432351352985;39321;39473.80263098688;39514.60485395145;39639.801800990994;39435.0141246469;39953.80023099888;39961.800190999005;39983.60016399835;40066.399004014966;8358.247757701805;8553.529555874424;9139.725808225747;9400;11022.393768342738;11022.669319920375;11361.147913906449;11361.318320900773;11370.829437558443;11416;11299.604513842018;11305.095592352593;11323.810999845022;11344.659660210207;11360.659180224606;11264.774704505864;11322.490487928064;11322.716932076764;11349.829752553718;11386.943065284704;11162.776744465147;11167.329960202333;11238;11244;11246.100311975022;36846.81576592127;37218.25563488715;37341.253174936624;37449.87650370466;37482.62517374819;3267.18320419895;3272.5034254055868;3356.681115294043;3473.5831700195886;3542.982285088584;29702;29921.850390748124;30495.237619059702;30586.69413305861;30820.22949426282;3132.451820931328;3239.5464634951127;3263.9184020399443;3281.8523166457567;3316.519104729825;435970;452501.7374913137;481670.591647043;485552;486868;55922.44077559172;56482.43517564772;57009.14486282709;57138.714306429036;57243.42756572381;61162.08256876151;61492.462688433145;61524;61647;61810.69094654498;14972.176530290939;15482.690346193238;15494.922525387527;15512.844871551366;15518.534443966699;10688.305260158066;11060.949209825054;11795.35125568102;12039.819402708967;12105.394730263451;12685.492580296685;13563;13960.930195348958;16927.714758507445;16929.153542322834;5722.96986542418;5728.627639203439;6144.539159563051;6222.315545290015;6246.718897649616;842.3471809347682;930.4045410937006;934.9392289501296;954.556131398889;1012.4785735346303;28666;28830.135095947157;29155.416891662473;29566.408671826444;29664.406711865642;894.5482531321641;930.930180236485;974.4640447753707;992.8113658405024;1020.611967723895;13118.475260989453;14820.40718371253;14956.476523321631;14996.250187490581;15128.319225634872;535963;631739;640204;646333;646797;55408.72295638496;55844;55848.16227756587;55849;55991.440085598624;1287.2469605280828;1325.7414804113298;1327.5154568582398;1342.3959218351586;1344.4420565465223;27899.44201116007;28096.157115286573;28644.856775715987;29200.561991569717;29614.407711846074;44997.65007049794;51260.487395127064;53538;53575.46424535705;56452.15321770094;555189;557207;558570;559557;562527;22830.42923926915;23178;23653.408664783517;25241.96128619412;25630.871845640653;44877;45095.77452112718;45173.77413112913;45417.31874021826;45845.85385365259;37326.813365933;37540.24919501649;37595.706761452624;37898;38606.2278754429;34709.47935780915;37250.06874828151;37575;37865.053373665876;38248.04379890525;27524;27909.44181116407;32681.836590816893;34760.478592820626;37132;25885.741142588333;26886.59670104989;29998.70001299959;30869.610867510568;33945.830270848484;22872.885635571714;24698;25265.873670632263;25406.364840879127;25481.87259063693 00:48:50 INFO - PROCESS | 1650 | |2;jquery.html;347.15294680978417;367.08595596963534;372.0865275748039;378.15671053550597;392.4819238605041;18866.622667546642;19053;19309.517262068457;19920.60158796825;20139.093740781664;16428.75356869648;19795.50511237216;19963.800361996375;20025.299114530993;20062.197512099498;5272.446393128705;5701.372848986619;5995.160677505153;6000.3699611540815;6011.428914253139;3149.291409432882;3984.1633257015915;5819.418058194168;7204.351608355247;7577.16651168371;7367.373773229282;7528.284812942762;7535.1711311755935;7622.161562228151;7633.65648545814;7507.474476786627;7618.580978046205;7634.198409167013;7643.961780191091;7649.961750191269;7022.367986881205;7298.635068246619;7342.48602597813;7350.926490735078;7367.410607151415;25710.357241068938;26637.334066648295;26801.92792288306;27205.455890882073;28131.578026329622;2383.1063351243283;2433.0267892842826;2575.575030120028;2816.901408450715;3209.406259841913;15642.296096675676;17251.654966900718;17272.136393180415;17289.394871179447;17704.114794260237;1964.2437661500283;2033.4408037789726;2036.1142902837164;2094.130935661714;2109.715188449555;96653;107793.46103269512;110929.78140437226;119987;121405.99999999911;20654.690179647318;21085.894570527355;21155;21223;21299.574008519743;33535.329293414;34014.10880075172;34059.14852128716;34116.82941585326;34149.80475683339;8797.428167169242;10435.16518678504;10474.581016759397;10578.418186999788;10731.946340268249;8580.570971451403;8585;8600.913990860012;8676.392652514263;8741.213290803858;7613.695452181962;7791.64937577799;8099.919000809917;8521.190486903733;9441.480718560408;1536.285627183365;1543.4057887713311;1577.9526614201363;1588.5393235961674;3243.935121297608;722.339059760324;825.1336097098023;838.9370797190113;877.925376343018;884.5975081337975;20097.884827851707;20218.696719549218;20582.176712931614;20756.273530426362;20956.47608809792;870.2124577257465;898.0839543665425;900.4057322167469;910.1433076523949;984.3109823123842;10422.530986105643;10830.566777328977;10906.672799816019;10932.56269749201;10941.398223097647;563042;580738;580939.190608097;587981;597149;126080;127952.80117997124;128020.35989820177;129018;129156.35421822831;928.3084102343662;939.4691999020531;963.3449254506862;967.3905439572883;969.8060387922303;17725.379611713528;18222.544436388667;18310.725339119657;18391;18464.907675461538;50720.492795073056;52213.21680174724;52595.474045259056;52761;52770;75669.62165189139;76081.61959190169;76083.95664173593;76472.23527764874;78276.60861695655;5862.589618726648;6666.666666666783;6820.249772525118;6917.896231556631;7134.60759658203;7149.85700285981;8164.632591533514;9189.586468609063;9777.022297770167;12307.138500304893;7680.807979800326;8923.598438070432;10572.735681608021;10857.402842843403;10951.123910087334;10318.535665895202;10360.585576576852;10437.791244175225;10482.947585262025;11027.221035202423;5854.736536855767;10236.129928956123;10476.738081548023;10819.945900270448;11213.327200368005;7137.429005679637;7177.318154775288;7209.531380460253;7284.307990740871;7308.5614863108385;8023.959880200561;10641.627543035956;10919.235653504178;10980.011798938134;11066.170037247077 00:48:50 INFO - PROCESS | 1650 | |3;mootools.html;1374.1205628397827;1476.542271895712;1630.2826756227266;1767.2400867626916;1784.081198182936;7519.097708275001;7774.300312971832;7997.200279972;8398.790030249247;8404.45371050882;7904.249096335853;8207.671693132268;8228.547429891354;8278.337732981363;8295.377846661495;2286.616596958837;2310.560993411255;2317.188983855654;2318.814494840417;2324.1284518305633;2300.654901764732;2331.3821837213154;2334.7898689117974;2335.1710142899283;2347.1432926981615;2266.331432227497;2283.041122728458;2288.233441796992;2288.7139107611547;2294.254367330616;1992.7110568967564;2270.886455677218;2286.428392901783;2289.107248173197;2295.472041430464;1896.2415033986379;1990.4227773945538;2301.631738921781;2313.664518644804;2314.6875171851752;6969.16370035599;8237.752867413987;8310.70912518065;8356.080831108573;8358.498490090553;4878.268259761065;5025.472325405853;5045.823396181116;5068.087744206042;5073.112205364084;3208.4545627243424;3238.4980328048955;3527.3474407234744;3535.9469607955903;3545.2377738786026;1035.404642330663;1060.1836585828946;1073.6939972107912;1089.536946797608;1097.3744965369742;8808.559572021373;9006;10698.625548105856;10784.5686172553;10877.510512026978;4440.444944381952;4574.336721175411;4676.976615116902;4697.624190064855;4704.3649107370065;9317.860232096524;9414.388064775905;9424.293178011676;9426.340156189;9445.244380449547;5094.363204599425;5166.354205724285;5180.119379705459;5185.248139019821;5187.740612969336;4251.659867210616;4260.595243451867;4728.976355118202;4744.122337367598;4768;3707.7589956652732;3759.323321802102;3805.010697218743;3840.6543411093135;3852.9036774080873;1256.2776403567984;1256.2901960392348;1270.7610080171758;1270.866559011309;1273.0642977411594;881.8941726992674;885.9822803543893;901.9729408117636;908.2416182487697;911.8313112074287;5108.591312694975;5590.91613625796;5761.3950535194035;5761.625494342854;5834.183214349994;430.1311351070882;430.8922769307673;433.6032530234863;434.5502405010862;438.1412431634033;3427.4344733119256;3429.9657003430148;3512.473129030615;3519.788812671248;3572;9717.17404020652;10022.899771002343;10077.395356278646;10085.394876307446;10121.443320617289;9871.901280987242;9968.750781230527;10004.19966402686;10013.549390277454;10047.849282260771;7523.623818809037;7643.159252482223;7755.7673269802;7831.25603067719;7833.843323133619;5483.616146869681;5607.383187849252;5616.522595579421;5632.436756324499;5743.483086522233;9246.95376523113;9315.627374904929;9315.906840931504;9341.019192984639;9362.672306469241;8987.910120898969;9367.906320936703;9455.669051583161;9455.810883782424;9461.432314061178;6549.410553050248;6747.595144291358;6899.517033807585;7004.509684322048;7066.505344625827;7753.418493613114;7847.686092556234;7919.604019798871;7932.960335198287;7949.3243074337015;6906.274841141608;7050.400715939202;7060.470464715269;7133.500654954311;7156;6885.552439091443;6911.93088069133;6933.064036355027;6939;6995.230524642387;6414.198225221848;6609.867802644017;6624.436922861418;6721.462283017249;6726.6636668167375;4863.513648635108;4920.335754673073;4924.384451943507;4937;4987.476314986874;4675.555822196886;4696.459907110726;4726.125666751662;4822.348982887405;4828.493008234085 00:48:50 INFO - PROCESS | 1650 | |4;prototype.html;268.8747591330283;297.52544691217514;299.637438699174;304.7957868228287;307.3300205551896;5179.430262671112;5230.686158830473;5370.516653501184;5403.6757794532305;5435.592330575208;4295;4340;4473.463184417867;5065.1642478990925;5329.922609203962;3056.663766985641;3645.161612829051;3727.4781530585738;4122.4746843667735;4128.834846606147;3980.3432433648413;4098.303288440972;4123.7938103094875;4135.7518548887165;4138.358554424069;4062.2281766464275;4068.125353049094;4076.714629975903;4084.57040035988;4104.753714777108;3244.8967351100623;3763.190913953486;4060.20825938942;4106.507219133693;4127.463429754142;3237.41007194246;3576.6572894753976;3579.427291633326;3580.3813081125577;3598;4655.953440465586;4811.278308253755;5009.603232258886;5072.70645985275;5230.843074707765;3336.5643080551336;4175.54069052404;4618.468876079227;4711.575958163782;4738.502457242009;5098.694078355311;5474.863128421782;5479.945200547983;5665.291838520185;5671.886562268732;3236.3850868335176;3763.73653844231;3929.31237033518;3932.6067393260732;3940.6256405641707;4963.578095861856;5400.91898621521;5845.094010428348;5924.726183870489;5973.551983601204;3327.683870032343;3335.6831101045364;4012.61880121388;4027.35562310029;4050.696197785178;3360.0087974047715;4042.333015052542;4054.2499637567144;4080.9799149420633;4091.488563929509;4076.3681629347498;4399.62603178727;4614.423197100363;4629;4661.696989695659;4354.542773008789;5668.319801623749;5706.3722990471015;5725.141228815628;5743.483086522233;1115.341948250536;1183.7869183546873;1254.7051442910908;1314.8553659097493;1324.8145259663654;720.476192852114;807.4105902691068;904.3985749476656;915.3866909170738;918.8346097702344;5013.849584512471;5028.547430731252;5049.798008079636;5096.668716533488;5104.336436263262;4770.522947705202;4808.563520866625;5424.718045582365;5572.024895643327;5573.972130139324;4280.400743895857;4665.276882083214;4915.4347250065985;5047.268146118792;5049.798008079636;2614.2288025032663;2654.1241390341143;2669.1992402279625;2793.916182514487;2799.2721892308145;5055.575652759949;5186.6369354144845;5547.583931205176;5717.256756621696;5732.710140218501;5015.3730783652045;5258.421573626898;5407.621466497386;5645.887082258332;5710.743636400069;4520.819167233274;5460.2355670207;5479.369872464637;5725.963195946848;5740.282464691913;4703.623710103115;4743.549362810665;5352.304200453916;5483.835484935458;5513.448655134454;4596.655250856133;4663.836765713319;5413.512783849473;5449.23710680513;5453.863653408696;5231.607629427732;5702.6293290935955;5718.599698021098;5725.513331366714;5774.642958904738;3598.766080204883;3818.6252948937804;3868.8334532661797;3892.377219644843;3940.862069827542;4963.677360971526;5605.579581531483;5810.738516766671;5831.308920413033;5857;4573.5426457354;4772.735225165404;4895.46149923501;5683.119116536944;5698.202251684685;5344.3545445004975;5602.9914615368;5639.689817060101;5642.576806739429;5712.742926568398;4525.303011370736;5373.5432488237375;5539.362973257966;5554.305711786027;5580.939621471907;5099.311592935054;5246.029484545371;5654.830355089354;5699.287589051369;5716.685162412751;5571.303587051619;5574.303212098488;5596.3284405871555;5614.747336369792;5632.633878797865 00:48:50 INFO - PROCESS | 1650 | |5;yui.html;676.8781619308522;684.6987325576746;711.7864640607817;747.7943565519481;796.6176235407005;14684.41262349506;15089.320980555874;15342.30959606819;15474.613134671625;15539.92230038851;14086.436542538286;14285.428582856674;14290.928180386487;14307.78538321926;14319.212443315613;817.3665409307789;828.9129641387658;829.1998221716043;830.1864173110356;833.1377024779355;643.2827397451831;663.7013343995197;798;815.2092470303796;830.3025458614762;874.5583480342418;875.4003507597284;875.7110153649312;878.7056336127405;880.1154839386408;857.3612658569343;873.5588527793456;874.637025634361;874.6763697431959;877.0615441477589;649.9155109835691;651.1665068712056;651.5894986158737;652.3802387731627;652.6345246661884;14112.50606228777;14564.635884102876;14590.124592524482;14661.926690366587;14941.02883312592;10570.894291057068;14080.507182248675;14386.064905781092;14611.342489587994;14720.558383248519;9799.461029643368;12302.62993892559;13049.478020879249;13077.149985250928;13153.671158221121;4437.2234858899565;4470.418845550058;4490.663200259994;4495.43807024122;4689.62483001359;89888;96325;116164;117263;120027.39986300013;10544.736381590521;10570.322170137182;10601.204909631808;10695.197860160519;10956.616518421817;15417;17360.479185624452;20181.697274540893;20231.797682023287;20277.797222027886;7793.688252469838;7849;7850.528968261922;7858.253465920729;8089.433739638286;4262.168877068942;4318.222719910446;4344.326629372453;4400.581944715247;4414.911701766011;3474.774139680913;3548.6806187443253;3571.7321200910037;3578.6421357864006;3622.710183185339;572.4733245414229;652.9031227537782;658.0392626764976;663.890458074422;666.3170250493283;555.8526990347561;586.9119632055141;647.0843756085087;652.5334385913999;677.3869647968596;8662.566871656392;9003.324750643727;9210.25026225089;9312.115349041831;9717.720519985842;624.2820756130486;629.3832044596321;632.1560716443507;676.1210426445699;693.6531734132933;4399.076193999296;4648.302754586772;4651.813927442932;4689.171223222946;4691.7654117294;111387.21531961604;113553;118347.40826295986;118848.40575797239;120611.39694301473;38534.61465385366;38580.807095964905;90833.09166908379;93469.13061738727;93705.5314723422;60694.69652651797;76348.23651763522;78264.60867695739;82236.58881705553;82701.58649206716;9716.659916902874;9788.412695238309;9870.950645246729;10006.599736010769;10096.394216347042;47211;54084.459155407945;55366.44633553774;56303.43696562982;56754;58874.35065422152;67806.54128045813;69661.65169174122;74693.87959180726;76326.85509717248;12853.651752364123;12911.677208069874;13058.34708264602;13070.215787052808;13385.129966552144;12163.939180304042;14924.552263432115;15096.849031509544;15239;15285.770713439086;11518.424078795859;13310.800337994744;13578.710022547843;13656.385462654403;14480.058796178215;11602.709932251424;13239.073264871367;13747.587572372844;13845;14186.929065354607;12954.85309339914;13369.26469044173;14085.507007254697;14121.858781412055;14172.220527871066;9159.587818548314;11230;11382.317060976036;11423.428828558704;11754.412279386168;8224.3831712623;9117.589708463267;9151.367134067297;10115.089641932262;10321.535530901278 00:48:50 INFO - PROCESS | 1650 | __end_tp_report 00:48:50 INFO - PROCESS | 1650 | __start_cc_report 00:48:50 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,371 00:48:50 INFO - PROCESS | 1650 | __end_cc_report 00:48:50 INFO - PROCESS | 1650 | __startTimestamp1480754930897__endTimestamp 00:48:50 INFO - PROCESS | 1650 | 00:48:50 INFO - PROCESS | 1650 | ------- Summary: start ------- 00:48:50 INFO - PROCESS | 1650 | Number of tests: 6 00:48:50 INFO - PROCESS | 1650 | 00:48:50 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5648.09 Median:5884.97 stddev:736.93 (12.5%) stddev-sans-first:716.61 00:48:50 INFO - PROCESS | 1650 | Values: 3340.6 3382.2 3394.9 3413.8 3443.6 4393.5 5673.4 5681.5 5720.4 5757.6 5586.4 5665.7 5668.1 5698.2 5706.7 4622.8 5096.9 5133.9 5190.5 5225.0 3729.7 3955.6 4766.2 4953.7 5295.2 4275.3 5304.1 5308.8 5313.0 5316.5 4070.0 5105.5 5220.7 5280.6 5298.6 3789.9 5084.0 5133.2 5181.3 5223.5 5510.8 5675.3 5685.2 5687.1 5714.2 6136.4 6167.1 6282.7 6310.1 6318.5 6199.4 6203.3 6212.0 6254.6 6322.1 5832.5 5832.5 5836.8 5861.4 5862.0 6305.1 6311.2 6320.0 6331.5 6335.9 5985.9 5995.4 6053.0 6094.8 6128.8 6187.5 6256.9 6282.1 6287.3 6306.9 6196.5 6230.4 6236.1 6256.8 6262.8 6116.9 6129.7 6169.7 6268.0 6291.6 4900.3 4921.6 4949.6 4978.5 5006.2 4338.2 4364.6 4366.7 4369.7 4409.4 5562.8 5785.4 5820.7 5841.2 5885.0 5319.3 6272.6 6276.7 6349.7 6355.0 4743.3 5045.7 5756.3 5831.7 5931.6 4431.1 4581.0 5442.8 5452.2 5461.2 6220.3 6244.2 6290.7 6405.5 6416.0 6147.6 6193.6 6229.7 6233.0 6268.3 5256.8 6318.0 6357.8 6373.9 6400.0 6072.3 6142.0 6212.6 6221.5 6237.8 5288.5 6177.4 6210.5 6227.0 6250.9 6089.5 6112.9 6126.4 6158.0 6176.5 4784.9 5286.6 5823.1 6136.9 6206.4 5432.0 5673.7 5891.3 5909.9 6083.2 6070.9 6075.1 6120.8 6133.4 6134.0 5848.5 5909.9 5962.7 5973.6 6022.2 00:48:50 INFO - PROCESS | 1650 | 00:48:50 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:67603.86 Median:19091.53 stddev:147905.77 (774.7%) stddev-sans-first:148234.75 00:48:50 INFO - PROCESS | 1650 | Values: 453.2 520.2 526.9 545.9 559.2 28382.4 39321.0 39473.8 39514.6 39639.8 39435.0 39953.8 39961.8 39983.6 40066.4 8358.2 8553.5 9139.7 9400.0 11022.4 11022.7 11361.1 11361.3 11370.8 11416.0 11299.6 11305.1 11323.8 11344.7 11360.7 11264.8 11322.5 11322.7 11349.8 11386.9 11162.8 11167.3 11238.0 11244.0 11246.1 36846.8 37218.3 37341.3 37449.9 37482.6 3267.2 3272.5 3356.7 3473.6 3543.0 29702.0 29921.9 30495.2 30586.7 30820.2 3132.5 3239.5 3263.9 3281.9 3316.5 435970.0 452501.7 481670.6 485552.0 486868.0 55922.4 56482.4 57009.1 57138.7 57243.4 61162.1 61492.5 61524.0 61647.0 61810.7 14972.2 15482.7 15494.9 15512.8 15518.5 10688.3 11060.9 11795.4 12039.8 12105.4 12685.5 13563.0 13960.9 16927.7 16929.2 5723.0 5728.6 6144.5 6222.3 6246.7 842.3 930.4 934.9 954.6 1012.5 28666.0 28830.1 29155.4 29566.4 29664.4 894.5 930.9 974.5 992.8 1020.6 13118.5 14820.4 14956.5 14996.3 15128.3 535963.0 631739.0 640204.0 646333.0 646797.0 55408.7 55844.0 55848.2 55849.0 55991.4 1287.2 1325.7 1327.5 1342.4 1344.4 27899.4 28096.2 28644.9 29200.6 29614.4 44997.7 51260.5 53538.0 53575.5 56452.2 555189.0 557207.0 558570.0 559557.0 562527.0 22830.4 23178.0 23653.4 25242.0 25630.9 44877.0 45095.8 45173.8 45417.3 45845.9 37326.8 37540.2 37595.7 37898.0 38606.2 34709.5 37250.1 37575.0 37865.1 38248.0 27524.0 27909.4 32681.8 34760.5 37132.0 25885.7 26886.6 29998.7 30869.6 33945.8 22872.9 24698.0 25265.9 25406.4 25481.9 00:48:50 INFO - PROCESS | 1650 | 00:48:50 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:35320.54 Median:17248.48 stddev:96979.75 (562.3%) stddev-sans-first:97216.25 00:48:50 INFO - PROCESS | 1650 | Values: 347.2 367.1 372.1 378.2 392.5 18866.6 19053.0 19309.5 19920.6 20139.1 16428.8 19795.5 19963.8 20025.3 20062.2 5272.4 5701.4 5995.2 6000.4 6011.4 3149.3 3984.2 5819.4 7204.4 7577.2 7367.4 7528.3 7535.2 7622.2 7633.7 7507.5 7618.6 7634.2 7644.0 7650.0 7022.4 7298.6 7342.5 7350.9 7367.4 25710.4 26637.3 26801.9 27205.5 28131.6 2383.1 2433.0 2575.6 2816.9 3209.4 15642.3 17251.7 17272.1 17289.4 17704.1 1964.2 2033.4 2036.1 2094.1 2109.7 96653.0 107793.5 110929.8 119987.0 121406.0 20654.7 21085.9 21155.0 21223.0 21299.6 33535.3 34014.1 34059.1 34116.8 34149.8 8797.4 10435.2 10474.6 10578.4 10731.9 8580.6 8585.0 8600.9 8676.4 8741.2 7613.7 7791.6 8099.9 8521.2 9441.5 1536.3 1543.4 1578.0 1588.5 3243.9 722.3 825.1 838.9 877.9 884.6 20097.9 20218.7 20582.2 20756.3 20956.5 870.2 898.1 900.4 910.1 984.3 10422.5 10830.6 10906.7 10932.6 10941.4 563042.0 580738.0 580939.2 587981.0 597149.0 126080.0 127952.8 128020.4 129018.0 129156.4 928.3 939.5 963.3 967.4 969.8 17725.4 18222.5 18310.7 18391.0 18464.9 50720.5 52213.2 52595.5 52761.0 52770.0 75669.6 76081.6 76084.0 76472.2 78276.6 5862.6 6666.7 6820.2 6917.9 7134.6 7149.9 8164.6 9189.6 9777.0 12307.1 7680.8 8923.6 10572.7 10857.4 10951.1 10318.5 10360.6 10437.8 10482.9 11027.2 5854.7 10236.1 10476.7 10819.9 11213.3 7137.4 7177.3 7209.5 7284.3 7308.6 8024.0 10641.6 10919.2 10980.0 11066.2 00:48:50 INFO - PROCESS | 1650 | 00:48:50 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5359.55 Median:5006.47 stddev:2947.03 (58.9%) stddev-sans-first:2940.07 00:48:50 INFO - PROCESS | 1650 | Values: 1374.1 1476.5 1630.3 1767.2 1784.1 7519.1 7774.3 7997.2 8398.8 8404.5 7904.2 8207.7 8228.5 8278.3 8295.4 2286.6 2310.6 2317.2 2318.8 2324.1 2300.7 2331.4 2334.8 2335.2 2347.1 2266.3 2283.0 2288.2 2288.7 2294.3 1992.7 2270.9 2286.4 2289.1 2295.5 1896.2 1990.4 2301.6 2313.7 2314.7 6969.2 8237.8 8310.7 8356.1 8358.5 4878.3 5025.5 5045.8 5068.1 5073.1 3208.5 3238.5 3527.3 3535.9 3545.2 1035.4 1060.2 1073.7 1089.5 1097.4 8808.6 9006.0 10698.6 10784.6 10877.5 4440.4 4574.3 4677.0 4697.6 4704.4 9317.9 9414.4 9424.3 9426.3 9445.2 5094.4 5166.4 5180.1 5185.2 5187.7 4251.7 4260.6 4729.0 4744.1 4768.0 3707.8 3759.3 3805.0 3840.7 3852.9 1256.3 1256.3 1270.8 1270.9 1273.1 881.9 886.0 902.0 908.2 911.8 5108.6 5590.9 5761.4 5761.6 5834.2 430.1 430.9 433.6 434.6 438.1 3427.4 3430.0 3512.5 3519.8 3572.0 9717.2 10022.9 10077.4 10085.4 10121.4 9871.9 9968.8 10004.2 10013.5 10047.8 7523.6 7643.2 7755.8 7831.3 7833.8 5483.6 5607.4 5616.5 5632.4 5743.5 9247.0 9315.6 9315.9 9341.0 9362.7 8987.9 9367.9 9455.7 9455.8 9461.4 6549.4 6747.6 6899.5 7004.5 7066.5 7753.4 7847.7 7919.6 7933.0 7949.3 6906.3 7050.4 7060.5 7133.5 7156.0 6885.6 6911.9 6933.1 6939.0 6995.2 6414.2 6609.9 6624.4 6721.5 6726.7 4863.5 4920.3 4924.4 4937.0 4987.5 4675.6 4696.5 4726.1 4822.3 4828.5 00:48:50 INFO - PROCESS | 1650 | 00:48:50 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4441.72 Median:4963.63 stddev:1370.60 (27.6%) stddev-sans-first:1338.18 00:48:50 INFO - PROCESS | 1650 | Values: 268.9 297.5 299.6 304.8 307.3 5179.4 5230.7 5370.5 5403.7 5435.6 4295.0 4340.0 4473.5 5065.2 5329.9 3056.7 3645.2 3727.5 4122.5 4128.8 3980.3 4098.3 4123.8 4135.8 4138.4 4062.2 4068.1 4076.7 4084.6 4104.8 3244.9 3763.2 4060.2 4106.5 4127.5 3237.4 3576.7 3579.4 3580.4 3598.0 4656.0 4811.3 5009.6 5072.7 5230.8 3336.6 4175.5 4618.5 4711.6 4738.5 5098.7 5474.9 5479.9 5665.3 5671.9 3236.4 3763.7 3929.3 3932.6 3940.6 4963.6 5400.9 5845.1 5924.7 5973.6 3327.7 3335.7 4012.6 4027.4 4050.7 3360.0 4042.3 4054.2 4081.0 4091.5 4076.4 4399.6 4614.4 4629.0 4661.7 4354.5 5668.3 5706.4 5725.1 5743.5 1115.3 1183.8 1254.7 1314.9 1324.8 720.5 807.4 904.4 915.4 918.8 5013.8 5028.5 5049.8 5096.7 5104.3 4770.5 4808.6 5424.7 5572.0 5574.0 4280.4 4665.3 4915.4 5047.3 5049.8 2614.2 2654.1 2669.2 2793.9 2799.3 5055.6 5186.6 5547.6 5717.3 5732.7 5015.4 5258.4 5407.6 5645.9 5710.7 4520.8 5460.2 5479.4 5726.0 5740.3 4703.6 4743.5 5352.3 5483.8 5513.4 4596.7 4663.8 5413.5 5449.2 5453.9 5231.6 5702.6 5718.6 5725.5 5774.6 3598.8 3818.6 3868.8 3892.4 3940.9 4963.7 5605.6 5810.7 5831.3 5857.0 4573.5 4772.7 4895.5 5683.1 5698.2 5344.4 5603.0 5639.7 5642.6 5712.7 4525.3 5373.5 5539.4 5554.3 5580.9 5099.3 5246.0 5654.8 5699.3 5716.7 5571.3 5574.3 5596.3 5614.7 5632.6 00:48:50 INFO - PROCESS | 1650 | 00:48:50 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:20370.03 Median:4493.05 stddev:30251.16 (673.3%) stddev-sans-first:30299.88 00:48:50 INFO - PROCESS | 1650 | Values: 676.9 684.7 711.8 747.8 796.6 14684.4 15089.3 15342.3 15474.6 15539.9 14086.4 14285.4 14290.9 14307.8 14319.2 817.4 828.9 829.2 830.2 833.1 643.3 663.7 798.0 815.2 830.3 874.6 875.4 875.7 878.7 880.1 857.4 873.6 874.6 874.7 877.1 649.9 651.2 651.6 652.4 652.6 14112.5 14564.6 14590.1 14661.9 14941.0 10570.9 14080.5 14386.1 14611.3 14720.6 9799.5 12302.6 13049.5 13077.1 13153.7 4437.2 4470.4 4490.7 4495.4 4689.6 89888.0 96325.0 116164.0 117263.0 120027.4 10544.7 10570.3 10601.2 10695.2 10956.6 15417.0 17360.5 20181.7 20231.8 20277.8 7793.7 7849.0 7850.5 7858.3 8089.4 4262.2 4318.2 4344.3 4400.6 4414.9 3474.8 3548.7 3571.7 3578.6 3622.7 572.5 652.9 658.0 663.9 666.3 555.9 586.9 647.1 652.5 677.4 8662.6 9003.3 9210.3 9312.1 9717.7 624.3 629.4 632.2 676.1 693.7 4399.1 4648.3 4651.8 4689.2 4691.8 111387.2 113553.0 118347.4 118848.4 120611.4 38534.6 38580.8 90833.1 93469.1 93705.5 60694.7 76348.2 78264.6 82236.6 82701.6 9716.7 9788.4 9871.0 10006.6 10096.4 47211.0 54084.5 55366.4 56303.4 56754.0 58874.4 67806.5 69661.7 74693.9 76326.9 12853.7 12911.7 13058.3 13070.2 13385.1 12163.9 14924.6 15096.8 15239.0 15285.8 11518.4 13310.8 13578.7 13656.4 14480.1 11602.7 13239.1 13747.6 13845.0 14186.9 12954.9 13369.3 14085.5 14121.9 14172.2 9159.6 11230.0 11382.3 11423.4 11754.4 8224.4 9117.6 9151.4 10115.1 10321.5 00:48:50 INFO - PROCESS | 1650 | -------- Summary: end -------- 00:48:50 INFO - PROCESS | 1650 | 00:48:51 INFO - TEST-INFO | 1650: exit 0 00:48:51 INFO - TEST-OK | dromaeo_css | took 1116764ms 00:48:51 INFO - TEST-START | kraken 00:48:51 INFO - operating with platform_type : mac_ 00:48:51 INFO - Initialising browser for kraken test... 00:48:51 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmp3ibdtN/profile http://localhost:49243/getInfo.html) 00:48:54 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 00:48:54 INFO - PROCESS | 1658 | colorDepth:24 00:48:54 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 00:48:54 INFO - PROCESS | 1658 | __metrics 00:48:54 INFO - PROCESS | 1658 | 2016-12-03 00:48:54.540 plugin-container[1659:11259] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 00:48:54 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:48:54 INFO - PROCESS | 1658 | 2016-12-03 00:48:54.545 plugin-container[1659:11259] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 00:48:54 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:48:54 INFO - PROCESS | 1658 | 2016-12-03 00:48:54.545 plugin-container[1659:11259] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:48:54 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 00:48:55 INFO - TEST-INFO | 1658: exit 0 00:48:55 INFO - Browser initialized. 00:48:55 INFO - Running cycle 1/1 for kraken test... 00:48:55 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmp3ibdtN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:48:58 INFO - PROCESS | 1660 | 2016-12-03 00:48:58.238 plugin-container[1661:11374] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8633, name = 'com.apple.tsm.portname' 00:48:58 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:48:58 INFO - PROCESS | 1660 | 2016-12-03 00:48:58.239 plugin-container[1661:11374] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a23, name = 'com.apple.CFPasteboardClient' 00:48:58 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:48:58 INFO - PROCESS | 1660 | 2016-12-03 00:48:58.239 plugin-container[1661:11374] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:49:07 INFO - PROCESS | 1660 | RSS: Main: 241840128 00:49:07 INFO - PROCESS | 1660 | 00:49:11 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 00:49:12 INFO - PROCESS | 1660 | RSS: Main: 253906944 00:49:12 INFO - PROCESS | 1660 | 00:49:14 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 00:49:15 INFO - PROCESS | 1660 | RSS: Main: 261443584 00:49:15 INFO - PROCESS | 1660 | 00:49:18 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 00:49:19 INFO - PROCESS | 1660 | RSS: Main: 264253440 00:49:19 INFO - PROCESS | 1660 | 00:49:21 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 00:49:22 INFO - PROCESS | 1660 | RSS: Main: 265351168 00:49:22 INFO - PROCESS | 1660 | 00:49:24 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:49:24 INFO - PROCESS | 1660 | RSS: Main: 267018240 00:49:24 INFO - PROCESS | 1660 | 00:49:27 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 00:49:28 INFO - PROCESS | 1660 | RSS: Main: 273059840 00:49:28 INFO - PROCESS | 1660 | 00:49:31 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 00:49:32 INFO - PROCESS | 1660 | RSS: Main: 272199680 00:49:32 INFO - PROCESS | 1660 | 00:49:35 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 00:49:36 INFO - PROCESS | 1660 | RSS: Main: 271998976 00:49:36 INFO - PROCESS | 1660 | 00:49:37 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:49:38 INFO - PROCESS | 1660 | RSS: Main: 271310848 00:49:38 INFO - PROCESS | 1660 | 00:49:40 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:49:41 INFO - PROCESS | 1660 | RSS: Main: 271282176 00:49:41 INFO - PROCESS | 1660 | 00:49:43 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:49:44 INFO - PROCESS | 1660 | RSS: Main: 271360000 00:49:44 INFO - PROCESS | 1660 | 00:49:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:49:48 INFO - PROCESS | 1660 | RSS: Main: 271392768 00:49:48 INFO - PROCESS | 1660 | 00:49:51 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:49:51 INFO - PROCESS | 1660 | RSS: Main: 271253504 00:49:51 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 00:49:53 INFO - PROCESS | 1660 | RSS: Main: 273608704 00:49:53 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | __start_tp_report 00:49:53 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 00:49:53 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 00:49:53 INFO - PROCESS | 1660 | |i|pagename|runs| 00:49:53 INFO - PROCESS | 1660 | |0;ai-astar;148;174;152;119;98;171;180;131;120;152 00:49:53 INFO - PROCESS | 1660 | |1;audio-beat-detection;148;122;123;146;146;112;151;151;174;123 00:49:53 INFO - PROCESS | 1660 | |2;audio-dft;230;201;197;199;196;197;199;198;193;201 00:49:53 INFO - PROCESS | 1660 | |3;audio-fft;83;62;77;78;60;50;61;76;98;52 00:49:53 INFO - PROCESS | 1660 | |4;audio-oscillator;87;74;88;60;70;94;116;106;89;81 00:49:53 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;89;121;103;87;89;87;111;83;137;135 00:49:53 INFO - PROCESS | 1660 | |6;imaging-darkroom;96;95;124;157;105;114;158;108;99;95 00:49:53 INFO - PROCESS | 1660 | |7;imaging-desaturate;94;113;118;105;141;120;145;144;94;122 00:49:53 INFO - PROCESS | 1660 | |8;json-parse-financial;57;58;70;92;95;85;49;75;92;89 00:49:53 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;69;80;73;88;81;72;69;71;74;74 00:49:53 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;91;102;86;122;110;105;111;114;82;116 00:49:53 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;148;164;170;159;146;188;175;166;202;163 00:49:53 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;174;180;190;176;181;177;177;175;197;247 00:49:53 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;73;71;72;74;71;82;74;81;88;96 00:49:53 INFO - PROCESS | 1660 | __end_tp_report 00:49:53 INFO - PROCESS | 1660 | __start_cc_report 00:49:53 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,930 00:49:53 INFO - PROCESS | 1660 | __end_cc_report 00:49:53 INFO - PROCESS | 1660 | __startTimestamp1480754993775__endTimestamp 00:49:53 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | ------- Summary: start ------- 00:49:53 INFO - PROCESS | 1660 | Number of tests: 14 00:49:53 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:144.50 Median:161.50 stddev:26.98 (16.7%) stddev-sans-first:28.59 00:49:53 INFO - PROCESS | 1660 | Values: 148.0 174.0 152.0 119.0 98.0 171.0 180.0 131.0 120.0 152.0 00:49:53 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:147.00 stddev:18.91 (12.9%) stddev-sans-first:19.81 00:49:53 INFO - PROCESS | 1660 | Values: 148.0 122.0 123.0 146.0 146.0 112.0 151.0 151.0 174.0 123.0 00:49:53 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:201.10 Median:199.00 stddev:10.43 (5.2%) stddev-sans-first:2.52 00:49:53 INFO - PROCESS | 1660 | Values: 230.0 201.0 197.0 199.0 196.0 197.0 199.0 198.0 193.0 201.0 00:49:53 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:69.70 Median:76.50 stddev:15.17 (19.8%) stddev-sans-first:15.30 00:49:53 INFO - PROCESS | 1660 | Values: 83.0 62.0 77.0 78.0 60.0 50.0 61.0 76.0 98.0 52.0 00:49:53 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:86.50 Median:84.00 stddev:16.59 (19.7%) stddev-sans-first:17.59 00:49:53 INFO - PROCESS | 1660 | Values: 87.0 74.0 88.0 60.0 70.0 94.0 116.0 106.0 89.0 81.0 00:49:53 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:104.20 Median:85.00 stddev:20.70 (24.4%) stddev-sans-first:21.22 00:49:53 INFO - PROCESS | 1660 | Values: 89.0 121.0 103.0 87.0 89.0 87.0 111.0 83.0 137.0 135.0 00:49:53 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:115.10 Median:126.50 stddev:24.18 (19.1%) stddev-sans-first:24.64 00:49:53 INFO - PROCESS | 1660 | Values: 96.0 95.0 124.0 157.0 105.0 114.0 158.0 108.0 99.0 95.0 00:49:53 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:119.60 Median:142.50 stddev:19.07 (13.4%) stddev-sans-first:17.84 00:49:53 INFO - PROCESS | 1660 | Values: 94.0 113.0 118.0 105.0 141.0 120.0 145.0 144.0 94.0 122.0 00:49:53 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:76.20 Median:87.00 stddev:16.91 (19.4%) stddev-sans-first:16.45 00:49:53 INFO - PROCESS | 1660 | Values: 57.0 58.0 70.0 92.0 95.0 85.0 49.0 75.0 92.0 89.0 00:49:53 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:75.10 Median:74.00 stddev:6.08 (8.2%) stddev-sans-first:6.04 00:49:53 INFO - PROCESS | 1660 | Values: 69.0 80.0 73.0 88.0 81.0 72.0 69.0 71.0 74.0 74.0 00:49:53 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:103.90 Median:119.00 stddev:13.48 (11.3%) stddev-sans-first:13.46 00:49:53 INFO - PROCESS | 1660 | Values: 91.0 102.0 86.0 122.0 110.0 105.0 111.0 114.0 82.0 116.0 00:49:53 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:168.10 Median:168.00 stddev:17.06 (10.2%) stddev-sans-first:16.47 00:49:53 INFO - PROCESS | 1660 | Values: 148.0 164.0 170.0 159.0 146.0 188.0 175.0 166.0 202.0 163.0 00:49:53 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.40 Median:180.50 stddev:22.18 (12.3%) stddev-sans-first:22.99 00:49:53 INFO - PROCESS | 1660 | Values: 174.0 180.0 190.0 176.0 181.0 177.0 177.0 175.0 197.0 247.0 00:49:53 INFO - PROCESS | 1660 | 00:49:53 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.20 Median:77.50 stddev:8.43 (10.9%) stddev-sans-first:8.73 00:49:53 INFO - PROCESS | 1660 | Values: 73.0 71.0 72.0 74.0 71.0 82.0 74.0 81.0 88.0 96.0 00:49:53 INFO - PROCESS | 1660 | -------- Summary: end -------- 00:49:53 INFO - PROCESS | 1660 | 00:49:54 INFO - TEST-INFO | 1660: exit 0 00:49:54 INFO - TEST-OK | kraken | took 63269ms 00:49:54 INFO - SUITE-END | took 1180s 00:49:54 INFO - Completed test suite (00:19:40) 00:49:54 INFO - javascript benchmark 00:49:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7202.537443454767, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3340.5991281046277, 3382.238996225848, 3394.949075763864, 3413.7951722896614, 3443.603985541662, 4393.494748103969, 5673.43265673433, 5681.488666020057, 5720.399358067405, 5757.625754325966, 5586.441355864412, 5665.660060396379, 5668.064769313059, 5698.230738850254, 5706.714664266791, 4622.838200662977, 5096.898062038757, 5133.897322053556, 5190.532852043315, 5225.007248622768, 3729.6643302102807, 3955.564887862333, 4766.237402015661, 4953.687272872691, 5295.232191332274, 4275.2945763949065, 5304.098303288451, 5308.787648494055, 5313.043652142613, 5316.548093412064, 4070.0435397681667, 5105.463926287724, 5220.660657057317, 5280.577553795706, 5298.602604804655, 3789.8673546425744, 5084.034033533617, 5133.178691409356, 5181.326427564431, 5223.451537588575, 5510.8071217507195, 5675.318961724578, 5685.232493613392, 5687.0900655895275, 5714.228579141804, 6136.447719705248, 6167.105769663373, 6282.685865706742, 6310.116583678288, 6318.4629306509005, 6199.411055949678, 6203.31763506014, 6212.0, 6254.593451425642, 6322.083297921776, 5832.533397328203, 5832.533397328203, 5836.766529338822, 5861.413858614104, 5862.003459411911, 6305.117283580303, 6311.211098612674, 6320.0, 6331.5251356147555, 6335.936640633627, 5985.850353741192, 5995.370486098984, 6052.969735151384, 6094.8171554853425, 6128.80869161996, 6187.535934804908, 6256.906146407808, 6282.057691346335, 6287.276963149205, 6306.936930630727, 6196.47329976948, 6230.376962303824, 6236.126942228092, 6256.812295631138, 6262.843428914313, 6116.914073580098, 6129.693515324216, 6169.722362493699, 6268.0, 6291.591046581958, 4900.26496025599, 4921.630877684116, 4949.628777841676, 4978.5270399312, 5006.199008158677, 4338.154059958341, 4364.5635436456105, 4366.694331396771, 4369.71596846204, 4409.4267745193565, 5562.805301814417, 5785.363610002981, 5820.708964551755, 5841.240638717025, 5884.9705751470965, 5319.281896943863, 6272.6236425814595, 6276.6547839868335, 6349.714262858182, 6355.0, 4743.31221972812, 5045.722485263345, 5756.280464941882, 5831.737571809279, 5931.6441013539325, 4431.113777244564, 4581.0072618411095, 5442.782288708408, 5452.182172674051, 5461.2354270402175, 6220.315765265726, 6244.219472565929, 6290.748370065329, 6405.51958603116, 6416.022066318912, 6147.631142131487, 6193.628382297076, 6229.719662615284, 6232.968835155795, 6268.341824108403, 5256.78972841082, 6318.0, 6357.841053973502, 6373.8725225496155, 6400.0, 6072.271327440735, 6141.969290153521, 6212.627242365473, 6221.47117495018, 6237.75048998035, 5288.524032837063, 6177.382261773787, 6210.472109870531, 6226.968865155826, 6250.9062364065485, 6089.5432842537875, 6112.938870611237, 6126.392418651802, 6158.04550294705, 6176.505879529716, 4784.856454306377, 5286.5990512513445, 5823.068309070529, 6136.8772624548155, 6206.379362063757, 5431.972840135774, 5673.659580425187, 5891.3224979127945, 5909.940900590939, 6083.239595050619, 6070.878582428415, 6075.149479072845, 6120.816375508742, 6133.3866613338305, 6133.977404287646, 5848.473637372657, 5909.85225369352, 5962.70186490665, 5973.581849270509, 6022.247219097613], "value": 5601.435671951363, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.24308404963705, 520.2118790033101, 526.8682829292677, 545.9344878614564, 559.2170960655083, 28382.432351352985, 39321.0, 39473.80263098688, 39514.60485395145, 39639.801800990994, 39435.0141246469, 39953.80023099888, 39961.800190999005, 39983.60016399835, 40066.399004014966, 8358.247757701805, 8553.529555874424, 9139.725808225747, 9400.0, 11022.393768342738, 11022.669319920375, 11361.147913906449, 11361.318320900773, 11370.829437558443, 11416.0, 11299.604513842018, 11305.095592352593, 11323.810999845022, 11344.659660210207, 11360.659180224606, 11264.774704505864, 11322.490487928064, 11322.716932076764, 11349.829752553718, 11386.943065284704, 11162.776744465147, 11167.329960202333, 11238.0, 11244.0, 11246.100311975022, 36846.81576592127, 37218.25563488715, 37341.253174936624, 37449.87650370466, 37482.62517374819, 3267.18320419895, 3272.5034254055868, 3356.681115294043, 3473.5831700195886, 3542.982285088584, 29702.0, 29921.850390748124, 30495.237619059702, 30586.69413305861, 30820.22949426282, 3132.451820931328, 3239.5464634951127, 3263.9184020399443, 3281.8523166457567, 3316.519104729825, 435970.0, 452501.7374913137, 481670.591647043, 485552.0, 486868.0, 55922.44077559172, 56482.43517564772, 57009.14486282709, 57138.714306429036, 57243.42756572381, 61162.08256876151, 61492.462688433145, 61524.0, 61647.0, 61810.69094654498, 14972.176530290939, 15482.690346193238, 15494.922525387527, 15512.844871551366, 15518.534443966699, 10688.305260158066, 11060.949209825054, 11795.35125568102, 12039.819402708967, 12105.394730263451, 12685.492580296685, 13563.0, 13960.930195348958, 16927.714758507445, 16929.153542322834, 5722.96986542418, 5728.627639203439, 6144.539159563051, 6222.315545290015, 6246.718897649616, 842.3471809347682, 930.4045410937006, 934.9392289501296, 954.556131398889, 1012.4785735346303, 28666.0, 28830.135095947157, 29155.416891662473, 29566.408671826444, 29664.406711865642, 894.5482531321641, 930.930180236485, 974.4640447753707, 992.8113658405024, 1020.611967723895, 13118.475260989453, 14820.40718371253, 14956.476523321631, 14996.250187490581, 15128.319225634872, 535963.0, 631739.0, 640204.0, 646333.0, 646797.0, 55408.72295638496, 55844.0, 55848.16227756587, 55849.0, 55991.440085598624, 1287.2469605280828, 1325.7414804113298, 1327.5154568582398, 1342.3959218351586, 1344.4420565465223, 27899.44201116007, 28096.157115286573, 28644.856775715987, 29200.561991569717, 29614.407711846074, 44997.65007049794, 51260.487395127064, 53538.0, 53575.46424535705, 56452.15321770094, 555189.0, 557207.0, 558570.0, 559557.0, 562527.0, 22830.42923926915, 23178.0, 23653.408664783517, 25241.96128619412, 25630.871845640653, 44877.0, 45095.77452112718, 45173.77413112913, 45417.31874021826, 45845.85385365259, 37326.813365933, 37540.24919501649, 37595.706761452624, 37898.0, 38606.2278754429, 34709.47935780915, 37250.06874828151, 37575.0, 37865.053373665876, 38248.04379890525, 27524.0, 27909.44181116407, 32681.836590816893, 34760.478592820626, 37132.0, 25885.741142588333, 26886.59670104989, 29998.70001299959, 30869.610867510568, 33945.830270848484, 22872.885635571714, 24698.0, 25265.873670632263, 25406.364840879127, 25481.87259063693], "value": 19320.99760329581, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.15294680978417, 367.08595596963534, 372.0865275748039, 378.15671053550597, 392.4819238605041, 18866.622667546642, 19053.0, 19309.517262068457, 19920.60158796825, 20139.093740781664, 16428.75356869648, 19795.50511237216, 19963.800361996375, 20025.299114530993, 20062.197512099498, 5272.446393128705, 5701.372848986619, 5995.160677505153, 6000.3699611540815, 6011.428914253139, 3149.291409432882, 3984.1633257015915, 5819.418058194168, 7204.351608355247, 7577.16651168371, 7367.373773229282, 7528.284812942762, 7535.1711311755935, 7622.161562228151, 7633.65648545814, 7507.474476786627, 7618.580978046205, 7634.198409167013, 7643.961780191091, 7649.961750191269, 7022.367986881205, 7298.635068246619, 7342.48602597813, 7350.926490735078, 7367.410607151415, 25710.357241068938, 26637.334066648295, 26801.92792288306, 27205.455890882073, 28131.578026329622, 2383.1063351243283, 2433.0267892842826, 2575.575030120028, 2816.901408450715, 3209.406259841913, 15642.296096675676, 17251.654966900718, 17272.136393180415, 17289.394871179447, 17704.114794260237, 1964.2437661500283, 2033.4408037789726, 2036.1142902837164, 2094.130935661714, 2109.715188449555, 96653.0, 107793.46103269512, 110929.78140437226, 119987.0, 121405.99999999911, 20654.690179647318, 21085.894570527355, 21155.0, 21223.0, 21299.574008519743, 33535.329293414, 34014.10880075172, 34059.14852128716, 34116.82941585326, 34149.80475683339, 8797.428167169242, 10435.16518678504, 10474.581016759397, 10578.418186999788, 10731.946340268249, 8580.570971451403, 8585.0, 8600.913990860012, 8676.392652514263, 8741.213290803858, 7613.695452181962, 7791.64937577799, 8099.919000809917, 8521.190486903733, 9441.480718560408, 1536.285627183365, 1543.4057887713311, 1577.9526614201363, 1588.5393235961674, 3243.935121297608, 722.339059760324, 825.1336097098023, 838.9370797190113, 877.925376343018, 884.5975081337975, 20097.884827851707, 20218.696719549218, 20582.176712931614, 20756.273530426362, 20956.47608809792, 870.2124577257465, 898.0839543665425, 900.4057322167469, 910.1433076523949, 984.3109823123842, 10422.530986105643, 10830.566777328977, 10906.672799816019, 10932.56269749201, 10941.398223097647, 563042.0, 580738.0, 580939.190608097, 587981.0, 597149.0, 126080.0, 127952.80117997124, 128020.35989820177, 129018.0, 129156.35421822831, 928.3084102343662, 939.4691999020531, 963.3449254506862, 967.3905439572883, 969.8060387922303, 17725.379611713528, 18222.544436388667, 18310.725339119657, 18391.0, 18464.907675461538, 50720.492795073056, 52213.21680174724, 52595.474045259056, 52761.0, 52770.0, 75669.62165189139, 76081.61959190169, 76083.95664173593, 76472.23527764874, 78276.60861695655, 5862.589618726648, 6666.666666666783, 6820.249772525118, 6917.896231556631, 7134.60759658203, 7149.85700285981, 8164.632591533514, 9189.586468609063, 9777.022297770167, 12307.138500304893, 7680.807979800326, 8923.598438070432, 10572.735681608021, 10857.402842843403, 10951.123910087334, 10318.535665895202, 10360.585576576852, 10437.791244175225, 10482.947585262025, 11027.221035202423, 5854.736536855767, 10236.129928956123, 10476.738081548023, 10819.945900270448, 11213.327200368005, 7137.429005679637, 7177.318154775288, 7209.531380460253, 7284.307990740871, 7308.5614863108385, 8023.959880200561, 10641.627543035956, 10919.235653504178, 10980.011798938134, 11066.170037247077], "value": 10210.462608172833, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.1205628397827, 1476.542271895712, 1630.2826756227266, 1767.2400867626916, 1784.081198182936, 7519.097708275001, 7774.300312971832, 7997.200279972, 8398.790030249247, 8404.45371050882, 7904.249096335853, 8207.671693132268, 8228.547429891354, 8278.337732981363, 8295.377846661495, 2286.616596958837, 2310.560993411255, 2317.188983855654, 2318.814494840417, 2324.1284518305633, 2300.654901764732, 2331.3821837213154, 2334.7898689117974, 2335.1710142899283, 2347.1432926981615, 2266.331432227497, 2283.041122728458, 2288.233441796992, 2288.7139107611547, 2294.254367330616, 1992.7110568967564, 2270.886455677218, 2286.428392901783, 2289.107248173197, 2295.472041430464, 1896.2415033986379, 1990.4227773945538, 2301.631738921781, 2313.664518644804, 2314.6875171851752, 6969.16370035599, 8237.752867413987, 8310.70912518065, 8356.080831108573, 8358.498490090553, 4878.268259761065, 5025.472325405853, 5045.823396181116, 5068.087744206042, 5073.112205364084, 3208.4545627243424, 3238.4980328048955, 3527.3474407234744, 3535.9469607955903, 3545.2377738786026, 1035.404642330663, 1060.1836585828946, 1073.6939972107912, 1089.536946797608, 1097.3744965369742, 8808.559572021373, 9006.0, 10698.625548105856, 10784.5686172553, 10877.510512026978, 4440.444944381952, 4574.336721175411, 4676.976615116902, 4697.624190064855, 4704.3649107370065, 9317.860232096524, 9414.388064775905, 9424.293178011676, 9426.340156189, 9445.244380449547, 5094.363204599425, 5166.354205724285, 5180.119379705459, 5185.248139019821, 5187.740612969336, 4251.659867210616, 4260.595243451867, 4728.976355118202, 4744.122337367598, 4768.0, 3707.7589956652732, 3759.323321802102, 3805.010697218743, 3840.6543411093135, 3852.9036774080873, 1256.2776403567984, 1256.2901960392348, 1270.7610080171758, 1270.866559011309, 1273.0642977411594, 881.8941726992674, 885.9822803543893, 901.9729408117636, 908.2416182487697, 911.8313112074287, 5108.591312694975, 5590.91613625796, 5761.3950535194035, 5761.625494342854, 5834.183214349994, 430.1311351070882, 430.8922769307673, 433.6032530234863, 434.5502405010862, 438.1412431634033, 3427.4344733119256, 3429.9657003430148, 3512.473129030615, 3519.788812671248, 3572.0, 9717.17404020652, 10022.899771002343, 10077.395356278646, 10085.394876307446, 10121.443320617289, 9871.901280987242, 9968.750781230527, 10004.19966402686, 10013.549390277454, 10047.849282260771, 7523.623818809037, 7643.159252482223, 7755.7673269802, 7831.25603067719, 7833.843323133619, 5483.616146869681, 5607.383187849252, 5616.522595579421, 5632.436756324499, 5743.483086522233, 9246.95376523113, 9315.627374904929, 9315.906840931504, 9341.019192984639, 9362.672306469241, 8987.910120898969, 9367.906320936703, 9455.669051583161, 9455.810883782424, 9461.432314061178, 6549.410553050248, 6747.595144291358, 6899.517033807585, 7004.509684322048, 7066.505344625827, 7753.418493613114, 7847.686092556234, 7919.604019798871, 7932.960335198287, 7949.3243074337015, 6906.274841141608, 7050.400715939202, 7060.470464715269, 7133.500654954311, 7156.0, 6885.552439091443, 6911.93088069133, 6933.064036355027, 6939.0, 6995.230524642387, 6414.198225221848, 6609.867802644017, 6624.436922861418, 6721.462283017249, 6726.6636668167375, 4863.513648635108, 4920.335754673073, 4924.384451943507, 4937.0, 4987.476314986874, 4675.555822196886, 4696.459907110726, 4726.125666751662, 4822.348982887405, 4828.493008234085], "value": 4279.128539734926, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.8747591330283, 297.52544691217514, 299.637438699174, 304.7957868228287, 307.3300205551896, 5179.430262671112, 5230.686158830473, 5370.516653501184, 5403.6757794532305, 5435.592330575208, 4295.0, 4340.0, 4473.463184417867, 5065.1642478990925, 5329.922609203962, 3056.663766985641, 3645.161612829051, 3727.4781530585738, 4122.4746843667735, 4128.834846606147, 3980.3432433648413, 4098.303288440972, 4123.7938103094875, 4135.7518548887165, 4138.358554424069, 4062.2281766464275, 4068.125353049094, 4076.714629975903, 4084.57040035988, 4104.753714777108, 3244.8967351100623, 3763.190913953486, 4060.20825938942, 4106.507219133693, 4127.463429754142, 3237.41007194246, 3576.6572894753976, 3579.427291633326, 3580.3813081125577, 3598.0, 4655.953440465586, 4811.278308253755, 5009.603232258886, 5072.70645985275, 5230.843074707765, 3336.5643080551336, 4175.54069052404, 4618.468876079227, 4711.575958163782, 4738.502457242009, 5098.694078355311, 5474.863128421782, 5479.945200547983, 5665.291838520185, 5671.886562268732, 3236.3850868335176, 3763.73653844231, 3929.31237033518, 3932.6067393260732, 3940.6256405641707, 4963.578095861856, 5400.91898621521, 5845.094010428348, 5924.726183870489, 5973.551983601204, 3327.683870032343, 3335.6831101045364, 4012.61880121388, 4027.35562310029, 4050.696197785178, 3360.0087974047715, 4042.333015052542, 4054.2499637567144, 4080.9799149420633, 4091.488563929509, 4076.3681629347498, 4399.62603178727, 4614.423197100363, 4629.0, 4661.696989695659, 4354.542773008789, 5668.319801623749, 5706.3722990471015, 5725.141228815628, 5743.483086522233, 1115.341948250536, 1183.7869183546873, 1254.7051442910908, 1314.8553659097493, 1324.8145259663654, 720.476192852114, 807.4105902691068, 904.3985749476656, 915.3866909170738, 918.8346097702344, 5013.849584512471, 5028.547430731252, 5049.798008079636, 5096.668716533488, 5104.336436263262, 4770.522947705202, 4808.563520866625, 5424.718045582365, 5572.024895643327, 5573.972130139324, 4280.400743895857, 4665.276882083214, 4915.4347250065985, 5047.268146118792, 5049.798008079636, 2614.2288025032663, 2654.1241390341143, 2669.1992402279625, 2793.916182514487, 2799.2721892308145, 5055.575652759949, 5186.6369354144845, 5547.583931205176, 5717.256756621696, 5732.710140218501, 5015.3730783652045, 5258.421573626898, 5407.621466497386, 5645.887082258332, 5710.743636400069, 4520.819167233274, 5460.2355670207, 5479.369872464637, 5725.963195946848, 5740.282464691913, 4703.623710103115, 4743.549362810665, 5352.304200453916, 5483.835484935458, 5513.448655134454, 4596.655250856133, 4663.836765713319, 5413.512783849473, 5449.23710680513, 5453.863653408696, 5231.607629427732, 5702.6293290935955, 5718.599698021098, 5725.513331366714, 5774.642958904738, 3598.766080204883, 3818.6252948937804, 3868.8334532661797, 3892.377219644843, 3940.862069827542, 4963.677360971526, 5605.579581531483, 5810.738516766671, 5831.308920413033, 5857.0, 4573.5426457354, 4772.735225165404, 4895.46149923501, 5683.119116536944, 5698.202251684685, 5344.3545445004975, 5602.9914615368, 5639.689817060101, 5642.576806739429, 5712.742926568398, 4525.303011370736, 5373.5432488237375, 5539.362973257966, 5554.305711786027, 5580.939621471907, 5099.311592935054, 5246.029484545371, 5654.830355089354, 5699.287589051369, 5716.685162412751, 5571.303587051619, 5574.303212098488, 5596.3284405871555, 5614.747336369792, 5632.633878797865], "value": 4001.5238280644026, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.8781619308522, 684.6987325576746, 711.7864640607817, 747.7943565519481, 796.6176235407005, 14684.41262349506, 15089.320980555874, 15342.30959606819, 15474.613134671625, 15539.92230038851, 14086.436542538286, 14285.428582856674, 14290.928180386487, 14307.78538321926, 14319.212443315613, 817.3665409307789, 828.9129641387658, 829.1998221716043, 830.1864173110356, 833.1377024779355, 643.2827397451831, 663.7013343995197, 798.0, 815.2092470303796, 830.3025458614762, 874.5583480342418, 875.4003507597284, 875.7110153649312, 878.7056336127405, 880.1154839386408, 857.3612658569343, 873.5588527793456, 874.637025634361, 874.6763697431959, 877.0615441477589, 649.9155109835691, 651.1665068712056, 651.5894986158737, 652.3802387731627, 652.6345246661884, 14112.50606228777, 14564.635884102876, 14590.124592524482, 14661.926690366587, 14941.02883312592, 10570.894291057068, 14080.507182248675, 14386.064905781092, 14611.342489587994, 14720.558383248519, 9799.461029643368, 12302.62993892559, 13049.478020879249, 13077.149985250928, 13153.671158221121, 4437.2234858899565, 4470.418845550058, 4490.663200259994, 4495.43807024122, 4689.62483001359, 89888.0, 96325.0, 116164.0, 117263.0, 120027.39986300013, 10544.736381590521, 10570.322170137182, 10601.204909631808, 10695.197860160519, 10956.616518421817, 15417.0, 17360.479185624452, 20181.697274540893, 20231.797682023287, 20277.797222027886, 7793.688252469838, 7849.0, 7850.528968261922, 7858.253465920729, 8089.433739638286, 4262.168877068942, 4318.222719910446, 4344.326629372453, 4400.581944715247, 4414.911701766011, 3474.774139680913, 3548.6806187443253, 3571.7321200910037, 3578.6421357864006, 3622.710183185339, 572.4733245414229, 652.9031227537782, 658.0392626764976, 663.890458074422, 666.3170250493283, 555.8526990347561, 586.9119632055141, 647.0843756085087, 652.5334385913999, 677.3869647968596, 8662.566871656392, 9003.324750643727, 9210.25026225089, 9312.115349041831, 9717.720519985842, 624.2820756130486, 629.3832044596321, 632.1560716443507, 676.1210426445699, 693.6531734132933, 4399.076193999296, 4648.302754586772, 4651.813927442932, 4689.171223222946, 4691.7654117294, 111387.21531961604, 113553.0, 118347.40826295986, 118848.40575797239, 120611.39694301473, 38534.61465385366, 38580.807095964905, 90833.09166908379, 93469.13061738727, 93705.5314723422, 60694.69652651797, 76348.23651763522, 78264.60867695739, 82236.58881705553, 82701.58649206716, 9716.659916902874, 9788.412695238309, 9870.950645246729, 10006.599736010769, 10096.394216347042, 47211.0, 54084.459155407945, 55366.44633553774, 56303.43696562982, 56754.0, 58874.35065422152, 67806.54128045813, 69661.65169174122, 74693.87959180726, 76326.85509717248, 12853.651752364123, 12911.677208069874, 13058.34708264602, 13070.215787052808, 13385.129966552144, 12163.939180304042, 14924.552263432115, 15096.849031509544, 15239.0, 15285.770713439086, 11518.424078795859, 13310.800337994744, 13578.710022547843, 13656.385462654403, 14480.058796178215, 11602.709932251424, 13239.073264871367, 13747.587572372844, 13845.0, 14186.929065354607, 12954.85309339914, 13369.26469044173, 14085.507007254697, 14121.858781412055, 14172.220527871066, 9159.587818548314, 11230.0, 11382.317060976036, 11423.428828558704, 11754.412279386168, 8224.3831712623, 9117.589708463267, 9151.367134067297, 10115.089641932262, 10321.535530901278], "value": 7377.4869901435495, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1669.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 174.0, 152.0, 119.0, 98.0, 171.0, 180.0, 131.0, 120.0, 152.0], "value": 144.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 123.0, 146.0, 146.0, 112.0, 151.0, 151.0, 174.0, 123.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [230.0, 201.0, 197.0, 199.0, 196.0, 197.0, 199.0, 198.0, 193.0, 201.0], "value": 201.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 62.0, 77.0, 78.0, 60.0, 50.0, 61.0, 76.0, 98.0, 52.0], "value": 69.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 74.0, 88.0, 60.0, 70.0, 94.0, 116.0, 106.0, 89.0, 81.0], "value": 86.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 121.0, 103.0, 87.0, 89.0, 87.0, 111.0, 83.0, 137.0, 135.0], "value": 104.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 124.0, 157.0, 105.0, 114.0, 158.0, 108.0, 99.0, 95.0], "value": 115.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 113.0, 118.0, 105.0, 141.0, 120.0, 145.0, 144.0, 94.0, 122.0], "value": 119.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 70.0, 92.0, 95.0, 85.0, 49.0, 75.0, 92.0, 89.0], "value": 76.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 80.0, 73.0, 88.0, 81.0, 72.0, 69.0, 71.0, 74.0, 74.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 102.0, 86.0, 122.0, 110.0, 105.0, 111.0, 114.0, 82.0, 116.0], "value": 103.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 164.0, 170.0, 159.0, 146.0, 188.0, 175.0, 166.0, 202.0, 163.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 180.0, 190.0, 176.0, 181.0, 177.0, 177.0, 175.0, 197.0, 247.0], "value": 187.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 72.0, 74.0, 71.0, 82.0, 74.0, 81.0, 88.0, 96.0], "value": 78.2, "unit": "score"}]}]} 00:49:55 INFO - Return code: 0 00:49:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:49:55 ERROR - # TBPL SUCCESS # 00:49:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:49:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:49:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:49:55 INFO - 2016-12-03 00:49:55.083 screenresolution[1665:11764] starting screenresolution argv=screenresolution get 00:49:55 INFO - 2016-12-03 00:49:55.086 screenresolution[1665:11764] Display 0: 1600x1200x32@60 00:49:55 INFO - 2016-12-03 00:49:55.092 screenresolution[1666:11767] starting screenresolution argv=screenresolution list 00:49:55 INFO - Available Modes on Display 0 00:49:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:49:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:49:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:49:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:49:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:49:55 INFO - Intel Iris: 00:49:55 INFO - Chipset Model: Intel Iris 00:49:55 INFO - Type: GPU 00:49:55 INFO - Bus: Built-In 00:49:55 INFO - VRAM (Dynamic, Max): 1536 MB 00:49:55 INFO - Vendor: Intel (0x8086) 00:49:55 INFO - Device ID: 0x0a2e 00:49:55 INFO - Revision ID: 0x0009 00:49:55 INFO - Displays: 00:49:55 INFO - Display: 00:49:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:49:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:49:55 INFO - Display Serial Number: 1600x1200 60 00:49:55 INFO - Main Display: Yes 00:49:55 INFO - Mirror: Off 00:49:55 INFO - Online: Yes 00:49:55 INFO - Rotation: Supported 00:49:55 INFO - Return code: 0 00:49:55 INFO - Running post-action listener: _resource_record_post_action 00:49:55 INFO - [mozharness: 2016-12-03 08:49:55.333770Z] Finished run-tests step (success) 00:49:55 INFO - Running post-run listener: _resource_record_post_run 00:49:55 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 33227264; Write bytes: 698810880; Read time: 202; Write time: 2031 00:49:55 INFO - TinderboxPrint: CPU usage
54.5% 00:49:55 INFO - TinderboxPrint: I/O read bytes / time
33,227,264 / 202 00:49:55 INFO - TinderboxPrint: I/O write bytes / time
698,810,880 / 2,031 00:49:55 INFO - TinderboxPrint: CPU idle
2,210.8 (45.5%) 00:49:55 INFO - TinderboxPrint: CPU system
980.8 (20.2%) 00:49:55 INFO - TinderboxPrint: CPU user
1,666.1 (34.3%) 00:49:55 INFO - TinderboxPrint: Swap in / out
413,667,328 / 0 00:49:55 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 368591360; Write bytes: 367908864; Read time: 29766; Write time: 793 00:49:55 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 32272896; Write bytes: 312420864; Read time: 189; Write time: 1191 00:49:55 INFO - Running post-run listener: _upload_blobber_files 00:49:55 INFO - Blob upload gear active. 00:49:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:49:55 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 00:49:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:49:56 INFO - (blobuploader) - INFO - Open directory for files ... 00:49:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:49:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:49:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:49:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:49:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:49:56 INFO - (blobuploader) - INFO - Done attempting. 00:49:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:49:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:49:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:49:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:49:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:49:57 INFO - (blobuploader) - INFO - Done attempting. 00:49:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:49:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:49:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:50:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:50:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:50:00 INFO - (blobuploader) - INFO - Done attempting. 00:50:00 INFO - (blobuploader) - INFO - Iteration through files over. 00:50:00 INFO - Return code: 0 00:50:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:50:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:50:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0fb0b7d2bbac1b22303e1a23494b504cef0306d075d3163a0dba096f95e4da31a0ba044299f07300952b774c32a2f7bb90bd42cac49c10e6d897e767ec370ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/099e110605cee3374e79c8ed36215d0f047a98253efe72085abc44c8d838d7e23b5ade58af933b549f304b13baed4414d4894b0f1d310cc74b379601cf3bdb84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd697c97abd66121d980ada6e5d1f7d45e58520a3b5bd1c17345f82e7143ecae4a920315137dcaf13496e051c05f2b2cc10fa914c8fb4451030ef69376bd2bd5"} 00:50:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:50:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:50:00 INFO - Contents: 00:50:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0fb0b7d2bbac1b22303e1a23494b504cef0306d075d3163a0dba096f95e4da31a0ba044299f07300952b774c32a2f7bb90bd42cac49c10e6d897e767ec370ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/099e110605cee3374e79c8ed36215d0f047a98253efe72085abc44c8d838d7e23b5ade58af933b549f304b13baed4414d4894b0f1d310cc74b379601cf3bdb84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd697c97abd66121d980ada6e5d1f7d45e58520a3b5bd1c17345f82e7143ecae4a920315137dcaf13496e051c05f2b2cc10fa914c8fb4451030ef69376bd2bd5"} 00:50:00 INFO - Running post-run listener: copy_logs_to_upload_dir 00:50:00 INFO - Copying logs to upload dir... 00:50:00 INFO - mkdir: /builds/slave/test/build/upload/logs 00:50:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.295724 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-12-03 00:50:00.101375) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-03 00:50:00.105475) ========= 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.SlZBYVFMMG/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.C77yp6vnDY/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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/Firefox/sha512/b0fb0b7d2bbac1b22303e1a23494b504cef0306d075d3163a0dba096f95e4da31a0ba044299f07300952b774c32a2f7bb90bd42cac49c10e6d897e767ec370ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/099e110605cee3374e79c8ed36215d0f047a98253efe72085abc44c8d838d7e23b5ade58af933b549f304b13baed4414d4894b0f1d310cc74b379601cf3bdb84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd697c97abd66121d980ada6e5d1f7d45e58520a3b5bd1c17345f82e7143ecae4a920315137dcaf13496e051c05f2b2cc10fa914c8fb4451030ef69376bd2bd5"} build_url:https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010861 build_url: 'https://queue.taskcluster.net/v1/task/e1SXmQsnRN2XbWuZBmer_A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0fb0b7d2bbac1b22303e1a23494b504cef0306d075d3163a0dba096f95e4da31a0ba044299f07300952b774c32a2f7bb90bd42cac49c10e6d897e767ec370ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/099e110605cee3374e79c8ed36215d0f047a98253efe72085abc44c8d838d7e23b5ade58af933b549f304b13baed4414d4894b0f1d310cc74b379601cf3bdb84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd697c97abd66121d980ada6e5d1f7d45e58520a3b5bd1c17345f82e7143ecae4a920315137dcaf13496e051c05f2b2cc10fa914c8fb4451030ef69376bd2bd5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-03 00:50:00.139004) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 00:50:00.139320) ========= 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.SlZBYVFMMG/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.C77yp6vnDY/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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.004511 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 00:50:00.187599) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-03 00:50:00.187876) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-03 00:50:00.188217) ========= ========= Total master_lag: 0.19 =========