builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0078 starttime: 1468605138.06 results: success (0) buildid: 20160713141046 builduid: f56c373fb50a40f583c4b414d4dcca39 revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.064622) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.065076) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.065351) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.138178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.138418) ========= 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.BOoNWKAL6m/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.j5VyQnbk78/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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-07-15 10:52:18-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 178M=0s 2016-07-15 10:52:18 (178 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.585151 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.750293) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.750584) ========= 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.BOoNWKAL6m/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.j5VyQnbk78/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.027939 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.798878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 10:52:18.799175) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5fd14a66be3191e5628af3cfb0a456dd70f179b8 --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 5fd14a66be3191e5628af3cfb0a456dd70f179b8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BOoNWKAL6m/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.j5VyQnbk78/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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-07-15 10:52:18,876 truncating revision to first 12 chars 2016-07-15 10:52:18,876 Setting DEBUG logging. 2016-07-15 10:52:18,876 attempt 1/10 2016-07-15 10:52:18,876 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5fd14a66be31?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 10:52:20,112 unpacking tar archive at: mozilla-central-5fd14a66be31/testing/mozharness/ program finished with exit code 0 elapsedTime=1.517578 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 10:52:20.339681) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:20.340026) ========= script_repo_revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:20.340442) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:20.340751) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:20.360257) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 38 secs) (at 2016-07-15 10:52:20.360709) ========= /tools/buildbot/bin/python 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', '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.BOoNWKAL6m/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.j5VyQnbk78/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:52:20 INFO - MultiFileLogger online at 20160715 10:52:20 in /builds/slave/test 10:52:20 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 10:52:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:52:20 INFO - {'append_to_log': False, 10:52:20 INFO - 'base_work_dir': '/builds/slave/test', 10:52:20 INFO - 'blob_upload_branch': 'Firefox', 10:52:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:52:20 INFO - 'branch': 'Firefox', 10:52:20 INFO - 'buildbot_json_path': 'buildprops.json', 10:52:20 INFO - 'config_files': ('talos/mac_config.py',), 10:52:20 INFO - 'default_actions': ('clobber', 10:52:20 INFO - 'read-buildbot-config', 10:52:20 INFO - 'download-and-extract', 10:52:20 INFO - 'populate-webroot', 10:52:20 INFO - 'create-virtualenv', 10:52:20 INFO - 'install', 10:52:20 INFO - 'run-tests'), 10:52:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:52:20 INFO - 'download_minidump_stackwalk': True, 10:52:20 INFO - 'download_symbols': 'ondemand', 10:52:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:52:20 INFO - 'tooltool.py': '/tools/tooltool.py', 10:52:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:52:20 INFO - '/tools/misc-python/virtualenv.py')}, 10:52:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:52:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:52:20 INFO - 'installer_path': 'installer.exe', 10:52:20 INFO - 'log_level': 'info', 10:52:20 INFO - 'log_name': 'talos', 10:52:20 INFO - 'log_to_console': True, 10:52:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:52:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:52:20 INFO - 'opt_config_files': (), 10:52:20 INFO - 'pip_index': False, 10:52:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:52:20 INFO - 'cmd': ('bash', 10:52:20 INFO - '-c', 10:52:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:52:20 INFO - 'enabled': True, 10:52:20 INFO - 'halt_on_failure': False, 10:52:20 INFO - 'name': 'check_screen_resolution'},), 10:52:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:52:20 INFO - 'cmd': ('bash', 10:52:20 INFO - '-c', 10:52:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:52:20 INFO - 'enabled': True, 10:52:20 INFO - 'halt_on_failure': False, 10:52:20 INFO - 'name': 'check_screen_resolution'},), 10:52:20 INFO - 'run_cmd_checks_enabled': True, 10:52:20 INFO - 'sps_profile': False, 10:52:20 INFO - 'sps_profile_interval': 0, 10:52:20 INFO - 'suite': 'dromaeojs-e10s', 10:52:20 INFO - 'system_bits': '32', 10:52:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:52:20 INFO - 'title': 't-yosemite-r7-0078', 10:52:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:52:20 INFO - 'use_talos_json': True, 10:52:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:52:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:52:20 INFO - 'work_dir': 'build'} 10:52:20 INFO - ##### 10:52:20 INFO - ##### Running clobber step. 10:52:20 INFO - ##### 10:52:20 INFO - Running pre-action listener: _resource_record_pre_action 10:52:20 INFO - Running main action method: clobber 10:52:20 INFO - rmtree: /builds/slave/test/build 10:52:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:52:22 INFO - Running post-action listener: _resource_record_post_action 10:52:22 INFO - ##### 10:52:22 INFO - ##### Finished clobber step (success) 10:52:22 INFO - ##### 10:52:22 INFO - ##### 10:52:22 INFO - ##### Running read-buildbot-config step. 10:52:22 INFO - ##### 10:52:22 INFO - Running pre-action listener: _resource_record_pre_action 10:52:22 INFO - Running main action method: read_buildbot_config 10:52:22 INFO - Using buildbot properties: 10:52:22 INFO - { 10:52:22 INFO - "project": "", 10:52:22 INFO - "product": "firefox", 10:52:22 INFO - "script_repo_revision": "production", 10:52:22 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:52:22 INFO - "repository": "", 10:52:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:52:22 INFO - "buildid": "20160713141046", 10:52:22 INFO - "pgo_build": "False", 10:52:22 INFO - "basedir": "/builds/slave/test", 10:52:22 INFO - "buildnumber": 64, 10:52:22 INFO - "slavename": "t-yosemite-r7-0078", 10:52:22 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 10:52:22 INFO - "platform": "yosemite_r7", 10:52:22 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:52:22 INFO - "branch": "mozilla-central", 10:52:22 INFO - "repo_path": "mozilla-central", 10:52:22 INFO - "revision": "5fd14a66be3191e5628af3cfb0a456dd70f179b8", 10:52:22 INFO - "stage_platform": "macosx64", 10:52:22 INFO - "builduid": "f56c373fb50a40f583c4b414d4dcca39", 10:52:22 INFO - "slavebuilddir": "test" 10:52:22 INFO - } 10:52:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 10:52:22 INFO - Running post-action listener: _resource_record_post_action 10:52:22 INFO - ##### 10:52:22 INFO - ##### Finished read-buildbot-config step (success) 10:52:22 INFO - ##### 10:52:22 INFO - ##### 10:52:22 INFO - ##### Running download-and-extract step. 10:52:22 INFO - ##### 10:52:22 INFO - Running pre-action listener: _resource_record_pre_action 10:52:22 INFO - Running main action method: download_and_extract 10:52:22 INFO - mkdir: /builds/slave/test/build/tests 10:52:22 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:22 INFO - https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:52:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 10:52:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 10:52:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 10:52:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 10:52:42 INFO - Downloaded 1199 bytes. 10:52:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 10:52:42 INFO - Using the following test package requirements: 10:52:42 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:52:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:42 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 10:52:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:42 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 10:52:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:42 INFO - u'jsshell-mac.zip'], 10:52:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:42 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 10:52:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:52:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:42 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 10:52:42 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:42 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 10:52:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:42 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 10:52:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:42 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 10:52:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:42 INFO - https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:52:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:52:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:52:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:53:12 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip: timed out 10:53:12 INFO - retry: attempt #1 caught exception: timed out 10:53:12 INFO - retry: Failed, sleeping 30 seconds before retrying 10:53:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #2 10:53:44 INFO - Downloaded 18827271 bytes. 10:53:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:53:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:53:47 INFO - Return code: 0 10:53:47 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:47 INFO - https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:53:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:53:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:53:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:53:57 INFO - Downloaded 18827271 bytes. 10:53:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:53:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:54:00 INFO - Return code: 0 10:54:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:00 INFO - https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:54:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:54:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:54:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:54:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:54:02 INFO - Downloaded 14403317 bytes. 10:54:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:54:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:54:02 INFO - Return code: 0 10:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:02 INFO - https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:54:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:54:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:54:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 10:54:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 10:54:10 INFO - Downloaded 112779863 bytes. 10:54:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:54:10 INFO - mkdir: /builds/slave/test/properties 10:54:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:54:10 INFO - Writing to file /builds/slave/test/properties/build_url 10:54:10 INFO - Contents: 10:54:10 INFO - build_url:https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:54:11 INFO - Running post-action listener: _resource_record_post_action 10:54:11 INFO - Running post-action listener: set_extra_try_arguments 10:54:11 INFO - ##### 10:54:11 INFO - ##### Finished download-and-extract step (success) 10:54:11 INFO - ##### 10:54:11 INFO - ##### 10:54:11 INFO - ##### Running populate-webroot step. 10:54:11 INFO - ##### 10:54:11 INFO - Running pre-action listener: _resource_record_pre_action 10:54:11 INFO - Running main action method: populate_webroot 10:54:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:54:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:54:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:54:11 INFO - '--tppagecycles', 10:54:11 INFO - '7'], 10:54:11 INFO - 'tests': ['tsvgm']}}, 10:54:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:54:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:54:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:54:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:54:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:54:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:54:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:11 INFO - 'talos_options': ['--disable-e10s'], 10:54:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:54:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:54:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:11 INFO - 'talos_options': ['--disable-e10s'], 10:54:11 INFO - 'tests': ['damp', 'tps']}, 10:54:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:11 INFO - 'tests': ['damp', 'tps']}, 10:54:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:54:11 INFO - 'tests': ['dromaeo_dom']}, 10:54:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:54:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:54:11 INFO - 'tests': ['basic_compositor_video']}, 10:54:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:54:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:54:11 INFO - 'tests': ['a11yr', 10:54:11 INFO - 'ts_paint', 10:54:11 INFO - 'tpaint', 10:54:11 INFO - 'sessionrestore', 10:54:11 INFO - 'sessionrestore_no_auto_restore', 10:54:11 INFO - 'tabpaint']}, 10:54:11 INFO - 'other-e10s': {'tests': ['a11yr', 10:54:11 INFO - 'ts_paint', 10:54:11 INFO - 'tpaint', 10:54:11 INFO - 'sessionrestore', 10:54:11 INFO - 'sessionrestore_no_auto_restore', 10:54:11 INFO - 'tabpaint']}, 10:54:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:54:11 INFO - 'ts_paint', 10:54:11 INFO - 'tpaint', 10:54:11 INFO - 'sessionrestore', 10:54:11 INFO - 'sessionrestore_no_auto_restore', 10:54:11 INFO - 'tabpaint']}, 10:54:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:54:11 INFO - 'ts_paint', 10:54:11 INFO - 'tpaint', 10:54:11 INFO - 'sessionrestore', 10:54:11 INFO - 'sessionrestore_no_auto_restore', 10:54:11 INFO - 'tabpaint']}, 10:54:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:54:11 INFO - 'tests': ['a11yr', 10:54:11 INFO - 'ts_paint', 10:54:11 INFO - 'tpaint', 10:54:11 INFO - 'sessionrestore', 10:54:11 INFO - 'sessionrestore_no_auto_restore', 10:54:11 INFO - 'tabpaint']}, 10:54:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:54:11 INFO - 'tests': ['a11yr', 10:54:11 INFO - 'ts_paint', 10:54:11 INFO - 'tpaint', 10:54:11 INFO - 'sessionrestore', 10:54:11 INFO - 'sessionrestore_no_auto_restore', 10:54:11 INFO - 'tabpaint']}, 10:54:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:54:11 INFO - 'tests': ['tsvgx', 10:54:11 INFO - 'tsvgr_opacity', 10:54:11 INFO - 'tart', 10:54:11 INFO - 'tscrollx', 10:54:11 INFO - 'cart']}, 10:54:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:54:11 INFO - 'tsvgr_opacity', 10:54:11 INFO - 'tart', 10:54:11 INFO - 'tscrollx', 10:54:11 INFO - 'cart']}, 10:54:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:11 INFO - 'talos_options': ['--disable-e10s'], 10:54:11 INFO - 'tests': ['tp5o']}, 10:54:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:11 INFO - 'tests': ['tp5o']}, 10:54:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:11 INFO - 'talos_options': ['--disable-e10s', 10:54:11 INFO - '--xperf_path', 10:54:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:54:11 INFO - 'tests': ['tp5n']}, 10:54:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:11 INFO - 'talos_options': ['--xperf_path', 10:54:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:54:11 INFO - 'tests': ['tp5n']}}, 10:54:11 INFO - 'talos.zip': {'path': '', 10:54:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:54:11 INFO - Running post-action listener: _resource_record_post_action 10:54:11 INFO - ##### 10:54:11 INFO - ##### Finished populate-webroot step (success) 10:54:11 INFO - ##### 10:54:11 INFO - ##### 10:54:11 INFO - ##### Running create-virtualenv step. 10:54:11 INFO - ##### 10:54:11 INFO - Running pre-action listener: _resource_record_pre_action 10:54:11 INFO - Running main action method: create_virtualenv 10:54:11 INFO - Creating virtualenv /builds/slave/test/build/venv 10:54:11 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 10:54:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:54:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:54:11 INFO - Using real prefix '/tools/python27' 10:54:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:54:12 INFO - Installing distribute.............................................................................................................................................................................................done. 10:54:15 INFO - Installing pip.................done. 10:54:15 INFO - Return code: 0 10:54:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:15 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 0x1079cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a60618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61593f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792fd30>, '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 0x107694db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107927b20>, '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.BOoNWKAL6m/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.j5VyQnbk78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:54:15 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 10:54:15 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 10:54:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOoNWKAL6m/Render', 10:54:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:15 INFO - 'HOME': '/Users/cltbld', 10:54:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:15 INFO - 'LOGNAME': 'cltbld', 10:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:15 INFO - 'MOZ_NO_REMOTE': '1', 10:54:15 INFO - 'NO_EM_RESTART': '1', 10:54:15 INFO - 'PAGER': '/bin/cat', 10:54:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:15 INFO - 'PWD': '/builds/slave/test', 10:54:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:15 INFO - 'SHELL': '/bin/bash', 10:54:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5VyQnbk78/Listeners', 10:54:15 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:54:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:15 INFO - 'USER': 'cltbld', 10:54:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:15 INFO - 'XPC_FLAGS': '0x0', 10:54:15 INFO - 'XPC_SERVICE_NAME': '0', 10:54:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:15 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 10:54:15 INFO - Cleaning up... 10:54:15 INFO - Return code: 0 10:54:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:15 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 0x1079cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a60618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61593f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792fd30>, '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 0x107694db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107927b20>, '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.BOoNWKAL6m/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.j5VyQnbk78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:54:15 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 10:54:15 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 10:54:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOoNWKAL6m/Render', 10:54:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:15 INFO - 'HOME': '/Users/cltbld', 10:54:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:15 INFO - 'LOGNAME': 'cltbld', 10:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:15 INFO - 'MOZ_NO_REMOTE': '1', 10:54:15 INFO - 'NO_EM_RESTART': '1', 10:54:15 INFO - 'PAGER': '/bin/cat', 10:54:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:15 INFO - 'PWD': '/builds/slave/test', 10:54:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:15 INFO - 'SHELL': '/bin/bash', 10:54:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5VyQnbk78/Listeners', 10:54:15 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:54:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:15 INFO - 'USER': 'cltbld', 10:54:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:15 INFO - 'XPC_FLAGS': '0x0', 10:54:15 INFO - 'XPC_SERVICE_NAME': '0', 10:54:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:15 INFO - Downloading/unpacking psutil>=3.1.1 10:54:15 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 10:54:15 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 10:54:15 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 10:54:15 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 10:54:15 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 10:54:15 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 10:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:54:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:19 INFO - Installing collected packages: psutil 10:54:19 INFO - Running setup.py install for psutil 10:54:19 INFO - building 'psutil._psutil_osx' extension 10:54:19 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 10:54:19 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 10:54:19 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 10:54:20 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 10:54:20 INFO - building 'psutil._psutil_posix' extension 10:54:20 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 10:54:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:54:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:54:20 INFO - ^ 10:54:20 INFO - 1 warning generated. 10:54:20 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 10:54:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:20 INFO - Successfully installed psutil 10:54:20 INFO - Cleaning up... 10:54:20 INFO - Return code: 0 10:54:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:54:20 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:20 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:20 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 0x1079cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a60618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61593f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792fd30>, '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 0x107694db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107927b20>, '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.BOoNWKAL6m/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.j5VyQnbk78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:54:20 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 10:54:20 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 10:54:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOoNWKAL6m/Render', 10:54:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:20 INFO - 'HOME': '/Users/cltbld', 10:54:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:20 INFO - 'LOGNAME': 'cltbld', 10:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:20 INFO - 'MOZ_NO_REMOTE': '1', 10:54:20 INFO - 'NO_EM_RESTART': '1', 10:54:20 INFO - 'PAGER': '/bin/cat', 10:54:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:20 INFO - 'PWD': '/builds/slave/test', 10:54:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:20 INFO - 'SHELL': '/bin/bash', 10:54:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5VyQnbk78/Listeners', 10:54:20 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:54:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:20 INFO - 'USER': 'cltbld', 10:54:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:20 INFO - 'XPC_FLAGS': '0x0', 10:54:20 INFO - 'XPC_SERVICE_NAME': '0', 10:54:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:54:20 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 10:54:20 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 10:54:20 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 10:54:20 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 10:54:20 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 10:54:20 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 10:54:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:54:23 INFO - Installing collected packages: mozsystemmonitor 10:54:23 INFO - Running setup.py install for mozsystemmonitor 10:54:23 INFO - Successfully installed mozsystemmonitor 10:54:23 INFO - Cleaning up... 10:54:23 INFO - Return code: 0 10:54:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:23 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 0x1079cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a60618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61593f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792fd30>, '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 0x107694db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107927b20>, '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.BOoNWKAL6m/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.j5VyQnbk78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:54:23 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 10:54:23 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 10:54:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOoNWKAL6m/Render', 10:54:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:23 INFO - 'HOME': '/Users/cltbld', 10:54:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:23 INFO - 'LOGNAME': 'cltbld', 10:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:23 INFO - 'MOZ_NO_REMOTE': '1', 10:54:23 INFO - 'NO_EM_RESTART': '1', 10:54:23 INFO - 'PAGER': '/bin/cat', 10:54:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:23 INFO - 'PWD': '/builds/slave/test', 10:54:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:23 INFO - 'SHELL': '/bin/bash', 10:54:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5VyQnbk78/Listeners', 10:54:23 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:54:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:23 INFO - 'USER': 'cltbld', 10:54:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:23 INFO - 'XPC_FLAGS': '0x0', 10:54:23 INFO - 'XPC_SERVICE_NAME': '0', 10:54:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:23 INFO - Downloading/unpacking jsonschema==2.5.1 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:54:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:54:26 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 10:54:26 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 10:54:26 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 10:54:26 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 10:54:26 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 10:54:26 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 10:54:26 INFO - Downloading functools32-3.2.3-2.tar.gz 10:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:54:26 INFO - warning: no files found matching '*.txt' 10:54:26 INFO - no previously-included directories found matching 'build' 10:54:26 INFO - no previously-included directories found matching 'dist' 10:54:26 INFO - no previously-included directories found matching '.git*' 10:54:26 INFO - Installing collected packages: jsonschema, functools32 10:54:26 INFO - Running setup.py install for functools32 10:54:26 INFO - warning: no files found matching '*.txt' 10:54:26 INFO - no previously-included directories found matching 'build' 10:54:26 INFO - no previously-included directories found matching 'dist' 10:54:26 INFO - no previously-included directories found matching '.git*' 10:54:26 INFO - Successfully installed jsonschema functools32 10:54:26 INFO - Cleaning up... 10:54:26 INFO - Return code: 0 10:54:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:54:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:26 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 0x1079cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a60618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61593f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792fd30>, '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 0x107694db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107927b20>, '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.BOoNWKAL6m/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.j5VyQnbk78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:54:26 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 10:54:26 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 10:54:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOoNWKAL6m/Render', 10:54:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:26 INFO - 'HOME': '/Users/cltbld', 10:54:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:26 INFO - 'LOGNAME': 'cltbld', 10:54:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:26 INFO - 'MOZ_NO_REMOTE': '1', 10:54:26 INFO - 'NO_EM_RESTART': '1', 10:54:26 INFO - 'PAGER': '/bin/cat', 10:54:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:26 INFO - 'PWD': '/builds/slave/test', 10:54:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:26 INFO - 'SHELL': '/bin/bash', 10:54:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5VyQnbk78/Listeners', 10:54:26 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:54:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:26 INFO - 'USER': 'cltbld', 10:54:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:26 INFO - 'XPC_FLAGS': '0x0', 10:54:26 INFO - 'XPC_SERVICE_NAME': '0', 10:54:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:27 INFO - Downloading/unpacking blobuploader==1.2.4 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54: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 10:54:29 INFO - Downloading blobuploader-1.2.4.tar.gz 10:54:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:54:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:54:29 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 10:54:29 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 10:54:29 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 10:54:29 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 10:54:29 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 10:54:29 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 10:54:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:54:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:30 INFO - Downloading docopt-0.6.1.tar.gz 10:54:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:54:30 INFO - Installing collected packages: blobuploader, requests, docopt 10:54:30 INFO - Running setup.py install for blobuploader 10:54:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:54:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:54:31 INFO - Running setup.py install for requests 10:54:31 INFO - Running setup.py install for docopt 10:54:31 INFO - Successfully installed blobuploader requests docopt 10:54:31 INFO - Cleaning up... 10:54:31 INFO - Return code: 0 10:54:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:31 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 0x1079cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a60618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61593f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792fd30>, '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 0x107694db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107927b20>, '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.BOoNWKAL6m/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.j5VyQnbk78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:54:31 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 10:54:31 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 10:54:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOoNWKAL6m/Render', 10:54:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:31 INFO - 'HOME': '/Users/cltbld', 10:54:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:31 INFO - 'LOGNAME': 'cltbld', 10:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:31 INFO - 'MOZ_NO_REMOTE': '1', 10:54:31 INFO - 'NO_EM_RESTART': '1', 10:54:31 INFO - 'PAGER': '/bin/cat', 10:54:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:31 INFO - 'PWD': '/builds/slave/test', 10:54:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:31 INFO - 'SHELL': '/bin/bash', 10:54:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5VyQnbk78/Listeners', 10:54:31 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:54:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:31 INFO - 'USER': 'cltbld', 10:54:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:31 INFO - 'XPC_FLAGS': '0x0', 10:54:31 INFO - 'XPC_SERVICE_NAME': '0', 10:54:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:54:32 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-4MayRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:54:32 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-YAp8Kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:54:32 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-6zftx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:54:32 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-HwlXCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:54:32 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-lzI3Rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:54:32 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-OYU4Jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:54:32 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-flpf4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:54:32 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-fuXk6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:54:32 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-TXmNpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:54:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-jExS1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:54:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-f7UaR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:54:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-k3ts8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:54:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-0I3Yxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:54:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-Z2xQf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-ZCi5NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:54:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-z8WVRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:54:33 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-HJrkZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:54:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:54:33 INFO - Running setup.py install for manifestparser 10:54:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:54:34 INFO - Running setup.py install for mozcrash 10:54:34 INFO - Running setup.py install for mozdebug 10:54:34 INFO - Running setup.py install for mozdevice 10:54:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:54:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:54:34 INFO - Running setup.py install for mozfile 10:54:34 INFO - Running setup.py install for mozhttpd 10:54:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:54:34 INFO - Running setup.py install for mozinfo 10:54:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:54:34 INFO - Running setup.py install for mozInstall 10:54:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:54:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:54:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:54:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:54:35 INFO - Running setup.py install for mozleak 10:54:35 INFO - Running setup.py install for mozlog 10:54:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:54:35 INFO - Running setup.py install for moznetwork 10:54:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:54:35 INFO - Running setup.py install for mozprocess 10:54:35 INFO - Running setup.py install for mozprofile 10:54:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:54:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:54:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:54:35 INFO - Running setup.py install for mozrunner 10:54:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:54:36 INFO - Running setup.py install for mozscreenshot 10:54:36 INFO - Running setup.py install for moztest 10:54:36 INFO - Running setup.py install for mozversion 10:54:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:54:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:54:36 INFO - Cleaning up... 10:54:36 INFO - Return code: 0 10:54:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:36 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 0x1079cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a60618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61593f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792fd30>, '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 0x107694db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107927b20>, '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.BOoNWKAL6m/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.j5VyQnbk78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:54:36 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 10:54:36 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 10:54:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOoNWKAL6m/Render', 10:54:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:36 INFO - 'HOME': '/Users/cltbld', 10:54:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:36 INFO - 'LOGNAME': 'cltbld', 10:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:36 INFO - 'MOZ_NO_REMOTE': '1', 10:54:36 INFO - 'NO_EM_RESTART': '1', 10:54:36 INFO - 'PAGER': '/bin/cat', 10:54:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:36 INFO - 'PWD': '/builds/slave/test', 10:54:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:36 INFO - 'SHELL': '/bin/bash', 10:54:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5VyQnbk78/Listeners', 10:54:36 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:54:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:36 INFO - 'USER': 'cltbld', 10:54:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:36 INFO - 'XPC_FLAGS': '0x0', 10:54:36 INFO - 'XPC_SERVICE_NAME': '0', 10:54:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:54:36 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-JOUc5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:54:36 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)) 10:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:54:36 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-EYOCGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:54:36 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-infDGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:54:37 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)) 10:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:54:37 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-acvWie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:54:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:54:37 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-MCYEC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:54:37 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)) 10:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:54:37 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-U10Ag2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:54:37 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)) 10:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:54:37 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-TI8xjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:54:37 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)) 10:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:54:37 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-fWJkoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:54:37 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)) 10:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:54:37 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-lzS6wG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:54:37 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)) 10:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:54:37 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-arX3Nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:54:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 10:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:54:37 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-Ykfng0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:54:37 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)) 10:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:54:37 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-wZlmaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:54:38 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)) 10:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:54:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-XvCxC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:54:38 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)) 10:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:54:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-UC9RLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:54:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-iIkL1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:38 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)) 10:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:54:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-YFmAL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:54:38 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)) 10:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:54:38 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-umPeDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:54:38 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)) 10:54:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:38 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)) 10:54:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:41 INFO - Downloading blessings-1.6.tar.gz 10:54:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:54:41 INFO - Installing collected packages: blessings 10:54:41 INFO - Running setup.py install for blessings 10:54:41 INFO - Successfully installed blessings 10:54:41 INFO - Cleaning up... 10:54:41 INFO - Return code: 0 10:54:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:54:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:54:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:54:41 INFO - Reading from file tmpfile_stdout 10:54:41 INFO - Current package versions: 10:54:41 INFO - blessings == 1.6 10:54:41 INFO - blobuploader == 1.2.4 10:54:41 INFO - docopt == 0.6.1 10:54:41 INFO - functools32 == 3.2.3-2 10:54:41 INFO - jsonschema == 2.5.1 10:54:41 INFO - manifestparser == 1.1 10:54:41 INFO - mozInstall == 1.12 10:54:41 INFO - mozcrash == 0.17 10:54:41 INFO - mozdebug == 0.1 10:54:41 INFO - mozdevice == 0.48 10:54:41 INFO - mozfile == 1.2 10:54:41 INFO - mozhttpd == 0.7 10:54:41 INFO - mozinfo == 0.9 10:54:41 INFO - mozleak == 0.1 10:54:41 INFO - mozlog == 3.2 10:54:41 INFO - moznetwork == 0.27 10:54:41 INFO - mozprocess == 0.23 10:54:41 INFO - mozprofile == 0.28 10:54:41 INFO - mozrunner == 6.12 10:54:41 INFO - mozscreenshot == 0.1 10:54:41 INFO - mozsystemmonitor == 0.3 10:54:41 INFO - moztest == 0.7 10:54:41 INFO - mozversion == 1.4 10:54:41 INFO - psutil == 3.1.1 10:54:41 INFO - requests == 1.2.3 10:54:41 INFO - wsgiref == 0.1.2 10:54:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:41 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:41 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:41 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 0x1079cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a60618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61593f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792fd30>, '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 0x107694db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107927b20>, '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.BOoNWKAL6m/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.j5VyQnbk78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:54:41 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 10:54:41 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 10:54:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOoNWKAL6m/Render', 10:54:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:41 INFO - 'HOME': '/Users/cltbld', 10:54:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:41 INFO - 'LOGNAME': 'cltbld', 10:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:41 INFO - 'MOZ_NO_REMOTE': '1', 10:54:41 INFO - 'NO_EM_RESTART': '1', 10:54:41 INFO - 'PAGER': '/bin/cat', 10:54:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:41 INFO - 'PWD': '/builds/slave/test', 10:54:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:41 INFO - 'SHELL': '/bin/bash', 10:54:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5VyQnbk78/Listeners', 10:54:41 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:54:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:41 INFO - 'USER': 'cltbld', 10:54:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:41 INFO - 'XPC_FLAGS': '0x0', 10:54:41 INFO - 'XPC_SERVICE_NAME': '0', 10:54:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:41 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)) 10:54:41 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)) 10:54:41 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)) 10:54:41 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)) 10:54:41 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)) 10:54:41 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)) 10:54:41 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)) 10:54:41 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)) 10:54:41 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)) 10:54:41 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)) 10:54:41 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)) 10:54:41 INFO - Cleaning up... 10:54:41 INFO - Return code: 0 10:54:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:54:41 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:41 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:41 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 0x1079cba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107a60618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb61593f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10792fd30>, '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 0x107694db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107927b20>, '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.BOoNWKAL6m/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.j5VyQnbk78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 10:54:41 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 10:54:41 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 10:54:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOoNWKAL6m/Render', 10:54:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:41 INFO - 'HOME': '/Users/cltbld', 10:54:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:41 INFO - 'LOGNAME': 'cltbld', 10:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:41 INFO - 'MOZ_NO_REMOTE': '1', 10:54:41 INFO - 'NO_EM_RESTART': '1', 10:54:41 INFO - 'PAGER': '/bin/cat', 10:54:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:41 INFO - 'PWD': '/builds/slave/test', 10:54:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:41 INFO - 'SHELL': '/bin/bash', 10:54:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5VyQnbk78/Listeners', 10:54:41 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:54:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:41 INFO - 'USER': 'cltbld', 10:54:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:42 INFO - 'XPC_FLAGS': '0x0', 10:54:42 INFO - 'XPC_SERVICE_NAME': '0', 10:54:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:54:42 INFO - Cleaning up... 10:54:42 INFO - Return code: 0 10:54:42 INFO - Running post-action listener: _resource_record_post_action 10:54:42 INFO - Running post-action listener: _start_resource_monitoring 10:54:42 INFO - Starting resource monitoring. 10:54:42 INFO - ##### 10:54:42 INFO - ##### Finished create-virtualenv step (success) 10:54:42 INFO - ##### 10:54:42 INFO - ##### 10:54:42 INFO - ##### Running install step. 10:54:42 INFO - ##### 10:54:42 INFO - Running pre-action listener: _resource_record_pre_action 10:54:42 INFO - Running main action method: install 10:54:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:54:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:54:42 INFO - Reading from file tmpfile_stdout 10:54:42 INFO - Detecting whether we're running mozinstall >=1.0... 10:54:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:54:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:54:42 INFO - Reading from file tmpfile_stdout 10:54:42 INFO - Output received: 10:54:42 INFO - Usage: mozinstall [options] installer 10:54:42 INFO - Options: 10:54:42 INFO - -h, --help show this help message and exit 10:54:42 INFO - -d DEST, --destination=DEST 10:54:42 INFO - Directory to install application into. [default: 10:54:42 INFO - "/builds/slave/test"] 10:54:42 INFO - --app=APP Application being installed. [default: firefox] 10:54:42 INFO - mkdir: /builds/slave/test/build/application 10:54:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:54:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:55:17 INFO - Reading from file tmpfile_stdout 10:55:17 INFO - Output received: 10:55:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:55:17 INFO - Running post-action listener: _resource_record_post_action 10:55:17 INFO - ##### 10:55:17 INFO - ##### Finished install step (success) 10:55:17 INFO - ##### 10:55:17 INFO - ##### 10:55:17 INFO - ##### Running run-tests step. 10:55:17 INFO - ##### 10:55:17 INFO - Running pre-action listener: _resource_record_pre_action 10:55:17 INFO - Running main action method: run_tests 10:55:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:55:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:55:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:55:17 INFO - 2016-07-15 10:55:17.636 screenresolution[1651:9311] starting screenresolution argv=screenresolution get 10:55:17 INFO - 2016-07-15 10:55:17.639 screenresolution[1651:9311] Display 0: 1600x1200x32@60 10:55:17 INFO - 2016-07-15 10:55:17.645 screenresolution[1652:9313] starting screenresolution argv=screenresolution list 10:55:17 INFO - Available Modes on Display 0 10:55:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:55:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:55:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:55:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:55:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:55:17 INFO - Intel Iris: 10:55:17 INFO - Chipset Model: Intel Iris 10:55:17 INFO - Type: GPU 10:55:17 INFO - Bus: Built-In 10:55:17 INFO - VRAM (Dynamic, Max): 1536 MB 10:55:17 INFO - Vendor: Intel (0x8086) 10:55:17 INFO - Device ID: 0x0a2e 10:55:17 INFO - Revision ID: 0x0009 10:55:17 INFO - Displays: 10:55:17 INFO - Display: 10:55:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:55:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:55:17 INFO - Display Serial Number: 1600x1200 60 10:55:17 INFO - Main Display: Yes 10:55:17 INFO - Mirror: Off 10:55:17 INFO - Online: Yes 10:55:17 INFO - Rotation: Supported 10:55:17 INFO - Return code: 0 10:55:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:55:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:55:17 INFO - Python 2.7.3 10:55:17 INFO - Return code: 0 10:55:17 INFO - grabbing minidump binary from tooltool 10:55: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:17 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 0x10792fd30>, '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 0x107694db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107927b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:55:17 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 10:55:17 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 10:55:17 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 10:55:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:55:18 INFO - Return code: 0 10:55:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:55:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:55:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:55:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:55:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:55:18 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/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--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 10:55:18 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/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0078 --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 10:55:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BOoNWKAL6m/Render', 10:55:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:18 INFO - 'HOME': '/Users/cltbld', 10:55:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:18 INFO - 'LOGNAME': 'cltbld', 10:55:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:55:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:18 INFO - 'MOZ_NO_REMOTE': '1', 10:55:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:55:18 INFO - 'NO_EM_RESTART': '1', 10:55:18 INFO - 'PAGER': '/bin/cat', 10:55:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:18 INFO - 'PWD': '/builds/slave/test', 10:55:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:55:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:18 INFO - 'SHELL': '/bin/bash', 10:55:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j5VyQnbk78/Listeners', 10:55:18 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 10:55:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:18 INFO - 'USER': 'cltbld', 10:55:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:18 INFO - 'XPC_FLAGS': '0x0', 10:55:18 INFO - 'XPC_SERVICE_NAME': '0', 10:55:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:18 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/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--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 10:55:18 INFO - mozversion application_buildid: 20160713141046 10:55:18 INFO - mozversion application_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 10:55:18 INFO - mozversion application_display_name: Nightly 10:55:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:55:18 INFO - mozversion application_name: Firefox 10:55:18 INFO - mozversion application_remotingname: firefox 10:55:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:55:18 INFO - mozversion application_vendor: Mozilla 10:55:18 INFO - mozversion application_version: 50.0a1 10:55:18 INFO - mozversion platform_buildid: 20160713141046 10:55:18 INFO - mozversion platform_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 10:55:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:55:18 INFO - mozversion platform_version: 50.0a1 10:55:18 INFO - using testdate: 1468605318 10:55:18 INFO - actual date: 1468605318 10:55:18 INFO - starting webserver on 'localhost:49276' 10:55:18 INFO - SUITE-START | Running 2 tests 10:55:18 INFO - TEST-START | dromaeo_css 10:55:18 INFO - operating with platform_type : mac_ 10:55:18 INFO - Initialising browser for dromaeo_css test... 10:55:18 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpAKUO61/profile http://localhost:49276/getInfo.html) 10:55:21 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 10:55:21 INFO - PROCESS | 1662 | colorDepth:24 10:55:21 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 10:55:21 INFO - PROCESS | 1662 | __metrics 10:55:21 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 10:55:21 INFO - TEST-INFO | 1662: exit 0 10:55:21 INFO - Browser initialized. 10:55:21 INFO - Running cycle 1/1 for dromaeo_css test... 10:55:21 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpAKUO61/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:55:33 INFO - PROCESS | 1666 | RSS: Main: 254156800 10:55:33 INFO - PROCESS | 1666 | 10:56:23 INFO - PROCESS | 1666 | 1468605383601 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] 10:58:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 10:58:36 INFO - PROCESS | 1666 | RSS: Main: 268259328 10:58:36 INFO - PROCESS | 1666 | 11:01:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 11:01:39 INFO - PROCESS | 1666 | RSS: Main: 275726336 11:01:39 INFO - PROCESS | 1666 | 11:04:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 11:04:41 INFO - PROCESS | 1666 | RSS: Main: 280035328 11:04:41 INFO - PROCESS | 1666 | 11:07:43 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 11:07:44 INFO - PROCESS | 1666 | RSS: Main: 279019520 11:07:44 INFO - PROCESS | 1666 | 11:10:47 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 11:10:47 INFO - PROCESS | 1666 | RSS: Main: 282599424 11:10:47 INFO - PROCESS | 1666 | 11:13:50 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 11:13:50 INFO - PROCESS | 1666 | RSS: Main: 282755072 11:13:50 INFO - PROCESS | 1666 | 11:13:50 INFO - PROCESS | 1666 | __start_tp_report 11:13:50 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 11:13:50 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 11:13:50 INFO - PROCESS | 1666 | |i|pagename|runs| 11:13:50 INFO - PROCESS | 1666 | |0;dojo.html;3374.5444365010717;3400.897973060809;3406.897793066208;3418.7948723076634;3430.605480369757;5023.849284521461;5703.230063941367;5845.415458454152;5930.436608522189;5953.196318497013;5684.175794509804;5839.591228613988;5859.414058594139;5908.61593996391;5958.463738263556;5200.869978250536;5228;5278.1291086970605;5354.839354819362;5403.486668766481;5054.3176671149295;5287.841364759044;5323.574114070865;5408.296921400232;5516.007118718629;5175.473235395567;5234.659747116425;5267.104592219332;5326.801469669332;5358.91961620576;4217.472815898012;5343.385510666284;5364.973175134139;5375.5162035417;5389.8113566025;5204.505571970657;5301.655392399521;5313.149896016619;5340.732963351817;5349.358077030743;4418.248897687401;5788.016037273674;5885.411458854123;5894.08641660539;5920.31916329619;6187.288461826903;6221.782237621662;6228.03465462854;6232.189815323979;6245.62526248422;6150.907736383958;6163.075538669191;6203.342868248721;6263.906041409383;6272.498200143978;5953.58324917256;5995.940040599538;6025.246844144438;6028.09578563219;6067.696615169224;6352.217584919265;6384.52116091295;6391.96804015977;6408.871822563616;6419.903701444388;5483.287172667528;6103.489197737689;6153.538484613582;6251.71867265965;6261.592996455307;5120.871978200575;5354.732263386815;5918.260217472816;6236.719347629368;6277.8744425111245;6076.665783381956;6156.199694039746;6161.630302181883;6208.161898143693;6266.874662506724;5711.457411545896;5949.077892926603;6124.234470691164;6236.126942228092;6259.342769009279;5048.469910659402;5081.983603279359;5091.87270318245;5135.12702840518;5140.280360749498;3799.658030777188;4513.052259025641;4526.818927242939;4545.886352841206;4586.954130458719;5846.736896839652;5949.434803693643;5995.2206213192;6004.189434426384;6088.786892458743;6193.6903154842075;6308.779192728232;6312.5265605078885;6329.259453650283;6333.778317758856;6009.879802403927;6056.031035034373;6081.239845019372;6086.300075491286;6127.816165514952;5486.478784515464;5580.972095139498;5611.270534830446;5664.745086471119;5700.800471983461;6569.4744420447205;6570.671466426755;6570.981497867742;6572.178477690289;6589.143411356493;6248.656323902047;6285.528585356208;6308.400701933309;6314.336994615683;6320.810375688737;6232.603231239076;6413.454856337077;6460.3862633049785;6469.838254043687;6487.610743355413;6192.411720886508;6193.566450348432;6196.47329976939;6204.3795620437595;6229.875402492015;6245.6252624842655;6249.718762655601;6263.843403914756;6264.812055638338;6269.153664255267;6108.129596501795;6114.205153330038;6116.305337585956;6141.324454310112;6172;5299.258103865385;6107.206063211754;6122.969385153046;6144.201253836973;6156.353582873734;5155.355580552431;6051.515878729603;6096.237970253718;6142.416470435302;6153.538484613761;6103.337669688754;6170;6198.504119670325;6208.161898143693;6216.347283535164;6159.322474527888;6191.25704915395;6194.690265486798;6201.627902325875;6226.470749986302 11:13:50 INFO - PROCESS | 1666 | |1;ext.html;484.1720657675375;515.1294312611687;535.4431391352994;550.1939658400445;572.9770809167634;38606;41037.3844392334;41118.17763644725;41148.17703645925;41192.17615647685;41589;41800.58199418005;42291;42294.94262643436;42414.7879260604;9564.76088097798;9734.464604446752;9759.804803903917;9765.853512197322;9778.902210977905;8606.225439710424;9616.374935629161;9696;9740.610375585004;9771.973942736016;8523.701670441536;8561.229489345958;9737.221022318197;9798.804023919518;9802.264830137769;9726.465044422554;9735.70792876215;9797.118259356621;9797.559109840004;9817.214622830157;9559.187469065138;9603.4718090505;9657.46883921384;9684.225261979096;9755.365901216399;40254;40267;40394.99012524681;40554;40739;3393.173803024571;3471.8784842530645;3500.6499350065046;4022.2960981828064;4129.15352352767;31718;32436.675633243838;32545.837270813732;32789.83605081983;32801.83599082013;2954.0547024952025;3306.6197387300285;3419.8461069251944;3431.5024321473497;3472.2361080562237;512188;518779;519214;519635;521099.9999999962;51404.74297628488;59426;60008;60713;60875.08687369693;63724.044139337944;63775;64219.03671444932;64443.355566444676;64754.02868956969;16465.83534164667;16540.172991350384;16571;16602.83397166037;16682.83317166837;12830.101892867597;12849.972002239985;12882.227066376048;12956.546520871725;12972.80540791889;16001.359945602278;16098.75851862223;16114.597135071717;16155.030698157912;16199;6472.385123413268;6515.250746164157;6544.214694236722;6546.18172728409;6564.442022428051;879.1252703559999;990.6978371596588;1013.3970287678819;1041.3699711674478;1156.7859945910034;26022.73977260241;28410.289742756595;30521.847390762905;30705.078847634606;31118.688813112032;1067.1249575348295;1073.806714791345;1104.4201794058024;1119.2501024313729;1166.5767763328724;13608;14731.926340368229;16150.919245403698;16207.837921620632;16393;588470;636333;645408;654091;655777.721111401;59163.70418147882;59178;59180.40819591835;59261.70369148213;59497.40502595005;1263.5388083349694;1335.5659410691565;1412.3785534364847;1456.61399729074;1482.384810303712;30252;30327.848360758937;30645.846770766002;31031.379372411975;31125;51259.23111153261;51374;51419;51427;51537.71155721137;583150;583524;585053;585666;586747;40784.59215407808;42247.57752422559;42471.7258482246;42738;42886;45733.85665358393;49196.26205606991;49302.26046609232;50085.74957125337;50439.49560504495;40427.59572404238;40626.17182226866;40894;41265.381019284134;42212;40859;41131.76604701864;41400.37899431451;41485.377719334836;42008.529701460306;38533.614663853004;38791.80604096961;39335.803320983214;39459.802700986314;39741;33513.664863351056;33630.663693363735;35526.93419197428;35849.283014340086;35909.461358080174;25589.9764009445;25782.484350312512;25840.741592583832;26345.4730905377;26517.734822651528 11:13:50 INFO - PROCESS | 1666 | |2;jquery.html;374.65344556285436;379.1204405778593;381.8033712637992;391.17462154853274;400.5033758139907;19636.60726785465;21584;22192.8890355548;22446.66330005049;22510.3246902593;21555.892220538914;21958.780412195872;22132.467700838195;22193.334199973986;22230.666540001912;5752.28096487938;6146.84632884177;6162.661053642048;6173.722182501776;6194.101855230989;4249.46881639795;6086.939130608704;6557.540972131953;6869.107016087902;6896.103506544167;5758.913616295759;6793.286704895989;6808.183018037842;6839.247682754893;6897.3447522485285;6008.669523176223;6078.878422431549;6171.321154672983;6188.350223226564;6198.907016394758;5971.462568368825;6061.090836374535;6081.087836824468;6089.299730531001;6095.786647467317;13727.107737996997;13980.300984950814;19946.900265498578;26857.060002899805;27144.592831107548;2418.407490164921;2422.7456117107627;2435.0625009371342;2714.701382847905;3074.7540196784203;9708.417494950256;10452.68641940743;10567.524461399256;12663.30351830649;13812.1022133561;1597.728386174353;1917.3864363403716;1924.6728056230475;1930.5077205312696;1983.6627773278578;127985.36007319998;131171.03243451356;132760.00859987107;133329;133750;11514.654560363202;11718.06255499558;11744.70638234051;11782.528698852122;11815.468303926344;14400.783988240184;14716;14807.111573305421;14863.851361486462;14961.027533210307;8720.389572729975;8728.825423491622;8767.912320876838;8791.780205494913;8792.692255771017;8623.611937462829;8642.870356944652;8719.38964272495;8721.215090641872;8942.86585701215;4562.520935301812;4606.95393046072;4611.423572053493;4631.282151266559;4669;1795.9012254326137;3732.234891847165;3756.380197267475;3911.7261791674878;3976.661983731415;807.8707406814881;911.7492689510306;926.6525053105086;959.0170075672352;975.4829940131741;19053.904730476257;19670;20942.267020654202;21811.127554897943;21886.90565471752;884.8099306432838;904.421170450912;960.481340076351;996.3125443444001;998.7353351361895;10762.408067556204;11060.944695276634;11206.38364889939;11498.482568284448;11527.365994870195;483046;486627;487410;577540;582340;136090;140991;143397;144245.5575444253;145811;913.6847787513431;923.9214666753267;963.8409662405764;968.099667309409;972.3679608254549;19417.902910485358;19420.708689369952;19566.413007609794;19577.412677619694;19583.824970501817;52345.953080937405;52775.47224527859;53066;53423.931521370134;54074.72962635162;76538.6173069131;80242.1975780258;82113.76829347684;82653.78223182136;90569;7229.277072292729;7569.280918312751;7580.05249343832;7942.880856787268;8564.957175214084;9376.249900007846;13283;13611.183329000292;13893.722125557635;14089.506867259597;11343.829842552203;11541.422928853692;11578.247413918069;11657.941710291394;11738.647840564796;11291.153163512605;11351.205415620827;11384.14618903602;11459.885401145882;11521.251118677259;9508.952455237679;10472.790544189225;11717.824232636347;11940.522379105087;11960.10299227544;8369.288610467935;8371.414001020114;8528.317734581342;8569.871451928351;8576;11228.438578071227;11388.544458221579;11469.827952580885;11552.960233579019;11759.294442333487 11:13:50 INFO - PROCESS | 1666 | |3;mootools.html;1444.342824015073;1576.29854714652;1589.9682006359874;1929.151173483668;1931.5364312564989;8127.9593602032055;8677.045524992254;8704.825903481942;9121.133492318235;9157.450552966826;8784.692535761249;8839.469631822096;8983.101689831014;8989.865152022725;9003.594838232279;2337.2520793346134;2348.9060437582475;2369.087901158058;2369.18263199196;2375.3586531636447;2172.598069357166;2317.536492701458;2360.091364824538;2389.5459862626044;2430.793382562484;2385.582523058458;2393.9880300598475;2403.291029146406;2415.1546958564536;2423.9151629692965;2316.1893337331885;2355.705536807899;2366.5621859955877;2379.3456799380137;2390.1395497620842;1881.9435416937513;2061.7319748432606;2351.4003928997995;2363.976360236393;2367.266147494265;8833.337499687485;9042.457452552868;9045;9071.63713451461;9100.499472529074;5251.68489890604;5290.100682883881;5406.702631355274;5412.648177868426;5425.104857698475;3491.8952431427097;3586.4799604057525;3596.6403359664087;3669.3945498992634;3682.5396825396824;1081.2971568480473;1101.4878081691973;1107.8670559532827;1119.8432219489277;1123.8988491035846;11796.882031179664;11928.880711192951;12071.939640301742;12075.335856527887;12284.385780710929;4591.9540804591525;4675.3220782986955;4793.448753393404;4881.365422495124;4897.069556784199;10171.033751793715;10174.694759157237;10176.592936282466;10183;10196.082352588302;5333.759980800874;5352.946470535323;5360.222767698662;5364.946350536445;5386.676799392049;4407.449068866392;4738.3129446230105;4879.951200488021;4893.486183950705;4919.409670839522;3948.170884114311;3997.1006523532556;4035.455213546192;4080.204360149742;4103.097318589906;1293.140061858872;1295.151675652449;1308.7447947650116;1316.3484075382555;1317.617890811654;921.589892497832;926.2867591954158;950.5579905344048;955.694177863091;956.3687965942445;6028.969855150696;6088.391160883876;6107.175531303306;6263.248410190807;6314.810555683337;389.3828282172788;401.43598244466574;431.60508135056074;440.3043191757016;458.834819464999;3330.9500357494658;4137.358709400048;4270.893227669333;4271.31658934569;4273.423087883159;10736.57053717858;10743.301685390425;11115.888841111648;11174.44127793607;11213.66359009231;8638.91361086381;10427.322224055411;10786.622468213574;10933.398663073449;10988;7155.713771449084;7954.64204110828;8294.668213271401;8330.208630180123;8366.916330836735;6235.906461402992;6270.341614130451;6291.213598300213;6314.1160237565855;6336.334684858023;10076.798464030824;10177.643782467578;10388.948055259676;10405;10436.63471778484;10490.370577765358;10531.94734026325;10537.9473102634;10649.627263046066;10655.89344106549;7145.714171433292;7583.544987300779;7786.844263114819;7850.764477065697;7927.762167134995;8587.484750914966;8602.91397086021;8671.826563468821;8677.219050285505;8700.260477859452;7683.231676832272;7700.807479813049;7853.293203611703;7897.447178697436;7953.6818527258265;7598.35413989795;7599.848003039798;7680.769576912701;7752.14726380109;7791.64937577799;7213.098362704662;7262.092238470192;7268.418526517971;7275.890861636974;7287.708491660274;5101.821436249862;5224.190250511177;5226.608004399609;5292.576593872558;5294.867628309169;5204.869878252923;5235.748209649139;5238.76425560843;5337.119375303031;5404.702741349263 11:13:50 INFO - PROCESS | 1666 | |4;prototype.html;314.04999875376996;315.43851943540494;323.256510026938;327.7247112425562;329.20168591166413;4676.953230467694;5577.665340079598;5633.0987042073275;5815.854603634912;5914.792982245623;5619.4942455179025;5620.831375058755;5651.604387692863;5663.952168848756;5668.943310566893;3764.6047165047685;4135.710500264982;4272.547333906479;4305.160493703729;4357.520672726014;4106.589341065899;4116.58834116589;4320.105529295364;4324.675649326297;4339.566043395666;3763.9811800941093;4251.893702657443;4262.936055959148;4270;4316.762578058206;4279.893002674942;4299.441072660566;4312.22379971605;4334.869953901388;4353.585084847437;3123.048094940662;3317.5189597508224;3394.4568868980846;3478.043538027063;3744.906377340561;4884.413870335547;5086.9745651271505;5234.26720259164;5579.967705974408;5607.915881261784;4549.727016379028;4764.833230836939;4907.730074845882;4929.767558110472;4968.975155124202;4907.135288590349;5639.830805075854;6050.6369617823075;6098.786542471036;6114.816555503342;3579.2461693769865;3740.869069582579;4034.253663072341;4041.4746083009313;4072.409500622423;6254.781082662085;6311.2426508819235;6363.809085727436;6402.199725034371;6436.839079023015;3603.9819800900827;3786.3184626767447;3871.4192871069563;3876.476675648751;4126.442930204384;3990.521137463523;4142.958570414317;4152.480939882515;4178.603032711888;4180.080382315886;4321.503027151855;4508.842190523382;4826.469088400273;4918;4949.034938187019;5795.39148389413;5936.8218953430605;6110.114033465212;6134.38656134383;6148.1085242639565;1172.9003034742143;1286.7683816913045;1375.7480692569713;1382.5092092307286;1396.6159306190675;697.3688811625487;763.7517806712841;850.1880703927734;867.4535042922918;880.3397451911067;3976.741511801724;4231.032569855032;4674.883127921761;4782.832600858953;4799.616030717534;4463.888402789891;4685.601723853442;5257.395399529027;5286.788528458818;5291.788328466818;4371.868843934687;4592.10453961481;4788.976055119702;4802.159622066194;4803.471618122004;2605.788308436548;2630.7763840073426;2655;2779.63864697588;2788.776897848167;4615.838445654453;5190.754218987416;5340.439253878365;5377.1769820844365;5477.370102438191;5056.612069913167;5386.791415519619;5396.514313711785;5446.1483095747635;5507.421720719347;5072.442031376472;5401.081816091274;5429.647072940325;5454.181872719124;5469.808556700496;4714.646401519831;4883.316335712932;4988.002399520038;5279.366476022902;5299.602529810202;4807;5239.790408383622;5263.605059697752;5267.762950667153;5267.973660131828;4879.731614761222;5085.389753229636;5334.039608017588;5494.2582751329655;5496.477834605706;3603.6396360363756;3607.961501751502;3612.8554857805393;3629.149133941656;3640.2355505344176;4628.467726211529;4775.928361074656;5004.2726713940265;5019.193090487349;5877.382874798084;5481.780728770805;5794.739236734441;5910.52715782745;5932.644041357532;5987.700614969147;5263.789208532349;5970.104484327386;5997.400259973968;6002.429769171922;6018.458338749533;5558.720354990575;5564.805231816867;5857.648541087548;5865.3254875689845;5883.2057672215415;5042.319286896222;5070.518300761421;5745.805561939724;5987.982043052779;6030.698465076816;5152.4847515248175;5577;5616.371252336777;5855.707214639166;5891.793787217427 11:13:50 INFO - PROCESS | 1666 | |5;yui.html;742.6658003898245;774.1639029847765;779.1390513482598;842.4103127810527;867.3798234262503;15194.772078418833;15290.541283761477;15468.071915685066;15911;15924.522264332074;10441.321314114577;12751.744965100692;12817.102802803807;12832.743345133093;12849.678758031054;704.9471289653296;876.3339861705118;891.696823080151;916.894557125929;925.509479975614;878.3193025405299;879.2350654930219;911.6717981526646;915.1489115122966;927.6150397584994;950.2967803825154;975.1613612293422;982.9705108846711;984.478226539935;987.2052997337141;963.2005435488528;976.3507267666993;977.8044391121804;979.5543027922279;980.5979548385128;712.9786106416764;719.0903507063568;729.6825880741894;730.9451791115688;732.7362149626131;14467.56597302072;14551.78172327416;14566.344514496874;14821.40714371424;14844.332005059798;14994.400223991028;15074.773878391832;15125.621859453491;15201.847981520154;15357.232138393147;12114.697132571668;12315.753684926342;12390;12541.561045363369;12575.748485030339;3883.689304855605;3919.7452165609143;4083.652889504366;4111.773852438115;4116.115035267402;78795;118629;119671;120411.39794300972;121160;11165.050970667422;11602.94198529002;11698.47356868943;11829.408529573488;12032.27806331623;24502;24671;24748.010079596614;24790;24854.254372368858;8128;8224.958875205586;8243.587820608946;8376.623051962677;8480.151984801594;4439.334099884978;4519.932201016987;4581.083783243364;4603.654725895572;4609.95390046102;3628.600853906068;3699.7965111918566;3740.9064773380883;3749.512563366745;3754.8685795997008;687.4019602945469;688.2051230828401;692.0760784352946;692.4806395203598;702.5152644675157;664.6743095883079;685.3831551603597;696.4219697650938;696.4324075878143;699.674938555453;7664.006452223232;9310.487923164292;9608.95195524018;9696.272779541563;9726.951365243129;634.6921742954663;638.1480723234441;673.9056532085511;702.7189124350199;709.3580309819622;4566.931496027562;4658.510856360033;4664.090502352009;4711.764411779397;4773.785179666923;145117;154452;155437.44562554455;156186;158336.20831895768;116986.41506792411;129168;130791;131420;131700;91193.54403227942;110029.89970100197;112644;113329.43335283271;114928;8942.86585701202;8963.820723585623;9014.684486042957;9085.636574536944;9250;49908;64001.0399844012;64083;64146;64282.678586606766;90504.5474772622;93861;94693.5265323669;96182.51908740411;97460;12176.025917926367;12246.816297755719;12325.260484370967;12438;12446.81329780036;10726.839097413702;13045.739085218433;13368;13471.595852124452;13935.470971933959;12341.50633974631;12506.562270320495;12523.123381363217;12859;12909.741805164032;12434.738031365432;12528.561500347445;12608.684782880502;12636.936815315865;13264.46942122343;11821.113416493625;12247.262267985596;12255.625276357465;12435.191712538655;12644.683882903;9898.703038908845;10734;10796.406197659204;10975.890241097486;10990.395528245703;10469.842952355568;10567.418791966209;10598.15214782831;10630.681079567625;10635.680929572125 11:13:50 INFO - PROCESS | 1666 | __end_tp_report 11:13:50 INFO - PROCESS | 1666 | __start_cc_report 11:13:50 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,441 11:13:50 INFO - PROCESS | 1666 | __end_cc_report 11:13:50 INFO - PROCESS | 1666 | __startTimestamp1468606430488__endTimestamp 11:13:50 INFO - PROCESS | 1666 | 11:13:50 INFO - PROCESS | 1666 | ------- Summary: start ------- 11:13:50 INFO - PROCESS | 1666 | Number of tests: 6 11:13:50 INFO - PROCESS | 1666 | 11:13:50 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5798.09 Median:6086.30 stddev:667.22 (11.0%) stddev-sans-first:641.61 11:13:50 INFO - PROCESS | 1666 | Values: 3374.5 3400.9 3406.9 3418.8 3430.6 5023.8 5703.2 5845.4 5930.4 5953.2 5684.2 5839.6 5859.4 5908.6 5958.5 5200.9 5228.0 5278.1 5354.8 5403.5 5054.3 5287.8 5323.6 5408.3 5516.0 5175.5 5234.7 5267.1 5326.8 5358.9 4217.5 5343.4 5365.0 5375.5 5389.8 5204.5 5301.7 5313.1 5340.7 5349.4 4418.2 5788.0 5885.4 5894.1 5920.3 6187.3 6221.8 6228.0 6232.2 6245.6 6150.9 6163.1 6203.3 6263.9 6272.5 5953.6 5995.9 6025.2 6028.1 6067.7 6352.2 6384.5 6392.0 6408.9 6419.9 5483.3 6103.5 6153.5 6251.7 6261.6 5120.9 5354.7 5918.3 6236.7 6277.9 6076.7 6156.2 6161.6 6208.2 6266.9 5711.5 5949.1 6124.2 6236.1 6259.3 5048.5 5082.0 5091.9 5135.1 5140.3 3799.7 4513.1 4526.8 4545.9 4587.0 5846.7 5949.4 5995.2 6004.2 6088.8 6193.7 6308.8 6312.5 6329.3 6333.8 6009.9 6056.0 6081.2 6086.3 6127.8 5486.5 5581.0 5611.3 5664.7 5700.8 6569.5 6570.7 6571.0 6572.2 6589.1 6248.7 6285.5 6308.4 6314.3 6320.8 6232.6 6413.5 6460.4 6469.8 6487.6 6192.4 6193.6 6196.5 6204.4 6229.9 6245.6 6249.7 6263.8 6264.8 6269.2 6108.1 6114.2 6116.3 6141.3 6172.0 5299.3 6107.2 6123.0 6144.2 6156.4 5155.4 6051.5 6096.2 6142.4 6153.5 6103.3 6170.0 6198.5 6208.2 6216.3 6159.3 6191.3 6194.7 6201.6 6226.5 11:13:50 INFO - PROCESS | 1666 | 11:13:50 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:71894.81 Median:41442.88 stddev:155325.22 (374.8%) stddev-sans-first:155668.41 11:13:50 INFO - PROCESS | 1666 | Values: 484.2 515.1 535.4 550.2 573.0 38606.0 41037.4 41118.2 41148.2 41192.2 41589.0 41800.6 42291.0 42294.9 42414.8 9564.8 9734.5 9759.8 9765.9 9778.9 8606.2 9616.4 9696.0 9740.6 9772.0 8523.7 8561.2 9737.2 9798.8 9802.3 9726.5 9735.7 9797.1 9797.6 9817.2 9559.2 9603.5 9657.5 9684.2 9755.4 40254.0 40267.0 40395.0 40554.0 40739.0 3393.2 3471.9 3500.6 4022.3 4129.2 31718.0 32436.7 32545.8 32789.8 32801.8 2954.1 3306.6 3419.8 3431.5 3472.2 512188.0 518779.0 519214.0 519635.0 521100.0 51404.7 59426.0 60008.0 60713.0 60875.1 63724.0 63775.0 64219.0 64443.4 64754.0 16465.8 16540.2 16571.0 16602.8 16682.8 12830.1 12850.0 12882.2 12956.5 12972.8 16001.4 16098.8 16114.6 16155.0 16199.0 6472.4 6515.3 6544.2 6546.2 6564.4 879.1 990.7 1013.4 1041.4 1156.8 26022.7 28410.3 30521.8 30705.1 31118.7 1067.1 1073.8 1104.4 1119.3 1166.6 13608.0 14731.9 16150.9 16207.8 16393.0 588470.0 636333.0 645408.0 654091.0 655777.7 59163.7 59178.0 59180.4 59261.7 59497.4 1263.5 1335.6 1412.4 1456.6 1482.4 30252.0 30327.8 30645.8 31031.4 31125.0 51259.2 51374.0 51419.0 51427.0 51537.7 583150.0 583524.0 585053.0 585666.0 586747.0 40784.6 42247.6 42471.7 42738.0 42886.0 45733.9 49196.3 49302.3 50085.7 50439.5 40427.6 40626.2 40894.0 41265.4 42212.0 40859.0 41131.8 41400.4 41485.4 42008.5 38533.6 38791.8 39335.8 39459.8 39741.0 33513.7 33630.7 35526.9 35849.3 35909.5 25590.0 25782.5 25840.7 26345.5 26517.7 11:13:50 INFO - PROCESS | 1666 | 11:13:50 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:34031.00 Median:2067.75 stddev:89324.92 (4319.9%) stddev-sans-first:89539.75 11:13:50 INFO - PROCESS | 1666 | Values: 374.7 379.1 381.8 391.2 400.5 19636.6 21584.0 22192.9 22446.7 22510.3 21555.9 21958.8 22132.5 22193.3 22230.7 5752.3 6146.8 6162.7 6173.7 6194.1 4249.5 6086.9 6557.5 6869.1 6896.1 5758.9 6793.3 6808.2 6839.2 6897.3 6008.7 6078.9 6171.3 6188.4 6198.9 5971.5 6061.1 6081.1 6089.3 6095.8 13727.1 13980.3 19946.9 26857.1 27144.6 2418.4 2422.7 2435.1 2714.7 3074.8 9708.4 10452.7 10567.5 12663.3 13812.1 1597.7 1917.4 1924.7 1930.5 1983.7 127985.4 131171.0 132760.0 133329.0 133750.0 11514.7 11718.1 11744.7 11782.5 11815.5 14400.8 14716.0 14807.1 14863.9 14961.0 8720.4 8728.8 8767.9 8791.8 8792.7 8623.6 8642.9 8719.4 8721.2 8942.9 4562.5 4607.0 4611.4 4631.3 4669.0 1795.9 3732.2 3756.4 3911.7 3976.7 807.9 911.7 926.7 959.0 975.5 19053.9 19670.0 20942.3 21811.1 21886.9 884.8 904.4 960.5 996.3 998.7 10762.4 11060.9 11206.4 11498.5 11527.4 483046.0 486627.0 487410.0 577540.0 582340.0 136090.0 140991.0 143397.0 144245.6 145811.0 913.7 923.9 963.8 968.1 972.4 19417.9 19420.7 19566.4 19577.4 19583.8 52346.0 52775.5 53066.0 53423.9 54074.7 76538.6 80242.2 82113.8 82653.8 90569.0 7229.3 7569.3 7580.1 7942.9 8565.0 9376.2 13283.0 13611.2 13893.7 14089.5 11343.8 11541.4 11578.2 11657.9 11738.6 11291.2 11351.2 11384.1 11459.9 11521.3 9509.0 10472.8 11717.8 11940.5 11960.1 8369.3 8371.4 8528.3 8569.9 8576.0 11228.4 11388.5 11469.8 11553.0 11759.3 11:13:50 INFO - PROCESS | 1666 | 11:13:50 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5840.83 Median:4633.64 stddev:3307.43 (71.4%) stddev-sans-first:3300.20 11:13:50 INFO - PROCESS | 1666 | Values: 1444.3 1576.3 1590.0 1929.2 1931.5 8128.0 8677.0 8704.8 9121.1 9157.5 8784.7 8839.5 8983.1 8989.9 9003.6 2337.3 2348.9 2369.1 2369.2 2375.4 2172.6 2317.5 2360.1 2389.5 2430.8 2385.6 2394.0 2403.3 2415.2 2423.9 2316.2 2355.7 2366.6 2379.3 2390.1 1881.9 2061.7 2351.4 2364.0 2367.3 8833.3 9042.5 9045.0 9071.6 9100.5 5251.7 5290.1 5406.7 5412.6 5425.1 3491.9 3586.5 3596.6 3669.4 3682.5 1081.3 1101.5 1107.9 1119.8 1123.9 11796.9 11928.9 12071.9 12075.3 12284.4 4592.0 4675.3 4793.4 4881.4 4897.1 10171.0 10174.7 10176.6 10183.0 10196.1 5333.8 5352.9 5360.2 5364.9 5386.7 4407.4 4738.3 4880.0 4893.5 4919.4 3948.2 3997.1 4035.5 4080.2 4103.1 1293.1 1295.2 1308.7 1316.3 1317.6 921.6 926.3 950.6 955.7 956.4 6029.0 6088.4 6107.2 6263.2 6314.8 389.4 401.4 431.6 440.3 458.8 3331.0 4137.4 4270.9 4271.3 4273.4 10736.6 10743.3 11115.9 11174.4 11213.7 8638.9 10427.3 10786.6 10933.4 10988.0 7155.7 7954.6 8294.7 8330.2 8366.9 6235.9 6270.3 6291.2 6314.1 6336.3 10076.8 10177.6 10388.9 10405.0 10436.6 10490.4 10531.9 10537.9 10649.6 10655.9 7145.7 7583.5 7786.8 7850.8 7927.8 8587.5 8602.9 8671.8 8677.2 8700.3 7683.2 7700.8 7853.3 7897.4 7953.7 7598.4 7599.8 7680.8 7752.1 7791.6 7213.1 7262.1 7268.4 7275.9 7287.7 5101.8 5224.2 5226.6 5292.6 5294.9 5204.9 5235.7 5238.8 5337.1 5404.7 11:13:50 INFO - PROCESS | 1666 | 11:13:50 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4563.59 Median:4959.01 stddev:1411.38 (28.5%) stddev-sans-first:1378.83 11:13:50 INFO - PROCESS | 1666 | Values: 314.0 315.4 323.3 327.7 329.2 4677.0 5577.7 5633.1 5815.9 5914.8 5619.5 5620.8 5651.6 5664.0 5668.9 3764.6 4135.7 4272.5 4305.2 4357.5 4106.6 4116.6 4320.1 4324.7 4339.6 3764.0 4251.9 4262.9 4270.0 4316.8 4279.9 4299.4 4312.2 4334.9 4353.6 3123.0 3317.5 3394.5 3478.0 3744.9 4884.4 5087.0 5234.3 5580.0 5607.9 4549.7 4764.8 4907.7 4929.8 4969.0 4907.1 5639.8 6050.6 6098.8 6114.8 3579.2 3740.9 4034.3 4041.5 4072.4 6254.8 6311.2 6363.8 6402.2 6436.8 3604.0 3786.3 3871.4 3876.5 4126.4 3990.5 4143.0 4152.5 4178.6 4180.1 4321.5 4508.8 4826.5 4918.0 4949.0 5795.4 5936.8 6110.1 6134.4 6148.1 1172.9 1286.8 1375.7 1382.5 1396.6 697.4 763.8 850.2 867.5 880.3 3976.7 4231.0 4674.9 4782.8 4799.6 4463.9 4685.6 5257.4 5286.8 5291.8 4371.9 4592.1 4789.0 4802.2 4803.5 2605.8 2630.8 2655.0 2779.6 2788.8 4615.8 5190.8 5340.4 5377.2 5477.4 5056.6 5386.8 5396.5 5446.1 5507.4 5072.4 5401.1 5429.6 5454.2 5469.8 4714.6 4883.3 4988.0 5279.4 5299.6 4807.0 5239.8 5263.6 5267.8 5268.0 4879.7 5085.4 5334.0 5494.3 5496.5 3603.6 3608.0 3612.9 3629.1 3640.2 4628.5 4775.9 5004.3 5019.2 5877.4 5481.8 5794.7 5910.5 5932.6 5987.7 5263.8 5970.1 5997.4 6002.4 6018.5 5558.7 5564.8 5857.6 5865.3 5883.2 5042.3 5070.5 5745.8 5988.0 6030.7 5152.5 5577.0 5616.4 5855.7 5891.8 11:13:50 INFO - PROCESS | 1666 | 11:13:50 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:24979.64 Median:3752.19 stddev:40269.96 (1073.2%) stddev-sans-first:40341.81 11:13:50 INFO - PROCESS | 1666 | Values: 742.7 774.2 779.1 842.4 867.4 15194.8 15290.5 15468.1 15911.0 15924.5 10441.3 12751.7 12817.1 12832.7 12849.7 704.9 876.3 891.7 916.9 925.5 878.3 879.2 911.7 915.1 927.6 950.3 975.2 983.0 984.5 987.2 963.2 976.4 977.8 979.6 980.6 713.0 719.1 729.7 730.9 732.7 14467.6 14551.8 14566.3 14821.4 14844.3 14994.4 15074.8 15125.6 15201.8 15357.2 12114.7 12315.8 12390.0 12541.6 12575.7 3883.7 3919.7 4083.7 4111.8 4116.1 78795.0 118629.0 119671.0 120411.4 121160.0 11165.1 11602.9 11698.5 11829.4 12032.3 24502.0 24671.0 24748.0 24790.0 24854.3 8128.0 8225.0 8243.6 8376.6 8480.2 4439.3 4519.9 4581.1 4603.7 4610.0 3628.6 3699.8 3740.9 3749.5 3754.9 687.4 688.2 692.1 692.5 702.5 664.7 685.4 696.4 696.4 699.7 7664.0 9310.5 9609.0 9696.3 9727.0 634.7 638.1 673.9 702.7 709.4 4566.9 4658.5 4664.1 4711.8 4773.8 145117.0 154452.0 155437.4 156186.0 158336.2 116986.4 129168.0 130791.0 131420.0 131700.0 91193.5 110029.9 112644.0 113329.4 114928.0 8942.9 8963.8 9014.7 9085.6 9250.0 49908.0 64001.0 64083.0 64146.0 64282.7 90504.5 93861.0 94693.5 96182.5 97460.0 12176.0 12246.8 12325.3 12438.0 12446.8 10726.8 13045.7 13368.0 13471.6 13935.5 12341.5 12506.6 12523.1 12859.0 12909.7 12434.7 12528.6 12608.7 12636.9 13264.5 11821.1 12247.3 12255.6 12435.2 12644.7 9898.7 10734.0 10796.4 10975.9 10990.4 10469.8 10567.4 10598.2 10630.7 10635.7 11:13:50 INFO - PROCESS | 1666 | -------- Summary: end -------- 11:13:50 INFO - PROCESS | 1666 | 11:13:51 INFO - TEST-INFO | 1666: exit 0 11:13:51 INFO - TEST-OK | dromaeo_css | took 1112855ms 11:13:51 INFO - TEST-START | kraken 11:13:51 INFO - operating with platform_type : mac_ 11:13:51 INFO - Initialising browser for kraken test... 11:13:51 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmp9I_dsY/profile http://localhost:49276/getInfo.html) 11:13:54 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 11:13:54 INFO - PROCESS | 1674 | colorDepth:24 11:13:54 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 11:13:54 INFO - PROCESS | 1674 | __metrics 11:13:54 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 11:13:54 INFO - TEST-INFO | 1674: exit 0 11:13:54 INFO - Browser initialized. 11:13:54 INFO - Running cycle 1/1 for kraken test... 11:13:54 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmp9I_dsY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:06 INFO - PROCESS | 1676 | RSS: Main: 254218240 11:14:06 INFO - PROCESS | 1676 | 11:14:09 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 11:14:10 INFO - PROCESS | 1676 | RSS: Main: 267182080 11:14:10 INFO - PROCESS | 1676 | 11:14:13 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 11:14:13 INFO - PROCESS | 1676 | RSS: Main: 271204352 11:14:13 INFO - PROCESS | 1676 | 11:14:17 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 11:14:17 INFO - PROCESS | 1676 | RSS: Main: 271339520 11:14:17 INFO - PROCESS | 1676 | 11:14:19 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 11:14:20 INFO - PROCESS | 1676 | RSS: Main: 272375808 11:14:20 INFO - PROCESS | 1676 | 11:14:22 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:14:23 INFO - PROCESS | 1676 | RSS: Main: 273158144 11:14:23 INFO - PROCESS | 1676 | 11:14:26 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 11:14:26 INFO - PROCESS | 1676 | RSS: Main: 273678336 11:14:26 INFO - PROCESS | 1676 | 11:14:29 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 11:14:30 INFO - PROCESS | 1676 | RSS: Main: 273977344 11:14:30 INFO - PROCESS | 1676 | 11:14:33 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 11:14:33 INFO - PROCESS | 1676 | RSS: Main: 274264064 11:14:33 INFO - PROCESS | 1676 | 11:14:35 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:14:36 INFO - PROCESS | 1676 | RSS: Main: 273776640 11:14:36 INFO - PROCESS | 1676 | 11:14:38 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:14:38 INFO - PROCESS | 1676 | RSS: Main: 273596416 11:14:38 INFO - PROCESS | 1676 | 11:14:41 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:14:41 INFO - PROCESS | 1676 | RSS: Main: 273936384 11:14:41 INFO - PROCESS | 1676 | 11:14:44 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:14:45 INFO - PROCESS | 1676 | RSS: Main: 274075648 11:14:45 INFO - PROCESS | 1676 | 11:14:48 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:14:48 INFO - PROCESS | 1676 | RSS: Main: 274223104 11:14:48 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 11:14:50 INFO - PROCESS | 1676 | RSS: Main: 275070976 11:14:50 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | __start_tp_report 11:14:50 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 11:14:50 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 11:14:50 INFO - PROCESS | 1676 | |i|pagename|runs| 11:14:50 INFO - PROCESS | 1676 | |0;ai-astar;104;119;122;170;122;117;113;118;116;118 11:14:50 INFO - PROCESS | 1676 | |1;audio-beat-detection;142;109;132;157;112;131;133;141;170;111 11:14:50 INFO - PROCESS | 1676 | |2;audio-dft;198;200;199;206;228;192;196;205;273;189 11:14:50 INFO - PROCESS | 1676 | |3;audio-fft;71;83;76;145;82;80;66;63;139;72 11:14:50 INFO - PROCESS | 1676 | |4;audio-oscillator;71;72;127;56;92;107;101;100;100;146 11:14:50 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;89;87;80;86;78;125;90;92;89;85 11:14:50 INFO - PROCESS | 1676 | |6;imaging-darkroom;94;94;96;97;95;95;104;130;95;95 11:14:50 INFO - PROCESS | 1676 | |7;imaging-desaturate;90;94;95;142;96;143;131;91;94;132 11:14:50 INFO - PROCESS | 1676 | |8;json-parse-financial;56;54;55;57;57;59;57;57;56;57 11:14:50 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;68;72;64;108;106;117;85;71;71;74 11:14:50 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;85;100;102;86;86;83;85;85;93;103 11:14:50 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;135;140;137;137;140;140;147;145;234;155 11:14:50 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;169;174;220;173;171;164;166;172;168;170 11:14:50 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;66;68;71;67;70;81;78;66;66;71 11:14:50 INFO - PROCESS | 1676 | __end_tp_report 11:14:50 INFO - PROCESS | 1676 | __start_cc_report 11:14:50 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1124 11:14:50 INFO - PROCESS | 1676 | __end_cc_report 11:14:50 INFO - PROCESS | 1676 | __startTimestamp1468606490850__endTimestamp 11:14:50 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | ------- Summary: start ------- 11:14:50 INFO - PROCESS | 1676 | Number of tests: 14 11:14:50 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:121.90 Median:118.50 stddev:17.67 (14.9%) stddev-sans-first:17.52 11:14:50 INFO - PROCESS | 1676 | Values: 104.0 119.0 122.0 170.0 122.0 117.0 113.0 118.0 116.0 118.0 11:14:50 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:137.00 stddev:19.97 (14.6%) stddev-sans-first:20.96 11:14:50 INFO - PROCESS | 1676 | Values: 142.0 109.0 132.0 157.0 112.0 131.0 133.0 141.0 170.0 111.0 11:14:50 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:208.60 Median:202.50 stddev:25.03 (12.4%) stddev-sans-first:26.26 11:14:50 INFO - PROCESS | 1676 | Values: 198.0 200.0 199.0 206.0 228.0 192.0 196.0 205.0 273.0 189.0 11:14:50 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:87.70 Median:74.00 stddev:29.39 (39.7%) stddev-sans-first:30.54 11:14:50 INFO - PROCESS | 1676 | Values: 71.0 83.0 76.0 145.0 82.0 80.0 66.0 63.0 139.0 72.0 11:14:50 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:101.00 stddev:26.75 (26.5%) stddev-sans-first:26.64 11:14:50 INFO - PROCESS | 1676 | Values: 71.0 72.0 127.0 56.0 92.0 107.0 101.0 100.0 100.0 146.0 11:14:50 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:88.00 stddev:13.02 (14.8%) stddev-sans-first:13.80 11:14:50 INFO - PROCESS | 1676 | Values: 89.0 87.0 80.0 86.0 78.0 125.0 90.0 92.0 89.0 85.0 11:14:50 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:95.00 stddev:11.11 (11.7%) stddev-sans-first:11.60 11:14:50 INFO - PROCESS | 1676 | Values: 94.0 94.0 96.0 97.0 95.0 95.0 104.0 130.0 95.0 95.0 11:14:50 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:110.80 Median:92.50 stddev:22.91 (24.8%) stddev-sans-first:23.03 11:14:50 INFO - PROCESS | 1676 | Values: 90.0 94.0 95.0 142.0 96.0 143.0 131.0 91.0 94.0 132.0 11:14:50 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:1.35 (2.4%) stddev-sans-first:1.42 11:14:50 INFO - PROCESS | 1676 | Values: 56.0 54.0 55.0 57.0 57.0 59.0 57.0 57.0 56.0 57.0 11:14:50 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:83.60 Median:71.00 stddev:19.40 (27.3%) stddev-sans-first:19.74 11:14:50 INFO - PROCESS | 1676 | Values: 68.0 72.0 64.0 108.0 106.0 117.0 85.0 71.0 71.0 74.0 11:14:50 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:85.00 stddev:7.97 (9.4%) stddev-sans-first:8.17 11:14:50 INFO - PROCESS | 1676 | Values: 85.0 100.0 102.0 86.0 86.0 83.0 85.0 85.0 93.0 103.0 11:14:50 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:151.00 Median:142.50 stddev:29.75 (20.9%) stddev-sans-first:30.99 11:14:50 INFO - PROCESS | 1676 | Values: 135.0 140.0 137.0 137.0 140.0 140.0 147.0 145.0 234.0 155.0 11:14:50 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:171.50 stddev:16.21 (9.5%) stddev-sans-first:17.07 11:14:50 INFO - PROCESS | 1676 | Values: 169.0 174.0 220.0 173.0 171.0 164.0 166.0 172.0 168.0 170.0 11:14:50 INFO - PROCESS | 1676 | 11:14:50 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:5.23 (7.4%) stddev-sans-first:5.30 11:14:50 INFO - PROCESS | 1676 | Values: 66.0 68.0 71.0 67.0 70.0 81.0 78.0 66.0 66.0 71.0 11:14:50 INFO - PROCESS | 1676 | -------- Summary: end -------- 11:14:50 INFO - PROCESS | 1676 | 11:14:51 INFO - TEST-INFO | 1676: exit 0 11:14:51 INFO - TEST-OK | kraken | took 60569ms 11:14:51 INFO - SUITE-END | took 1173s 11:14:52 INFO - Completed test suite (00:19:33) 11:14:52 INFO - javascript benchmark 11:14:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7485.498468185745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3374.5444365010717, 3400.897973060809, 3406.897793066208, 3418.7948723076634, 3430.605480369757, 5023.849284521461, 5703.230063941367, 5845.415458454152, 5930.436608522189, 5953.196318497013, 5684.175794509804, 5839.591228613988, 5859.414058594139, 5908.61593996391, 5958.463738263556, 5200.869978250536, 5228.0, 5278.1291086970605, 5354.839354819362, 5403.486668766481, 5054.3176671149295, 5287.841364759044, 5323.574114070865, 5408.296921400232, 5516.007118718629, 5175.473235395567, 5234.659747116425, 5267.104592219332, 5326.801469669332, 5358.91961620576, 4217.472815898012, 5343.385510666284, 5364.973175134139, 5375.5162035417, 5389.8113566025, 5204.505571970657, 5301.655392399521, 5313.149896016619, 5340.732963351817, 5349.358077030743, 4418.248897687401, 5788.016037273674, 5885.411458854123, 5894.08641660539, 5920.31916329619, 6187.288461826903, 6221.782237621662, 6228.03465462854, 6232.189815323979, 6245.62526248422, 6150.907736383958, 6163.075538669191, 6203.342868248721, 6263.906041409383, 6272.498200143978, 5953.58324917256, 5995.940040599538, 6025.246844144438, 6028.09578563219, 6067.696615169224, 6352.217584919265, 6384.52116091295, 6391.96804015977, 6408.871822563616, 6419.903701444388, 5483.287172667528, 6103.489197737689, 6153.538484613582, 6251.71867265965, 6261.592996455307, 5120.871978200575, 5354.732263386815, 5918.260217472816, 6236.719347629368, 6277.8744425111245, 6076.665783381956, 6156.199694039746, 6161.630302181883, 6208.161898143693, 6266.874662506724, 5711.457411545896, 5949.077892926603, 6124.234470691164, 6236.126942228092, 6259.342769009279, 5048.469910659402, 5081.983603279359, 5091.87270318245, 5135.12702840518, 5140.280360749498, 3799.658030777188, 4513.052259025641, 4526.818927242939, 4545.886352841206, 4586.954130458719, 5846.736896839652, 5949.434803693643, 5995.2206213192, 6004.189434426384, 6088.786892458743, 6193.6903154842075, 6308.779192728232, 6312.5265605078885, 6329.259453650283, 6333.778317758856, 6009.879802403927, 6056.031035034373, 6081.239845019372, 6086.300075491286, 6127.816165514952, 5486.478784515464, 5580.972095139498, 5611.270534830446, 5664.745086471119, 5700.800471983461, 6569.4744420447205, 6570.671466426755, 6570.981497867742, 6572.178477690289, 6589.143411356493, 6248.656323902047, 6285.528585356208, 6308.400701933309, 6314.336994615683, 6320.810375688737, 6232.603231239076, 6413.454856337077, 6460.3862633049785, 6469.838254043687, 6487.610743355413, 6192.411720886508, 6193.566450348432, 6196.47329976939, 6204.3795620437595, 6229.875402492015, 6245.6252624842655, 6249.718762655601, 6263.843403914756, 6264.812055638338, 6269.153664255267, 6108.129596501795, 6114.205153330038, 6116.305337585956, 6141.324454310112, 6172.0, 5299.258103865385, 6107.206063211754, 6122.969385153046, 6144.201253836973, 6156.353582873734, 5155.355580552431, 6051.515878729603, 6096.237970253718, 6142.416470435302, 6153.538484613761, 6103.337669688754, 6170.0, 6198.504119670325, 6208.161898143693, 6216.347283535164, 6159.322474527888, 6191.25704915395, 6194.690265486798, 6201.627902325875, 6226.470749986302], "value": 5756.934837846681, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.1720657675375, 515.1294312611687, 535.4431391352994, 550.1939658400445, 572.9770809167634, 38606.0, 41037.3844392334, 41118.17763644725, 41148.17703645925, 41192.17615647685, 41589.0, 41800.58199418005, 42291.0, 42294.94262643436, 42414.7879260604, 9564.76088097798, 9734.464604446752, 9759.804803903917, 9765.853512197322, 9778.902210977905, 8606.225439710424, 9616.374935629161, 9696.0, 9740.610375585004, 9771.973942736016, 8523.701670441536, 8561.229489345958, 9737.221022318197, 9798.804023919518, 9802.264830137769, 9726.465044422554, 9735.70792876215, 9797.118259356621, 9797.559109840004, 9817.214622830157, 9559.187469065138, 9603.4718090505, 9657.46883921384, 9684.225261979096, 9755.365901216399, 40254.0, 40267.0, 40394.99012524681, 40554.0, 40739.0, 3393.173803024571, 3471.8784842530645, 3500.6499350065046, 4022.2960981828064, 4129.15352352767, 31718.0, 32436.675633243838, 32545.837270813732, 32789.83605081983, 32801.83599082013, 2954.0547024952025, 3306.6197387300285, 3419.8461069251944, 3431.5024321473497, 3472.2361080562237, 512188.0, 518779.0, 519214.0, 519635.0, 521099.9999999962, 51404.74297628488, 59426.0, 60008.0, 60713.0, 60875.08687369693, 63724.044139337944, 63775.0, 64219.03671444932, 64443.355566444676, 64754.02868956969, 16465.83534164667, 16540.172991350384, 16571.0, 16602.83397166037, 16682.83317166837, 12830.101892867597, 12849.972002239985, 12882.227066376048, 12956.546520871725, 12972.80540791889, 16001.359945602278, 16098.75851862223, 16114.597135071717, 16155.030698157912, 16199.0, 6472.385123413268, 6515.250746164157, 6544.214694236722, 6546.18172728409, 6564.442022428051, 879.1252703559999, 990.6978371596588, 1013.3970287678819, 1041.3699711674478, 1156.7859945910034, 26022.73977260241, 28410.289742756595, 30521.847390762905, 30705.078847634606, 31118.688813112032, 1067.1249575348295, 1073.806714791345, 1104.4201794058024, 1119.2501024313729, 1166.5767763328724, 13608.0, 14731.926340368229, 16150.919245403698, 16207.837921620632, 16393.0, 588470.0, 636333.0, 645408.0, 654091.0, 655777.721111401, 59163.70418147882, 59178.0, 59180.40819591835, 59261.70369148213, 59497.40502595005, 1263.5388083349694, 1335.5659410691565, 1412.3785534364847, 1456.61399729074, 1482.384810303712, 30252.0, 30327.848360758937, 30645.846770766002, 31031.379372411975, 31125.0, 51259.23111153261, 51374.0, 51419.0, 51427.0, 51537.71155721137, 583150.0, 583524.0, 585053.0, 585666.0, 586747.0, 40784.59215407808, 42247.57752422559, 42471.7258482246, 42738.0, 42886.0, 45733.85665358393, 49196.26205606991, 49302.26046609232, 50085.74957125337, 50439.49560504495, 40427.59572404238, 40626.17182226866, 40894.0, 41265.381019284134, 42212.0, 40859.0, 41131.76604701864, 41400.37899431451, 41485.377719334836, 42008.529701460306, 38533.614663853004, 38791.80604096961, 39335.803320983214, 39459.802700986314, 39741.0, 33513.664863351056, 33630.663693363735, 35526.93419197428, 35849.283014340086, 35909.461358080174, 25589.9764009445, 25782.484350312512, 25840.741592583832, 26345.4730905377, 26517.734822651528], "value": 20474.079908086354, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.65344556285436, 379.1204405778593, 381.8033712637992, 391.17462154853274, 400.5033758139907, 19636.60726785465, 21584.0, 22192.8890355548, 22446.66330005049, 22510.3246902593, 21555.892220538914, 21958.780412195872, 22132.467700838195, 22193.334199973986, 22230.666540001912, 5752.28096487938, 6146.84632884177, 6162.661053642048, 6173.722182501776, 6194.101855230989, 4249.46881639795, 6086.939130608704, 6557.540972131953, 6869.107016087902, 6896.103506544167, 5758.913616295759, 6793.286704895989, 6808.183018037842, 6839.247682754893, 6897.3447522485285, 6008.669523176223, 6078.878422431549, 6171.321154672983, 6188.350223226564, 6198.907016394758, 5971.462568368825, 6061.090836374535, 6081.087836824468, 6089.299730531001, 6095.786647467317, 13727.107737996997, 13980.300984950814, 19946.900265498578, 26857.060002899805, 27144.592831107548, 2418.407490164921, 2422.7456117107627, 2435.0625009371342, 2714.701382847905, 3074.7540196784203, 9708.417494950256, 10452.68641940743, 10567.524461399256, 12663.30351830649, 13812.1022133561, 1597.728386174353, 1917.3864363403716, 1924.6728056230475, 1930.5077205312696, 1983.6627773278578, 127985.36007319998, 131171.03243451356, 132760.00859987107, 133329.0, 133750.0, 11514.654560363202, 11718.06255499558, 11744.70638234051, 11782.528698852122, 11815.468303926344, 14400.783988240184, 14716.0, 14807.111573305421, 14863.851361486462, 14961.027533210307, 8720.389572729975, 8728.825423491622, 8767.912320876838, 8791.780205494913, 8792.692255771017, 8623.611937462829, 8642.870356944652, 8719.38964272495, 8721.215090641872, 8942.86585701215, 4562.520935301812, 4606.95393046072, 4611.423572053493, 4631.282151266559, 4669.0, 1795.9012254326137, 3732.234891847165, 3756.380197267475, 3911.7261791674878, 3976.661983731415, 807.8707406814881, 911.7492689510306, 926.6525053105086, 959.0170075672352, 975.4829940131741, 19053.904730476257, 19670.0, 20942.267020654202, 21811.127554897943, 21886.90565471752, 884.8099306432838, 904.421170450912, 960.481340076351, 996.3125443444001, 998.7353351361895, 10762.408067556204, 11060.944695276634, 11206.38364889939, 11498.482568284448, 11527.365994870195, 483046.0, 486627.0, 487410.0, 577540.0, 582340.0, 136090.0, 140991.0, 143397.0, 144245.5575444253, 145811.0, 913.6847787513431, 923.9214666753267, 963.8409662405764, 968.099667309409, 972.3679608254549, 19417.902910485358, 19420.708689369952, 19566.413007609794, 19577.412677619694, 19583.824970501817, 52345.953080937405, 52775.47224527859, 53066.0, 53423.931521370134, 54074.72962635162, 76538.6173069131, 80242.1975780258, 82113.76829347684, 82653.78223182136, 90569.0, 7229.277072292729, 7569.280918312751, 7580.05249343832, 7942.880856787268, 8564.957175214084, 9376.249900007846, 13283.0, 13611.183329000292, 13893.722125557635, 14089.506867259597, 11343.829842552203, 11541.422928853692, 11578.247413918069, 11657.941710291394, 11738.647840564796, 11291.153163512605, 11351.205415620827, 11384.14618903602, 11459.885401145882, 11521.251118677259, 9508.952455237679, 10472.790544189225, 11717.824232636347, 11940.522379105087, 11960.10299227544, 8369.288610467935, 8371.414001020114, 8528.317734581342, 8569.871451928351, 8576.0, 11228.438578071227, 11388.544458221579, 11469.827952580885, 11552.960233579019, 11759.294442333487], "value": 9978.22362014098, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1444.342824015073, 1576.29854714652, 1589.9682006359874, 1929.151173483668, 1931.5364312564989, 8127.9593602032055, 8677.045524992254, 8704.825903481942, 9121.133492318235, 9157.450552966826, 8784.692535761249, 8839.469631822096, 8983.101689831014, 8989.865152022725, 9003.594838232279, 2337.2520793346134, 2348.9060437582475, 2369.087901158058, 2369.18263199196, 2375.3586531636447, 2172.598069357166, 2317.536492701458, 2360.091364824538, 2389.5459862626044, 2430.793382562484, 2385.582523058458, 2393.9880300598475, 2403.291029146406, 2415.1546958564536, 2423.9151629692965, 2316.1893337331885, 2355.705536807899, 2366.5621859955877, 2379.3456799380137, 2390.1395497620842, 1881.9435416937513, 2061.7319748432606, 2351.4003928997995, 2363.976360236393, 2367.266147494265, 8833.337499687485, 9042.457452552868, 9045.0, 9071.63713451461, 9100.499472529074, 5251.68489890604, 5290.100682883881, 5406.702631355274, 5412.648177868426, 5425.104857698475, 3491.8952431427097, 3586.4799604057525, 3596.6403359664087, 3669.3945498992634, 3682.5396825396824, 1081.2971568480473, 1101.4878081691973, 1107.8670559532827, 1119.8432219489277, 1123.8988491035846, 11796.882031179664, 11928.880711192951, 12071.939640301742, 12075.335856527887, 12284.385780710929, 4591.9540804591525, 4675.3220782986955, 4793.448753393404, 4881.365422495124, 4897.069556784199, 10171.033751793715, 10174.694759157237, 10176.592936282466, 10183.0, 10196.082352588302, 5333.759980800874, 5352.946470535323, 5360.222767698662, 5364.946350536445, 5386.676799392049, 4407.449068866392, 4738.3129446230105, 4879.951200488021, 4893.486183950705, 4919.409670839522, 3948.170884114311, 3997.1006523532556, 4035.455213546192, 4080.204360149742, 4103.097318589906, 1293.140061858872, 1295.151675652449, 1308.7447947650116, 1316.3484075382555, 1317.617890811654, 921.589892497832, 926.2867591954158, 950.5579905344048, 955.694177863091, 956.3687965942445, 6028.969855150696, 6088.391160883876, 6107.175531303306, 6263.248410190807, 6314.810555683337, 389.3828282172788, 401.43598244466574, 431.60508135056074, 440.3043191757016, 458.834819464999, 3330.9500357494658, 4137.358709400048, 4270.893227669333, 4271.31658934569, 4273.423087883159, 10736.57053717858, 10743.301685390425, 11115.888841111648, 11174.44127793607, 11213.66359009231, 8638.91361086381, 10427.322224055411, 10786.622468213574, 10933.398663073449, 10988.0, 7155.713771449084, 7954.64204110828, 8294.668213271401, 8330.208630180123, 8366.916330836735, 6235.906461402992, 6270.341614130451, 6291.213598300213, 6314.1160237565855, 6336.334684858023, 10076.798464030824, 10177.643782467578, 10388.948055259676, 10405.0, 10436.63471778484, 10490.370577765358, 10531.94734026325, 10537.9473102634, 10649.627263046066, 10655.89344106549, 7145.714171433292, 7583.544987300779, 7786.844263114819, 7850.764477065697, 7927.762167134995, 8587.484750914966, 8602.91397086021, 8671.826563468821, 8677.219050285505, 8700.260477859452, 7683.231676832272, 7700.807479813049, 7853.293203611703, 7897.447178697436, 7953.6818527258265, 7598.35413989795, 7599.848003039798, 7680.769576912701, 7752.14726380109, 7791.64937577799, 7213.098362704662, 7262.092238470192, 7268.418526517971, 7275.890861636974, 7287.708491660274, 5101.821436249862, 5224.190250511177, 5226.608004399609, 5292.576593872558, 5294.867628309169, 5204.869878252923, 5235.748209649139, 5238.76425560843, 5337.119375303031, 5404.702741349263], "value": 4594.502028716816, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.04999875376996, 315.43851943540494, 323.256510026938, 327.7247112425562, 329.20168591166413, 4676.953230467694, 5577.665340079598, 5633.0987042073275, 5815.854603634912, 5914.792982245623, 5619.4942455179025, 5620.831375058755, 5651.604387692863, 5663.952168848756, 5668.943310566893, 3764.6047165047685, 4135.710500264982, 4272.547333906479, 4305.160493703729, 4357.520672726014, 4106.589341065899, 4116.58834116589, 4320.105529295364, 4324.675649326297, 4339.566043395666, 3763.9811800941093, 4251.893702657443, 4262.936055959148, 4270.0, 4316.762578058206, 4279.893002674942, 4299.441072660566, 4312.22379971605, 4334.869953901388, 4353.585084847437, 3123.048094940662, 3317.5189597508224, 3394.4568868980846, 3478.043538027063, 3744.906377340561, 4884.413870335547, 5086.9745651271505, 5234.26720259164, 5579.967705974408, 5607.915881261784, 4549.727016379028, 4764.833230836939, 4907.730074845882, 4929.767558110472, 4968.975155124202, 4907.135288590349, 5639.830805075854, 6050.6369617823075, 6098.786542471036, 6114.816555503342, 3579.2461693769865, 3740.869069582579, 4034.253663072341, 4041.4746083009313, 4072.409500622423, 6254.781082662085, 6311.2426508819235, 6363.809085727436, 6402.199725034371, 6436.839079023015, 3603.9819800900827, 3786.3184626767447, 3871.4192871069563, 3876.476675648751, 4126.442930204384, 3990.521137463523, 4142.958570414317, 4152.480939882515, 4178.603032711888, 4180.080382315886, 4321.503027151855, 4508.842190523382, 4826.469088400273, 4918.0, 4949.034938187019, 5795.39148389413, 5936.8218953430605, 6110.114033465212, 6134.38656134383, 6148.1085242639565, 1172.9003034742143, 1286.7683816913045, 1375.7480692569713, 1382.5092092307286, 1396.6159306190675, 697.3688811625487, 763.7517806712841, 850.1880703927734, 867.4535042922918, 880.3397451911067, 3976.741511801724, 4231.032569855032, 4674.883127921761, 4782.832600858953, 4799.616030717534, 4463.888402789891, 4685.601723853442, 5257.395399529027, 5286.788528458818, 5291.788328466818, 4371.868843934687, 4592.10453961481, 4788.976055119702, 4802.159622066194, 4803.471618122004, 2605.788308436548, 2630.7763840073426, 2655.0, 2779.63864697588, 2788.776897848167, 4615.838445654453, 5190.754218987416, 5340.439253878365, 5377.1769820844365, 5477.370102438191, 5056.612069913167, 5386.791415519619, 5396.514313711785, 5446.1483095747635, 5507.421720719347, 5072.442031376472, 5401.081816091274, 5429.647072940325, 5454.181872719124, 5469.808556700496, 4714.646401519831, 4883.316335712932, 4988.002399520038, 5279.366476022902, 5299.602529810202, 4807.0, 5239.790408383622, 5263.605059697752, 5267.762950667153, 5267.973660131828, 4879.731614761222, 5085.389753229636, 5334.039608017588, 5494.2582751329655, 5496.477834605706, 3603.6396360363756, 3607.961501751502, 3612.8554857805393, 3629.149133941656, 3640.2355505344176, 4628.467726211529, 4775.928361074656, 5004.2726713940265, 5019.193090487349, 5877.382874798084, 5481.780728770805, 5794.739236734441, 5910.52715782745, 5932.644041357532, 5987.700614969147, 5263.789208532349, 5970.104484327386, 5997.400259973968, 6002.429769171922, 6018.458338749533, 5558.720354990575, 5564.805231816867, 5857.648541087548, 5865.3254875689845, 5883.2057672215415, 5042.319286896222, 5070.518300761421, 5745.805561939724, 5987.982043052779, 6030.698465076816, 5152.4847515248175, 5577.0, 5616.371252336777, 5855.707214639166, 5891.793787217427], "value": 4109.356003769804, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.6658003898245, 774.1639029847765, 779.1390513482598, 842.4103127810527, 867.3798234262503, 15194.772078418833, 15290.541283761477, 15468.071915685066, 15911.0, 15924.522264332074, 10441.321314114577, 12751.744965100692, 12817.102802803807, 12832.743345133093, 12849.678758031054, 704.9471289653296, 876.3339861705118, 891.696823080151, 916.894557125929, 925.509479975614, 878.3193025405299, 879.2350654930219, 911.6717981526646, 915.1489115122966, 927.6150397584994, 950.2967803825154, 975.1613612293422, 982.9705108846711, 984.478226539935, 987.2052997337141, 963.2005435488528, 976.3507267666993, 977.8044391121804, 979.5543027922279, 980.5979548385128, 712.9786106416764, 719.0903507063568, 729.6825880741894, 730.9451791115688, 732.7362149626131, 14467.56597302072, 14551.78172327416, 14566.344514496874, 14821.40714371424, 14844.332005059798, 14994.400223991028, 15074.773878391832, 15125.621859453491, 15201.847981520154, 15357.232138393147, 12114.697132571668, 12315.753684926342, 12390.0, 12541.561045363369, 12575.748485030339, 3883.689304855605, 3919.7452165609143, 4083.652889504366, 4111.773852438115, 4116.115035267402, 78795.0, 118629.0, 119671.0, 120411.39794300972, 121160.0, 11165.050970667422, 11602.94198529002, 11698.47356868943, 11829.408529573488, 12032.27806331623, 24502.0, 24671.0, 24748.010079596614, 24790.0, 24854.254372368858, 8128.0, 8224.958875205586, 8243.587820608946, 8376.623051962677, 8480.151984801594, 4439.334099884978, 4519.932201016987, 4581.083783243364, 4603.654725895572, 4609.95390046102, 3628.600853906068, 3699.7965111918566, 3740.9064773380883, 3749.512563366745, 3754.8685795997008, 687.4019602945469, 688.2051230828401, 692.0760784352946, 692.4806395203598, 702.5152644675157, 664.6743095883079, 685.3831551603597, 696.4219697650938, 696.4324075878143, 699.674938555453, 7664.006452223232, 9310.487923164292, 9608.95195524018, 9696.272779541563, 9726.951365243129, 634.6921742954663, 638.1480723234441, 673.9056532085511, 702.7189124350199, 709.3580309819622, 4566.931496027562, 4658.510856360033, 4664.090502352009, 4711.764411779397, 4773.785179666923, 145117.0, 154452.0, 155437.44562554455, 156186.0, 158336.20831895768, 116986.41506792411, 129168.0, 130791.0, 131420.0, 131700.0, 91193.54403227942, 110029.89970100197, 112644.0, 113329.43335283271, 114928.0, 8942.86585701202, 8963.820723585623, 9014.684486042957, 9085.636574536944, 9250.0, 49908.0, 64001.0399844012, 64083.0, 64146.0, 64282.678586606766, 90504.5474772622, 93861.0, 94693.5265323669, 96182.51908740411, 97460.0, 12176.025917926367, 12246.816297755719, 12325.260484370967, 12438.0, 12446.81329780036, 10726.839097413702, 13045.739085218433, 13368.0, 13471.595852124452, 13935.470971933959, 12341.50633974631, 12506.562270320495, 12523.123381363217, 12859.0, 12909.741805164032, 12434.738031365432, 12528.561500347445, 12608.684782880502, 12636.936815315865, 13264.46942122343, 11821.113416493625, 12247.262267985596, 12255.625276357465, 12435.191712538655, 12644.683882903, 9898.703038908845, 10734.0, 10796.406197659204, 10975.890241097486, 10990.395528245703, 10469.842952355568, 10567.418791966209, 10598.15214782831, 10630.681079567625, 10635.680929572125], "value": 7921.658458588692, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 119.0, 122.0, 170.0, 122.0, 117.0, 113.0, 118.0, 116.0, 118.0], "value": 121.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 132.0, 157.0, 112.0, 131.0, 133.0, 141.0, 170.0, 111.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 200.0, 199.0, 206.0, 228.0, 192.0, 196.0, 205.0, 273.0, 189.0], "value": 208.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 83.0, 76.0, 145.0, 82.0, 80.0, 66.0, 63.0, 139.0, 72.0], "value": 87.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 127.0, 56.0, 92.0, 107.0, 101.0, 100.0, 100.0, 146.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 80.0, 86.0, 78.0, 125.0, 90.0, 92.0, 89.0, 85.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 97.0, 95.0, 95.0, 104.0, 130.0, 95.0, 95.0], "value": 99.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 94.0, 95.0, 142.0, 96.0, 143.0, 131.0, 91.0, 94.0, 132.0], "value": 110.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 57.0, 57.0, 59.0, 57.0, 57.0, 56.0, 57.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 64.0, 108.0, 106.0, 117.0, 85.0, 71.0, 71.0, 74.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 100.0, 102.0, 86.0, 86.0, 83.0, 85.0, 85.0, 93.0, 103.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 140.0, 137.0, 137.0, 140.0, 140.0, 147.0, 145.0, 234.0, 155.0], "value": 151.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 174.0, 220.0, 173.0, 171.0, 164.0, 166.0, 172.0, 168.0, 170.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 71.0, 67.0, 70.0, 81.0, 78.0, 66.0, 66.0, 71.0], "value": 70.4, "unit": "score"}]}]} 11:14:52 INFO - Return code: 0 11:14:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:14:52 ERROR - # TBPL SUCCESS # 11:14:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:14:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:14:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:14:52 INFO - 2016-07-15 11:14:52.171 screenresolution[1681:12192] starting screenresolution argv=screenresolution get 11:14:52 INFO - 2016-07-15 11:14:52.173 screenresolution[1681:12192] Display 0: 1600x1200x32@60 11:14:52 INFO - 2016-07-15 11:14:52.178 screenresolution[1682:12195] starting screenresolution argv=screenresolution list 11:14:52 INFO - Available Modes on Display 0 11:14:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:14:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:14:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:14:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:14:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:14:52 INFO - Intel Iris: 11:14:52 INFO - Chipset Model: Intel Iris 11:14:52 INFO - Type: GPU 11:14:52 INFO - Bus: Built-In 11:14:52 INFO - VRAM (Dynamic, Max): 1536 MB 11:14:52 INFO - Vendor: Intel (0x8086) 11:14:52 INFO - Device ID: 0x0a2e 11:14:52 INFO - Revision ID: 0x0009 11:14:52 INFO - Displays: 11:14:52 INFO - Display: 11:14:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:14:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:14:52 INFO - Display Serial Number: 1600x1200 60 11:14:52 INFO - Main Display: Yes 11:14:52 INFO - Mirror: Off 11:14:52 INFO - Online: Yes 11:14:52 INFO - Rotation: Supported 11:14:52 INFO - Return code: 0 11:14:52 INFO - Running post-action listener: _resource_record_post_action 11:14:52 INFO - ##### 11:14:52 INFO - ##### Finished run-tests step (success) 11:14:52 INFO - ##### 11:14:52 INFO - Running post-run listener: _resource_record_post_run 11:14:52 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 32742912; Write bytes: 709393408; Read time: 341; Write time: 1948 11:14:52 INFO - TinderboxPrint: CPU usage
54.7% 11:14:52 INFO - TinderboxPrint: I/O read bytes / time
32,742,912 / 341 11:14:52 INFO - TinderboxPrint: I/O write bytes / time
709,393,408 / 1,948 11:14:52 INFO - TinderboxPrint: CPU idle
2,189.1 (45.3%) 11:14:52 INFO - TinderboxPrint: CPU system
980.8 (20.3%) 11:14:52 INFO - TinderboxPrint: CPU user
1,667.8 (34.5%) 11:14:52 INFO - TinderboxPrint: Swap in / out
435,560,448 / 0 11:14:52 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 403122688; Write bytes: 396339200; Read time: 30838; Write time: 677 11:14:52 INFO - run-tests - Wall time: 1175s; CPU: 55.0%; Read bytes: 30662144; Write bytes: 299369472; Read time: 317; Write time: 1238 11:14:52 INFO - Running post-run listener: _upload_blobber_files 11:14:52 INFO - Blob upload gear active. 11:14:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:14:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:14:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:14:53 INFO - (blobuploader) - INFO - Open directory for files ... 11:14:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:14:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:14:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:54 INFO - (blobuploader) - INFO - Done attempting. 11:14:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:14:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:14:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:55 INFO - (blobuploader) - INFO - Done attempting. 11:14:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:14:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:14:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:58 INFO - (blobuploader) - INFO - Done attempting. 11:14:58 INFO - (blobuploader) - INFO - Iteration through files over. 11:14:58 INFO - Return code: 0 11:14:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:14:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:14:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45099f7f32516ffbbcb734f76e84f87093207ed6ebfa68b233a466bc2f2933545264b9ced5917c5157925ddfbd321a494fa2e395d9eea2de24d88754509567d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85e5904fd7c325c018334798cf345d75d753241c44e3856267e599305c14914b98539ec9b2fc2dc3a54714eef6c94b481b74688c783634197cf5519e8610617f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/173d610d533a534400231bc47a89b20165a862748ee34a4851da62e0970d3d7a922b97cd7b12f7510d2bf12d6ec28dae8ff3436e66041925b6587d6b3b9bbb48"} 11:14:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:14:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:14:58 INFO - Contents: 11:14:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45099f7f32516ffbbcb734f76e84f87093207ed6ebfa68b233a466bc2f2933545264b9ced5917c5157925ddfbd321a494fa2e395d9eea2de24d88754509567d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85e5904fd7c325c018334798cf345d75d753241c44e3856267e599305c14914b98539ec9b2fc2dc3a54714eef6c94b481b74688c783634197cf5519e8610617f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/173d610d533a534400231bc47a89b20165a862748ee34a4851da62e0970d3d7a922b97cd7b12f7510d2bf12d6ec28dae8ff3436e66041925b6587d6b3b9bbb48"} 11:14:58 INFO - Running post-run listener: copy_logs_to_upload_dir 11:14:58 INFO - Copying logs to upload dir... 11:14:58 INFO - mkdir: /builds/slave/test/build/upload/logs 11:14:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1358.382665 ========= master_lag: 0.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 38 secs) (at 2016-07-15 11:14:59.193474) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 11:14:59.196865) ========= 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.BOoNWKAL6m/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.j5VyQnbk78/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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/45099f7f32516ffbbcb734f76e84f87093207ed6ebfa68b233a466bc2f2933545264b9ced5917c5157925ddfbd321a494fa2e395d9eea2de24d88754509567d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85e5904fd7c325c018334798cf345d75d753241c44e3856267e599305c14914b98539ec9b2fc2dc3a54714eef6c94b481b74688c783634197cf5519e8610617f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/173d610d533a534400231bc47a89b20165a862748ee34a4851da62e0970d3d7a922b97cd7b12f7510d2bf12d6ec28dae8ff3436e66041925b6587d6b3b9bbb48"} build_url:https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45099f7f32516ffbbcb734f76e84f87093207ed6ebfa68b233a466bc2f2933545264b9ced5917c5157925ddfbd321a494fa2e395d9eea2de24d88754509567d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/85e5904fd7c325c018334798cf345d75d753241c44e3856267e599305c14914b98539ec9b2fc2dc3a54714eef6c94b481b74688c783634197cf5519e8610617f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/173d610d533a534400231bc47a89b20165a862748ee34a4851da62e0970d3d7a922b97cd7b12f7510d2bf12d6ec28dae8ff3436e66041925b6587d6b3b9bbb48"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 11:14:59.233453) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:14:59.233783) ========= 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.BOoNWKAL6m/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.j5VyQnbk78/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.005171 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:14:59.280954) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 11:14:59.281226) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 11:14:59.281510) ========= ========= Total master_lag: 0.59 =========