builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0164 starttime: 1461876277.55 results: success (0) buildid: 20160428112703 builduid: c551b074b4bb47ada0e34bdaac768409 revision: 6adc822f5e27a55551faeb6c47a9bd8b0859a23b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 13:44:37.545990) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 13:44:37.546449) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 13:44:37.546725) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 13:44:37.564873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 13:44:37.565290) ========= 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.UEVn7OCguR/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.wSvhchxDGK/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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-04-28 13:44:37-- 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% 8.14M=0.001s 2016-04-28 13:44:37 (8.14 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132750 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 13:44:37.715091) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 13:44:37.715417) ========= 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.UEVn7OCguR/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.wSvhchxDGK/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.020705 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 13:44:37.763753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-28 13:44:37.764088) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6adc822f5e27a55551faeb6c47a9bd8b0859a23b --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 6adc822f5e27a55551faeb6c47a9bd8b0859a23b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UEVn7OCguR/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.wSvhchxDGK/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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-04-28 13:44:37,831 truncating revision to first 12 chars 2016-04-28 13:44:37,831 Setting DEBUG logging. 2016-04-28 13:44:37,831 attempt 1/10 2016-04-28 13:44:37,831 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6adc822f5e27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 13:44:39,904 unpacking tar archive at: mozilla-central-6adc822f5e27/testing/mozharness/ program finished with exit code 0 elapsedTime=2.324257 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-28 13:44:40.105439) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 13:44:40.105763) ========= script_repo_revision: 6adc822f5e27a55551faeb6c47a9bd8b0859a23b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 13:44:40.106270) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 13:44:40.106541) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 13:44:40.120395) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-04-28 13:44:40.120768) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UEVn7OCguR/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.wSvhchxDGK/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 13:44:40 INFO - MultiFileLogger online at 20160428 13:44:40 in /builds/slave/test 13:44:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:44:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:44:40 INFO - {'append_to_log': False, 13:44:40 INFO - 'base_work_dir': '/builds/slave/test', 13:44:40 INFO - 'blob_upload_branch': 'Firefox', 13:44:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:44:40 INFO - 'branch': 'Firefox', 13:44:40 INFO - 'buildbot_json_path': 'buildprops.json', 13:44:40 INFO - 'config_files': ('talos/mac_config.py',), 13:44:40 INFO - 'default_actions': ('clobber', 13:44:40 INFO - 'read-buildbot-config', 13:44:40 INFO - 'download-and-extract', 13:44:40 INFO - 'populate-webroot', 13:44:40 INFO - 'create-virtualenv', 13:44:40 INFO - 'install', 13:44:40 INFO - 'run-tests'), 13:44:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:44:40 INFO - 'download_minidump_stackwalk': True, 13:44:40 INFO - 'download_symbols': 'ondemand', 13:44:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:44:40 INFO - 'tooltool.py': '/tools/tooltool.py', 13:44:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:44:40 INFO - '/tools/misc-python/virtualenv.py')}, 13:44:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:44:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:44:40 INFO - 'installer_path': 'installer.exe', 13:44:40 INFO - 'log_level': 'info', 13:44:40 INFO - 'log_name': 'talos', 13:44:40 INFO - 'log_to_console': True, 13:44:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:44:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:44:40 INFO - 'opt_config_files': (), 13:44:40 INFO - 'pip_index': False, 13:44:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:44:40 INFO - 'cmd': ('bash', 13:44:40 INFO - '-c', 13:44:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:44:40 INFO - 'enabled': True, 13:44:40 INFO - 'halt_on_failure': False, 13:44:40 INFO - 'name': 'check_screen_resolution'},), 13:44:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:44:40 INFO - 'cmd': ('bash', 13:44:40 INFO - '-c', 13:44:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:44:40 INFO - 'enabled': True, 13:44:40 INFO - 'halt_on_failure': False, 13:44:40 INFO - 'name': 'check_screen_resolution'},), 13:44:40 INFO - 'run_cmd_checks_enabled': True, 13:44:40 INFO - 'sps_profile': False, 13:44:40 INFO - 'sps_profile_interval': 0, 13:44:40 INFO - 'suite': 'dromaeojs', 13:44:40 INFO - 'system_bits': '32', 13:44:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:44:40 INFO - 'title': 't-yosemite-r7-0164', 13:44:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:44:40 INFO - 'use_talos_json': True, 13:44:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:44:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:44:40 INFO - 'work_dir': 'build'} 13:44:40 INFO - ##### 13:44:40 INFO - ##### Running clobber step. 13:44:40 INFO - ##### 13:44:40 INFO - Running pre-action listener: _resource_record_pre_action 13:44:40 INFO - Running main action method: clobber 13:44:40 INFO - rmtree: /builds/slave/test/build 13:44:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:44:41 INFO - Running post-action listener: _resource_record_post_action 13:44:41 INFO - ##### 13:44:41 INFO - ##### Running read-buildbot-config step. 13:44:41 INFO - ##### 13:44:41 INFO - Running pre-action listener: _resource_record_pre_action 13:44:41 INFO - Running main action method: read_buildbot_config 13:44:41 INFO - Using buildbot properties: 13:44:41 INFO - { 13:44:41 INFO - "project": "", 13:44:41 INFO - "product": "firefox", 13:44:41 INFO - "script_repo_revision": "production", 13:44:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 13:44:41 INFO - "repository": "", 13:44:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 13:44:41 INFO - "buildid": "20160428112703", 13:44:41 INFO - "pgo_build": "False", 13:44:41 INFO - "basedir": "/builds/slave/test", 13:44:41 INFO - "buildnumber": 243, 13:44:41 INFO - "slavename": "t-yosemite-r7-0164", 13:44:41 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:44:41 INFO - "platform": "yosemite_r7", 13:44:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:44:41 INFO - "branch": "mozilla-central", 13:44:41 INFO - "repo_path": "mozilla-central", 13:44:41 INFO - "revision": "6adc822f5e27a55551faeb6c47a9bd8b0859a23b", 13:44:41 INFO - "stage_platform": "macosx64", 13:44:41 INFO - "builduid": "c551b074b4bb47ada0e34bdaac768409", 13:44:41 INFO - "slavebuilddir": "test" 13:44:41 INFO - } 13:44:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 13:44:41 INFO - Running post-action listener: _resource_record_post_action 13:44:41 INFO - ##### 13:44:41 INFO - ##### Running download-and-extract step. 13:44:41 INFO - ##### 13:44:41 INFO - Running pre-action listener: _resource_record_pre_action 13:44:41 INFO - Running main action method: download_and_extract 13:44:41 INFO - mkdir: /builds/slave/test/build/tests 13:44: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')]} 13:44:41 INFO - https://queue.taskcluster.net/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:44:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 13:44:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 13:44:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 13:44:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 13:44:42 INFO - Downloaded 1199 bytes. 13:44:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 13:44:42 INFO - Using the following test package requirements: 13:44:42 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 13:44:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:44:42 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 13:44:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:44:42 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 13:44:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:44:42 INFO - u'jsshell-mac.zip'], 13:44:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:44:42 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 13:44:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 13:44:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:44:42 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 13:44:42 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:44:42 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 13:44:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:44:42 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 13:44:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 13:44:42 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 13:44:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:44: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')]} 13:44:42 INFO - https://queue.taskcluster.net/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:44:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:44:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:44:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:44:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:44:44 INFO - Downloaded 18124035 bytes. 13:44:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:44:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:44:47 INFO - Return code: 0 13:44:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:44: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')]} 13:44:47 INFO - https://queue.taskcluster.net/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:44:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:44:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:44:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 13:44:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:44:54 INFO - Downloaded 18124035 bytes. 13:44:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:44:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:44:58 INFO - Return code: 0 13:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:44:58 INFO - https://queue.taskcluster.net/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:44:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 13:44:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 13:44:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 13:44:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:44:59 INFO - Downloaded 10840145 bytes. 13:44:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:44:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:44:59 INFO - Return code: 0 13:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:44:59 INFO - https://queue.taskcluster.net/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:44:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 13:44:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 13:44:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 13:44:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 13:45:02 INFO - Downloaded 110281448 bytes. 13:45:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 13:45:02 INFO - mkdir: /builds/slave/test/properties 13:45:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:45:02 INFO - Writing to file /builds/slave/test/properties/build_url 13:45:02 INFO - Contents: 13:45:02 INFO - build_url:https://queue.taskcluster.net/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 13:45:04 INFO - Running post-action listener: _resource_record_post_action 13:45:04 INFO - Running post-action listener: set_extra_try_arguments 13:45:04 INFO - ##### 13:45:04 INFO - ##### Running populate-webroot step. 13:45:04 INFO - ##### 13:45:04 INFO - Running pre-action listener: _resource_record_pre_action 13:45:04 INFO - Running main action method: populate_webroot 13:45:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:45:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:45:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:45:04 INFO - '--tppagecycles', 13:45:04 INFO - '7'], 13:45:04 INFO - 'tests': ['tsvgm']}}, 13:45:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:45:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:45:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:45:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:45:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:45:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:45:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:04 INFO - 'talos_options': ['--disable-e10s'], 13:45:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:45:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:04 INFO - 'talos_options': ['--disable-e10s'], 13:45:04 INFO - 'tests': ['damp', 'tps']}, 13:45:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:04 INFO - 'tests': ['damp', 'tps']}, 13:45:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:45:04 INFO - 'tests': ['dromaeo_dom']}, 13:45:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:45:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:45:04 INFO - 'tests': ['a11yr', 13:45:04 INFO - 'ts_paint', 13:45:04 INFO - 'tpaint', 13:45:04 INFO - 'sessionrestore', 13:45:04 INFO - 'sessionrestore_no_auto_restore', 13:45:04 INFO - 'tabpaint']}, 13:45:04 INFO - 'other-e10s': {'tests': ['a11yr', 13:45:04 INFO - 'ts_paint', 13:45:04 INFO - 'tpaint', 13:45:04 INFO - 'sessionrestore', 13:45:04 INFO - 'sessionrestore_no_auto_restore', 13:45:04 INFO - 'tabpaint']}, 13:45:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:45:04 INFO - 'ts_paint', 13:45:04 INFO - 'tpaint', 13:45:04 INFO - 'sessionrestore', 13:45:04 INFO - 'sessionrestore_no_auto_restore', 13:45:04 INFO - 'tabpaint']}, 13:45:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:45:04 INFO - 'ts_paint', 13:45:04 INFO - 'tpaint', 13:45:04 INFO - 'sessionrestore', 13:45:04 INFO - 'sessionrestore_no_auto_restore', 13:45:04 INFO - 'tabpaint']}, 13:45:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:45:04 INFO - 'tests': ['a11yr', 13:45:04 INFO - 'ts_paint', 13:45:04 INFO - 'tpaint', 13:45:04 INFO - 'sessionrestore', 13:45:04 INFO - 'sessionrestore_no_auto_restore', 13:45:04 INFO - 'tabpaint']}, 13:45:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:45:04 INFO - 'tests': ['a11yr', 13:45:04 INFO - 'ts_paint', 13:45:04 INFO - 'tpaint', 13:45:04 INFO - 'sessionrestore', 13:45:04 INFO - 'sessionrestore_no_auto_restore', 13:45:04 INFO - 'tabpaint']}, 13:45:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:45:04 INFO - 'tests': ['tsvgx', 13:45:04 INFO - 'tsvgr_opacity', 13:45:04 INFO - 'tart', 13:45:04 INFO - 'tscrollx', 13:45:04 INFO - 'cart']}, 13:45:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:45:04 INFO - 'tsvgr_opacity', 13:45:04 INFO - 'tart', 13:45:04 INFO - 'tscrollx', 13:45:04 INFO - 'cart']}, 13:45:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:04 INFO - 'talos_options': ['--disable-e10s'], 13:45:04 INFO - 'tests': ['tp5o']}, 13:45:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:04 INFO - 'tests': ['tp5o']}, 13:45:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:04 INFO - 'talos_options': ['--disable-e10s', 13:45:04 INFO - '--xperf_path', 13:45:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:04 INFO - 'tests': ['tp5n']}, 13:45:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:45:04 INFO - 'talos_options': ['--xperf_path', 13:45:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:45:04 INFO - 'tests': ['tp5n']}}, 13:45:04 INFO - 'talos.zip': {'path': '', 13:45:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:45:04 INFO - Running post-action listener: _resource_record_post_action 13:45:04 INFO - ##### 13:45:04 INFO - ##### Running create-virtualenv step. 13:45:04 INFO - ##### 13:45:04 INFO - Running pre-action listener: _resource_record_pre_action 13:45:04 INFO - Running main action method: create_virtualenv 13:45:04 INFO - Creating virtualenv /builds/slave/test/build/venv 13:45:04 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 13:45:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:45:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:45:04 INFO - Using real prefix '/tools/python27' 13:45:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:45:04 INFO - Installing distribute.............................................................................................................................................................................................done. 13:45:07 INFO - Installing pip.................done. 13:45:07 INFO - Return code: 0 13:45:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:45:07 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')]} 13:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:07 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')]} 13:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:07 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 0x106006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106016420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b1bd78290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ea5e00>, '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 0x105ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ea0b20>, '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.UEVn7OCguR/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.wSvhchxDGK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 13:45:07 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 13:45:07 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 13:45:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEVn7OCguR/Render', 13:45:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:07 INFO - 'HOME': '/Users/cltbld', 13:45:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:07 INFO - 'LOGNAME': 'cltbld', 13:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:07 INFO - 'MOZ_NO_REMOTE': '1', 13:45:07 INFO - 'NO_EM_RESTART': '1', 13:45:07 INFO - 'PAGER': '/bin/cat', 13:45:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:07 INFO - 'PWD': '/builds/slave/test', 13:45:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:07 INFO - 'SHELL': '/bin/bash', 13:45:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSvhchxDGK/Listeners', 13:45:07 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 13:45:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:07 INFO - 'USER': 'cltbld', 13:45:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:07 INFO - 'XPC_FLAGS': '0x0', 13:45:07 INFO - 'XPC_SERVICE_NAME': '0', 13:45:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:08 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 13:45:08 INFO - Cleaning up... 13:45:08 INFO - Return code: 0 13:45:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:45:08 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')]} 13:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:08 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')]} 13:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:08 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106016420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b1bd78290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ea5e00>, '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 0x105ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ea0b20>, '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.UEVn7OCguR/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.wSvhchxDGK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 13:45:08 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>=0.7.1'] in /builds/slave/test/build 13:45:08 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>=0.7.1 13:45:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEVn7OCguR/Render', 13:45:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:08 INFO - 'HOME': '/Users/cltbld', 13:45:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:08 INFO - 'LOGNAME': 'cltbld', 13:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:08 INFO - 'MOZ_NO_REMOTE': '1', 13:45:08 INFO - 'NO_EM_RESTART': '1', 13:45:08 INFO - 'PAGER': '/bin/cat', 13:45:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:08 INFO - 'PWD': '/builds/slave/test', 13:45:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:08 INFO - 'SHELL': '/bin/bash', 13:45:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSvhchxDGK/Listeners', 13:45:08 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 13:45:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:08 INFO - 'USER': 'cltbld', 13:45:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:08 INFO - 'XPC_FLAGS': '0x0', 13:45:08 INFO - 'XPC_SERVICE_NAME': '0', 13:45:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:08 INFO - Downloading/unpacking psutil>=0.7.1 13:45:08 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 13:45:08 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 13:45:08 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 13:45:08 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 13:45:08 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 13:45:08 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 13:45:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:45:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:45:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:45:11 INFO - Installing collected packages: psutil 13:45:11 INFO - Running setup.py install for psutil 13:45:11 INFO - building 'psutil._psutil_osx' extension 13:45:11 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 13:45:11 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 13:45:11 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 13:45:11 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 13:45:11 INFO - building 'psutil._psutil_posix' extension 13:45:11 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 13:45:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:45:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:45:11 INFO - ^ 13:45:11 INFO - 1 warning generated. 13:45:11 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 13:45:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:45:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:45:11 INFO - Successfully installed psutil 13:45:11 INFO - Cleaning up... 13:45:12 INFO - Return code: 0 13:45:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106016420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b1bd78290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ea5e00>, '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 0x105ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ea0b20>, '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.UEVn7OCguR/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.wSvhchxDGK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 13:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:45:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEVn7OCguR/Render', 13:45:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:12 INFO - 'HOME': '/Users/cltbld', 13:45:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:12 INFO - 'LOGNAME': 'cltbld', 13:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:12 INFO - 'MOZ_NO_REMOTE': '1', 13:45:12 INFO - 'NO_EM_RESTART': '1', 13:45:12 INFO - 'PAGER': '/bin/cat', 13:45:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:12 INFO - 'PWD': '/builds/slave/test', 13:45:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:12 INFO - 'SHELL': '/bin/bash', 13:45:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSvhchxDGK/Listeners', 13:45:12 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 13:45:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:12 INFO - 'USER': 'cltbld', 13:45:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:12 INFO - 'XPC_FLAGS': '0x0', 13:45:12 INFO - 'XPC_SERVICE_NAME': '0', 13:45:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:45:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:45:14 INFO - Installing collected packages: mozsystemmonitor 13:45:14 INFO - Running setup.py install for mozsystemmonitor 13:45:14 INFO - Successfully installed mozsystemmonitor 13:45:14 INFO - Cleaning up... 13:45:14 INFO - Return code: 0 13:45:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45: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', '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 0x106006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106016420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b1bd78290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ea5e00>, '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 0x105ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ea0b20>, '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.UEVn7OCguR/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.wSvhchxDGK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 13:45: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:45: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 blobuploader==1.2.4 13:45:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEVn7OCguR/Render', 13:45:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:15 INFO - 'HOME': '/Users/cltbld', 13:45:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:15 INFO - 'LOGNAME': 'cltbld', 13:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:15 INFO - 'MOZ_NO_REMOTE': '1', 13:45:15 INFO - 'NO_EM_RESTART': '1', 13:45:15 INFO - 'PAGER': '/bin/cat', 13:45:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:15 INFO - 'PWD': '/builds/slave/test', 13:45:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:15 INFO - 'SHELL': '/bin/bash', 13:45:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSvhchxDGK/Listeners', 13:45:15 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 13:45:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:15 INFO - 'USER': 'cltbld', 13:45:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:15 INFO - 'XPC_FLAGS': '0x0', 13:45:15 INFO - 'XPC_SERVICE_NAME': '0', 13:45:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:15 INFO - Downloading/unpacking blobuploader==1.2.4 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45:17 INFO - Downloading blobuploader-1.2.4.tar.gz 13:45:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:45:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:45:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:18 INFO - Downloading docopt-0.6.1.tar.gz 13:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:45:18 INFO - Installing collected packages: blobuploader, requests, docopt 13:45:18 INFO - Running setup.py install for blobuploader 13:45:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:45:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:45:19 INFO - Running setup.py install for requests 13:45:19 INFO - Running setup.py install for docopt 13:45:19 INFO - Successfully installed blobuploader requests docopt 13:45:19 INFO - Cleaning up... 13:45:19 INFO - Return code: 0 13:45:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:19 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')]} 13:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:19 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')]} 13:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:19 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 0x106006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106016420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b1bd78290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ea5e00>, '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 0x105ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ea0b20>, '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.UEVn7OCguR/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.wSvhchxDGK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 13:45:19 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 13:45:19 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 13:45:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEVn7OCguR/Render', 13:45:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:19 INFO - 'HOME': '/Users/cltbld', 13:45:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:19 INFO - 'LOGNAME': 'cltbld', 13:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:19 INFO - 'MOZ_NO_REMOTE': '1', 13:45:19 INFO - 'NO_EM_RESTART': '1', 13:45:19 INFO - 'PAGER': '/bin/cat', 13:45:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:19 INFO - 'PWD': '/builds/slave/test', 13:45:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:19 INFO - 'SHELL': '/bin/bash', 13:45:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSvhchxDGK/Listeners', 13:45:19 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 13:45:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:19 INFO - 'USER': 'cltbld', 13:45:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:19 INFO - 'XPC_FLAGS': '0x0', 13:45:19 INFO - 'XPC_SERVICE_NAME': '0', 13:45:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:45:20 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-2GvDQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:45:20 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-oIBrLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:45:20 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-j_gYlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:45:20 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-6ZEcmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:45:20 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-jK0iyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:45:20 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-psrtpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:45:20 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-HQOSez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:45:20 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-bghSr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:45:20 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-GKpf5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:45:20 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Gy8srs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:45:21 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-w0E_yR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:45:21 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-4h_fLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:45:21 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Ibwo8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:45:21 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-04Nvsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:21 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-0jlXSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:45:21 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-tBjF7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:45:21 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-xxKvOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:45:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:45:21 INFO - Running setup.py install for manifestparser 13:45:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:45:21 INFO - Running setup.py install for mozcrash 13:45:22 INFO - Running setup.py install for mozdebug 13:45:22 INFO - Running setup.py install for mozdevice 13:45:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:45:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:45:22 INFO - Running setup.py install for mozfile 13:45:22 INFO - Running setup.py install for mozhttpd 13:45:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:45:22 INFO - Running setup.py install for mozinfo 13:45:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:45:22 INFO - Running setup.py install for mozInstall 13:45:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Running setup.py install for mozleak 13:45:23 INFO - Running setup.py install for mozlog 13:45:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Running setup.py install for moznetwork 13:45:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Running setup.py install for mozprocess 13:45:23 INFO - Running setup.py install for mozprofile 13:45:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Running setup.py install for mozrunner 13:45:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:45:23 INFO - Running setup.py install for mozscreenshot 13:45:24 INFO - Running setup.py install for moztest 13:45:24 INFO - Running setup.py install for mozversion 13:45:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:45:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:45:24 INFO - Cleaning up... 13:45:24 INFO - Return code: 0 13:45:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:24 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 0x106006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106016420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b1bd78290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ea5e00>, '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 0x105ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ea0b20>, '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.UEVn7OCguR/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.wSvhchxDGK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 13:45:24 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 13:45:24 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 13:45:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEVn7OCguR/Render', 13:45:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:24 INFO - 'HOME': '/Users/cltbld', 13:45:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:24 INFO - 'LOGNAME': 'cltbld', 13:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:24 INFO - 'MOZ_NO_REMOTE': '1', 13:45:24 INFO - 'NO_EM_RESTART': '1', 13:45:24 INFO - 'PAGER': '/bin/cat', 13:45:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:24 INFO - 'PWD': '/builds/slave/test', 13:45:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:24 INFO - 'SHELL': '/bin/bash', 13:45:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSvhchxDGK/Listeners', 13:45:24 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 13:45:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:24 INFO - 'USER': 'cltbld', 13:45:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:24 INFO - 'XPC_FLAGS': '0x0', 13:45:24 INFO - 'XPC_SERVICE_NAME': '0', 13:45:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:45:24 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-eubH0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:45:24 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)) 13:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:45:24 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-UsPwUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:45:24 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)) 13:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:45:24 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-oSzdAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:45:25 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-jiiCVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:45:25 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Wx17_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:45:25 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-oOT8oA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:45:25 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-W3dcdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:45:25 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-u80_H5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:45:25 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-ltJVdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:45:25 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-aMya4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:45:25 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-dlrOTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:45:25 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:45:25 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-ka9QaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 13:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:45:25 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-5EH3V3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:45:26 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)) 13:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:45:26 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-47MMVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:45:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 13:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:26 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-89kgNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:45:26 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)) 13:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:45:26 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-5ysqIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:45:26 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)) 13:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:45:26 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-xbwJfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:45:26 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)) 13:45:26 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)) 13:45:26 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)) 13:45:26 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)) 13:45:26 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)) 13:45:26 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)) 13:45:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45:28 INFO - Downloading blessings-1.6.tar.gz 13:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:45:29 INFO - Installing collected packages: blessings 13:45:29 INFO - Running setup.py install for blessings 13:45:29 INFO - Successfully installed blessings 13:45:29 INFO - Cleaning up... 13:45:29 INFO - Return code: 0 13:45:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:45:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:45:29 INFO - Reading from file tmpfile_stdout 13:45:29 INFO - Current package versions: 13:45:29 INFO - blessings == 1.6 13:45:29 INFO - blobuploader == 1.2.4 13:45:29 INFO - docopt == 0.6.1 13:45:29 INFO - manifestparser == 1.1 13:45:29 INFO - mozInstall == 1.12 13:45:29 INFO - mozcrash == 0.17 13:45:29 INFO - mozdebug == 0.1 13:45:29 INFO - mozdevice == 0.48 13:45:29 INFO - mozfile == 1.2 13:45:29 INFO - mozhttpd == 0.7 13:45:29 INFO - mozinfo == 0.9 13:45:29 INFO - mozleak == 0.1 13:45:29 INFO - mozlog == 3.1 13:45:29 INFO - moznetwork == 0.27 13:45:29 INFO - mozprocess == 0.22 13:45:29 INFO - mozprofile == 0.28 13:45:29 INFO - mozrunner == 6.11 13:45:29 INFO - mozscreenshot == 0.1 13:45:29 INFO - mozsystemmonitor == 0.0 13:45:29 INFO - moztest == 0.7 13:45:29 INFO - mozversion == 1.4 13:45:29 INFO - psutil == 3.1.1 13:45:29 INFO - requests == 1.2.3 13:45:29 INFO - wsgiref == 0.1.2 13:45:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:45:29 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')]} 13:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:29 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')]} 13:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:29 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 0x106006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106016420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b1bd78290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ea5e00>, '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 0x105ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ea0b20>, '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.UEVn7OCguR/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.wSvhchxDGK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 13:45:29 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 13:45:29 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 13:45:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEVn7OCguR/Render', 13:45:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:29 INFO - 'HOME': '/Users/cltbld', 13:45:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:29 INFO - 'LOGNAME': 'cltbld', 13:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:29 INFO - 'MOZ_NO_REMOTE': '1', 13:45:29 INFO - 'NO_EM_RESTART': '1', 13:45:29 INFO - 'PAGER': '/bin/cat', 13:45:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:29 INFO - 'PWD': '/builds/slave/test', 13:45:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:29 INFO - 'SHELL': '/bin/bash', 13:45:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSvhchxDGK/Listeners', 13:45:29 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 13:45:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:29 INFO - 'USER': 'cltbld', 13:45:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:29 INFO - 'XPC_FLAGS': '0x0', 13:45:29 INFO - 'XPC_SERVICE_NAME': '0', 13:45:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:29 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)) 13:45:29 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)) 13:45:29 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)) 13:45:29 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)) 13:45:29 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)) 13:45:29 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)) 13:45:29 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)) 13:45:29 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)) 13:45:29 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)) 13:45:29 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)) 13:45:29 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)) 13:45:29 INFO - Cleaning up... 13:45:29 INFO - Return code: 0 13:45:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:45:29 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')]} 13:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:29 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')]} 13:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:29 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 0x106006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106016420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b1bd78290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ea5e00>, '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 0x105ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ea0b20>, '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.UEVn7OCguR/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.wSvhchxDGK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 13:45:29 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 13:45:29 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 13:45:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEVn7OCguR/Render', 13:45:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:29 INFO - 'HOME': '/Users/cltbld', 13:45:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:29 INFO - 'LOGNAME': 'cltbld', 13:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:29 INFO - 'MOZ_NO_REMOTE': '1', 13:45:29 INFO - 'NO_EM_RESTART': '1', 13:45:29 INFO - 'PAGER': '/bin/cat', 13:45:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:29 INFO - 'PWD': '/builds/slave/test', 13:45:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:29 INFO - 'SHELL': '/bin/bash', 13:45:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSvhchxDGK/Listeners', 13:45:29 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 13:45:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:29 INFO - 'USER': 'cltbld', 13:45:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:29 INFO - 'XPC_FLAGS': '0x0', 13:45:29 INFO - 'XPC_SERVICE_NAME': '0', 13:45:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:30 INFO - Downloading/unpacking jsonschema 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45: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 13:45:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:45:32 INFO - Downloading/unpacking functools32 (from jsonschema) 13:45:32 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 13:45:32 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 13:45:32 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 13:45:32 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 13:45:32 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 13:45:32 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 13:45:32 INFO - Downloading functools32-3.2.3-2.tar.gz 13:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:45:32 INFO - warning: no files found matching '*.txt' 13:45:32 INFO - no previously-included directories found matching 'build' 13:45:32 INFO - no previously-included directories found matching 'dist' 13:45:32 INFO - no previously-included directories found matching '.git*' 13:45:33 INFO - Installing collected packages: jsonschema, functools32 13:45:33 INFO - Running setup.py install for functools32 13:45:33 INFO - warning: no files found matching '*.txt' 13:45:33 INFO - no previously-included directories found matching 'build' 13:45:33 INFO - no previously-included directories found matching 'dist' 13:45:33 INFO - no previously-included directories found matching '.git*' 13:45:33 INFO - Successfully installed jsonschema functools32 13:45:33 INFO - Cleaning up... 13:45:33 INFO - Return code: 0 13:45:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:45:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106006a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106016420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b1bd78290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ea5e00>, '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 0x105ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ea0b20>, '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.UEVn7OCguR/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.wSvhchxDGK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 13:45:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:45:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEVn7OCguR/Render', 13:45:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:45:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:45:33 INFO - 'HOME': '/Users/cltbld', 13:45:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:45:33 INFO - 'LOGNAME': 'cltbld', 13:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:45:33 INFO - 'MOZ_NO_REMOTE': '1', 13:45:33 INFO - 'NO_EM_RESTART': '1', 13:45:33 INFO - 'PAGER': '/bin/cat', 13:45:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:45:33 INFO - 'PWD': '/builds/slave/test', 13:45:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:45:33 INFO - 'SHELL': '/bin/bash', 13:45:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSvhchxDGK/Listeners', 13:45:33 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 13:45:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:45:33 INFO - 'USER': 'cltbld', 13:45:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:45:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:45:33 INFO - 'XPC_FLAGS': '0x0', 13:45:33 INFO - 'XPC_SERVICE_NAME': '0', 13:45:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:45:33 INFO - Downloading/unpacking flake8 13:45:33 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 13:45:33 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 13:45:33 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 13:45:33 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 13:45:33 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 13:45:33 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 13:45:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:45:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:45:35 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 13:45:35 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 13:45:35 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 13:45:35 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 13:45:35 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 13:45:35 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 13:45:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:45:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:45:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:45:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:45:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:45:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:45:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:45:37 INFO - no previously-included directories found matching 'docs/_build' 13:45:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:45:37 INFO - Running setup.py install for pep8 13:45:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:45:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:45:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:45:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:45:37 INFO - no previously-included directories found matching 'docs/_build' 13:45:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:45:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:45:37 INFO - Cleaning up... 13:45:37 INFO - Return code: 0 13:45:37 INFO - Running post-action listener: _resource_record_post_action 13:45:37 INFO - Running post-action listener: _start_resource_monitoring 13:45:37 INFO - Starting resource monitoring. 13:45:37 INFO - ##### 13:45:37 INFO - ##### Running install step. 13:45:37 INFO - ##### 13:45:37 INFO - Running pre-action listener: _resource_record_pre_action 13:45:37 INFO - Running main action method: install 13:45:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:45:37 INFO - Reading from file tmpfile_stdout 13:45:37 INFO - Detecting whether we're running mozinstall >=1.0... 13:45:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:45:38 INFO - Reading from file tmpfile_stdout 13:45:38 INFO - Output received: 13:45:38 INFO - Usage: mozinstall [options] installer 13:45:38 INFO - Options: 13:45:38 INFO - -h, --help show this help message and exit 13:45:38 INFO - -d DEST, --destination=DEST 13:45:38 INFO - Directory to install application into. [default: 13:45:38 INFO - "/builds/slave/test"] 13:45:38 INFO - --app=APP Application being installed. [default: firefox] 13:45:38 INFO - mkdir: /builds/slave/test/build/application 13:45:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:45:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:46:11 INFO - Reading from file tmpfile_stdout 13:46:11 INFO - Output received: 13:46:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:46:11 INFO - Running post-action listener: _resource_record_post_action 13:46:11 INFO - ##### 13:46:11 INFO - ##### Running run-tests step. 13:46:11 INFO - ##### 13:46:11 INFO - Running pre-action listener: _resource_record_pre_action 13:46:11 INFO - Running main action method: run_tests 13:46:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:46:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:46:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:46:11 INFO - 2016-04-28 13:46:11.307 screenresolution[2188:21439] starting screenresolution argv=screenresolution get 13:46:11 INFO - 2016-04-28 13:46:11.310 screenresolution[2188:21439] Display 0: 1600x1200x32@60 13:46:11 INFO - 2016-04-28 13:46:11.316 screenresolution[2189:21441] starting screenresolution argv=screenresolution list 13:46:11 INFO - Available Modes on Display 0 13:46:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:46:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:46:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:46:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:46:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:46:11 INFO - Intel Iris: 13:46:11 INFO - Chipset Model: Intel Iris 13:46:11 INFO - Type: GPU 13:46:11 INFO - Bus: Built-In 13:46:11 INFO - VRAM (Dynamic, Max): 1536 MB 13:46:11 INFO - Vendor: Intel (0x8086) 13:46:11 INFO - Device ID: 0x0a2e 13:46:11 INFO - Revision ID: 0x0009 13:46:11 INFO - Displays: 13:46:11 INFO - Display: 13:46:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:46:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:46:11 INFO - Display Serial Number: 1600x1200 60 13:46:11 INFO - Main Display: Yes 13:46:11 INFO - Mirror: Off 13:46:11 INFO - Online: Yes 13:46:11 INFO - Rotation: Supported 13:46:11 INFO - Return code: 0 13:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:46:11 INFO - Python 2.7.3 13:46:11 INFO - Return code: 0 13:46:11 INFO - grabbing minidump binary from tooltool 13:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:46:11 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ea5e00>, '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 0x105ccedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ea0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:46:11 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 13:46:11 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 13:46:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:46:11 INFO - Return code: 0 13:46:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:46:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:46:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:46:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:46:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:46:12 INFO - Return code: 0 13:46:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0164', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0164 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:46:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEVn7OCguR/Render', 13:46:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:46:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:46:12 INFO - 'HOME': '/Users/cltbld', 13:46:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:46:12 INFO - 'LOGNAME': 'cltbld', 13:46:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:46:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:46:12 INFO - 'MOZ_NO_REMOTE': '1', 13:46:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:46:12 INFO - 'NO_EM_RESTART': '1', 13:46:12 INFO - 'PAGER': '/bin/cat', 13:46:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:46:12 INFO - 'PWD': '/builds/slave/test', 13:46:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:46:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:46:12 INFO - 'SHELL': '/bin/bash', 13:46:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wSvhchxDGK/Listeners', 13:46:12 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 13:46:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:46:12 INFO - 'USER': 'cltbld', 13:46:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:46:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:46:12 INFO - 'XPC_FLAGS': '0x0', 13:46:12 INFO - 'XPC_SERVICE_NAME': '0', 13:46:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:46:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0164', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:46:12 INFO - mozversion application_buildid: 20160428112703 13:46:12 INFO - mozversion application_changeset: 6adc822f5e27a55551faeb6c47a9bd8b0859a23b 13:46:12 INFO - mozversion application_display_name: Nightly 13:46:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:46:12 INFO - mozversion application_name: Firefox 13:46:12 INFO - mozversion application_remotingname: firefox 13:46:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:46:12 INFO - mozversion application_vendor: Mozilla 13:46:12 INFO - mozversion application_version: 49.0a1 13:46:12 INFO - mozversion platform_buildid: 20160428112703 13:46:12 INFO - mozversion platform_changeset: 6adc822f5e27a55551faeb6c47a9bd8b0859a23b 13:46:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:46:12 INFO - mozversion platform_version: 49.0a1 13:46:12 INFO - using testdate: 1461876372 13:46:12 INFO - actual date: 1461876372 13:46:12 INFO - starting webserver on 'localhost:55483' 13:46:12 INFO - SUITE-START | Running 2 tests 13:46:12 INFO - TEST-START | dromaeo_css 13:46:12 INFO - operating with platform_type : mac_ 13:46:12 INFO - Initialising browser for dromaeo_css test... 13:46:12 INFO - TEST-INFO | started process 2207 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpDnitSp/profile http://localhost:55483/getInfo.html) 13:46:15 INFO - PROCESS | 2207 | __metrics Screen width/height:1600/1200 13:46:15 INFO - PROCESS | 2207 | colorDepth:24 13:46:15 INFO - PROCESS | 2207 | Browser inner width/height: 1024/689 13:46:15 INFO - PROCESS | 2207 | __metrics 13:46:15 INFO - PROCESS | 2207 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:46:15 ERROR - PROCESS | 2207 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:46:15 INFO - TEST-INFO | 2207: exit 0 13:46:15 INFO - Browser initialized. 13:46:15 INFO - Running cycle 1/1 for dromaeo_css test... 13:46:15 INFO - TEST-INFO | started process 2209 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpDnitSp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:46:27 INFO - PROCESS | 2209 | RSS: Main: 239546368 13:46:27 INFO - PROCESS | 2209 | 13:47:19 INFO - PROCESS | 2209 | 1461876439254 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] 13:49:29 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:55483/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55483/tests/dromaeo/cssquery-ext.html) 13:49:31 INFO - PROCESS | 2209 | RSS: Main: 348884992 13:49:31 INFO - PROCESS | 2209 | 13:52:34 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:55483/tests/dromaeo/cssquery-ext.html (next: http://localhost:55483/tests/dromaeo/cssquery-jquery.html) 13:52:34 INFO - PROCESS | 2209 | RSS: Main: 375447552 13:52:34 INFO - PROCESS | 2209 | 13:55:37 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:55483/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55483/tests/dromaeo/cssquery-mootools.html) 13:55:37 INFO - PROCESS | 2209 | RSS: Main: 370634752 13:55:37 INFO - PROCESS | 2209 | 13:58:40 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:55483/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55483/tests/dromaeo/cssquery-prototype.html) 13:58:40 INFO - PROCESS | 2209 | RSS: Main: 362307584 13:58:40 INFO - PROCESS | 2209 | 14:01:44 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:55483/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55483/tests/dromaeo/cssquery-yui.html) 14:01:44 INFO - PROCESS | 2209 | RSS: Main: 342892544 14:01:44 INFO - PROCESS | 2209 | 14:04:47 INFO - PROCESS | 2209 | Cycle 1(1): loaded http://localhost:55483/tests/dromaeo/cssquery-yui.html (next: http://localhost:55483/tests/dromaeo/cssquery-dojo.html) 14:04:47 INFO - PROCESS | 2209 | RSS: Main: 376877056 14:04:47 INFO - PROCESS | 2209 | 14:04:47 INFO - PROCESS | 2209 | __start_tp_report 14:04:47 INFO - PROCESS | 2209 | _x_x_mozilla_page_load 14:04:47 INFO - PROCESS | 2209 | _x_x_mozilla_page_load_details 14:04:47 INFO - PROCESS | 2209 | |i|pagename|runs| 14:04:47 INFO - PROCESS | 2209 | |0;dojo.html;3265.2000259936312;3321.8837340693094;3330.933381332373;3333.2666813301066;3381.2223188666608;5425.457454254582;5490.6431081979645;5499.175123731437;5527.50252477277;5536.9999999999945;5477.452254774521;5506.201600767887;5536.861578460541;5551.500364967153;5553.444655534445;5052.696838189702;5068;5106.591472682177;5137.99809037236;5161.535461808437;5079.6190285728535;5133.1786914093755;5156.69059856408;5162.561182299509;5169.48305169482;5098.847034588968;5135.05001574708;5139.4346621871755;5152.201408781645;5154.716490593016;4196.3705444183315;5160.303359046518;5167.328247327823;5178.689278643294;5232.947670523284;5007.123753343187;5051.772670229849;5119.283300337956;5121.769520371592;5122.795088196468;5411.377691565442;5434.83695489132;5446.537044351235;5456.727163641802;5485.01269771441;6008.939910600881;6046.244219472566;6058.1215723719815;6071.028635418312;6071.726772295257;5963.165156878041;6062.9090563641585;6111.663858487781;6130.8773824523705;6134.17188679527;5603.635763675348;5635.520980716603;5653.208550802891;5666.490015898547;5683.54531637468;6233.501319894398;6283.748650054038;6285.497160227171;6297.433231009231;6303.3066362700065;5100.642954993189;5732;5939.970300148471;5941.465268125889;5958.523318134538;6076.118962750376;6140.754369825247;6141.109539116803;6154.83058218937;6184.072389141665;5996.340402555803;5996.970015149984;6005.369436209223;6024.216851809237;6049.18336024631;5865.88268234633;5881.5882888198275;6015.1278064681255;6018.548608854353;6031.2159419276095;4769.213079841857;4775.307580400822;4805.687630304019;4814.831480898151;4819.228923372314;4348.195583817004;4360.149770794665;4415.271480205794;4444.622207112367;4449.7330160190495;5593.8321850344555;5596.300462442195;5599.552035837123;5600.747966341524;5616.410276920865;6031.5476339273855;6138.416850399205;6143.907841382383;6169.2288463942;6173.382661733881;5479.726013699299;5535.612507124543;5567.331920169606;5590.636608620427;5592.189132575753;5268.157094864803;5271.868203294948;5272.472752724773;5274.868128296746;5296;6279.7488100476385;6325;6328.240611126602;6333.050042493663;6335.049742538656;5990.31111422192;6118.2658081028785;6128.111423843607;6145.539084568586;6171.691415429121;6281.152044473937;6307.463865571478;6319.8104056878365;6342.112104305494;6348.111264422892;6028.668423236764;6034.517238620812;6047.183630209865;6055.364186760503;6057.151998720271;5977.193078934288;6064.636121832704;6106.82471942484;6131.202943617302;6134.191681013941;5851.297844258716;5894.557908156991;5898.203742494708;5907.822765317047;5946.256717910262;5849.6197747148;5888.998870191992;5896.498797602252;5902.085176797603;5918;5648.096304591246;5730.9397761414275;5784.797532086525;5819.0689489681445;5861.9706901465215;5768.653880767168;5897.882042359214;5933.199018132497;5941.0197317442135;6000.939990600038;5720.3421606515785;5805.332386775575;5821.854453638523;5824.70876456167;5829.970850145722 14:04:47 INFO - PROCESS | 2209 | |1;ext.html;522.2688236468942;529.4678847758003;581.1370115378662;592.9563967417345;619.1826788638996;30426.239344016383;37911.24177516448;39276.80361598195;39277.67945525993;39527.40708889369;43692.3446148308;44456.77771611138;44489.55510444895;44620.553794462045;44792.99999999992;8444.57777111142;9460.81078378432;9695;9699.951500242489;9704.27217958656;8471.15288471154;8621.224089831914;8629.266512346458;8637.870431943526;11089;11417.02955248805;11618.302901825875;11624.476898539586;11627.767444651103;11646.24299420535;11495.885041149566;11617.883821161764;11624.302541847432;11629.88370116305;11635.82546261811;8308.210719981593;11200.495977681025;11399.943000285028;11467.254628449124;11474.024707899838;40684.79657601723;41269.58730412687;41331.1733765323;41366.1726765466;41596.584034159576;3300.818454984975;3415.9487607685905;3485.093875592339;3525.4183059795105;3568.589612194605;28684.71315286841;28688.713112868812;28919.855400722863;28972.565411518844;29641.851790741122;2744.7118052604387;2763.8618069096465;2815.9296017599722;2881.236472334812;2956.054062699937;501718;502105.48947255395;504104;507880;507971;63298.4041914964;63693.68153159297;63807.361926380145;63947.68026159839;63947.68026159932;67449.25507449314;67459.98810017854;67553.31116722024;67669.66165169241;67690;14604.34280457382;16837.32650693983;17136.57158571046;17137.742933856003;17178.055206963487;11735.4132293385;11869.931706146488;11882.28706277626;11941;12610.558630448073;16918.74621880673;17121.315147393965;17251.82748172502;17353.7396939046;17383.826161738474;7324.2309557496765;7501.737439189711;7507.962460187773;7537.7386783965685;7605.505642133355;935.9110884465965;938.957746901391;972.7227740094039;1116.3971455413985;1167.6963989362828;24531.509369812506;25635.718214089222;27713.307167320574;27851.164465066082;27881.442371152465;1114.426070573639;1122.5173175534435;1123.1127409346525;1187.0325684567051;1276.6170148955275;14505.186851643544;14673.192974386511;14701.485448009269;14894.031887927467;14960.32678529447;517631;524668;645035;660742;664495;59454;59669.80660386768;59682.70158649266;59724.70137649284;59733;1345.0786211444995;1490.917999509994;1500.7748837674217;1508.1931166825696;1552.5187191970526;28617;28726.994555191304;29138.417231655672;29165.562516561844;29411.411771764873;47373.52626473829;47554.76222618865;47955.28067078927;47956.760216198694;47972.08111675494;373273;375919;377314;377715;377958;20028.59942801165;21228;22538.774612253666;25905.611415829153;26459.338516537242;43285.35071973986;43592.34611480894;43788;43824.78087609669;43827.34258986054;31453;35859.82070089633;37041.07397315089;37230;38347.61652383552;36217;36672.63327366692;37178.81410593038;37306.81346593249;37360.43959340558;35292.294154117284;35756.92729218127;36223.27553448864;36472.27055458823;37283.254334912606;26242.737572624028;29224.415511690073;31507.68492315139;31618.683813161573;31809.204769880937;24377;24425.022999079836;24693;24995.625065623666;25080.749192507843 14:04:47 INFO - PROCESS | 2209 | |2;jquery.html;344.2357965316995;390.58597886240585;395.7467220978576;398.7388260689249;409.07344863883327;19672.409827705156;21131.57736845262;21828.781712182874;21898.01458934348;21957.560848783036;20705;20774.688379674317;21758.673619895715;21780.237691680795;22000.229991950284;5736.340320863092;5896.734646940888;6156.292026416974;6166;6168.0439531872635;3935.3900145477355;4186.623203911648;5801.47786699197;6097.6951152442425;6151.753929842801;6143.969280153593;6146.969265153691;6147.231596050494;6147.262328520584;6165.506759459233;6400.39196276353;6700.262971073178;6701.93298067018;6706.161729783777;6722.294159113296;3842.3275926712713;5543.805966791143;5686;5862.648241105548;5883.176355310217;11040.447977601169;13751.587452376445;13764.31178441074;19801.702974455395;25656.74343256581;1977.149825575002;2100.4643815826867;2112.535242246703;2188.245055455865;2787;9678.370905891095;10182.439965801877;10275.22935779812;13201.669958251121;13638.977076719286;1600.4878438899557;1637.3941641592687;1676.1284132251162;1689.8056723476834;1764.3207365164376;101197.99999999926;118696.40651796685;118807;119266.40366798197;122491.3875430626;9945.254105942084;11663.650090497298;11693.181477296677;11747.17769756126;11884;15038.924805375904;15150.696986060217;15168.469103581543;15174.393024278905;15201.771973420407;8517.190866867637;8729.51987640686;8732.995705493822;8793.560321983876;8876.955615221883;8532.104129066483;8546.957265213634;8551.700690475804;8694.956525217334;8699.521526315986;4576.336431217454;4663.300504924288;4684.906301874012;4718.127146477913;4739.075880203396;1782.2710424449292;1809.6018875847292;1841.9171137298854;1879.6146789908037;2019.293247363411;933.2580598424269;938.3290946972947;983.9114479696862;1015.7206768138673;1034.182995433599;17085;18342.17460214267;19135.617287654168;19873.403797886087;20416.387508374773;940.4263399326405;946.3422921069928;962.7015625156224;998.2164001258977;1005.5726316315537;10368.170546356274;10822.729431764268;10831.2959657622;10835.916408359259;10862.782744345226;581165.7892500205;582367.1763282397;591755;594789;595191;123328.38335808263;125057;126034.3698281521;127254;131628.3418582901;989.317371013998;996.9750756231152;1015.7866847961863;1019.5717798524637;1021.8313978193515;17459.912700436416;17717.822821771617;17760.644787104444;17762.5559361017;18079.005654689117;49020;49460.75269623629;49517.752411237714;52256.73871630617;52926.00257956234;71062.64468677624;73301;74427;74623;74921.62539187487;8009.83857340694;8095.23095305945;8128.431009829492;8405.789855253668;8420.789480263042;9009.459432433812;11656.242344247597;12233.388330583613;12551.372431378211;12819.743605127658;10564.313319634199;10692.786144277226;10800.891991079989;10888.782224355311;10962.342259464458;10488.26582139243;10552.050315471644;10607.681769546925;10821.67534973952;10859.728506787078;10534.631287904887;10606.681799546026;10967.890321096687;11054.723631909266;11282.75889652154;8072.233137851895;8173.386995975445;8235.794105147419;8340.791480213044;8358.791030224293;9712.417254964725;10652.84020739674;10904.890951090705;10946.835797462885;10951.069159121564 14:04:47 INFO - PROCESS | 2209 | |3;mootools.html;1437.008464159729;1602.3910913852737;1623.54540728596;1905.752252207213;2047.1606641277078;7611.885821712672;8657.264132548733;8882.511461869595;8888.555572221396;8890.86663700045;8454.746357609267;8739.650413983432;8742.388032837687;8744.868826967584;8755.168259015383;1751.378260717446;2242.372135801978;2451.595486744685;2483.6522886795865;2492.47657991821;2484.7887929526014;2516.9748302517014;2517.8237523373373;2519.4709111086695;2523.974760252392;2440.4996975619956;2496.151308555091;2498.5502609530276;2511.208969174704;2518.874056297187;2031.878087314766;2162.956740865182;2394.9521009579885;2476.0962248779065;2478.1326535712537;2437.9390515237083;2463.322586288767;2486.5772818620876;2489.191012920808;2490.1657944588583;8682.30541556674;8773.780655483664;8784.47293162406;8786.956065219632;8790;4238.554951730086;5332.120200166968;5489.1217405215375;5522.3649280332875;5528.143137813605;2959.9704002960125;3448.81031543265;3624.2932628137523;3686.668199862025;3714.5542534895717;998.5057396588662;1005.2360206243235;1016.4104819204917;1059.4914441068331;1072.7908057928707;11809.763804723943;11823.822642660367;11825.526978920832;11831.763364732657;11885.881141188564;4826.493218212107;4920.089783390084;4993.400791904995;5021.573166280907;5022.271770593244;10134.493275336205;10144.492775361203;10148.949255253825;10184.134348580454;10188.796224075477;5467.371252305956;5510.724463776795;5525.834224973177;5549.833504994856;5557.166425036277;4476.865694029184;4681.32120842476;4873.658843880894;5022.648414611015;5033.647644664911;4035.21313343901;4066.2477441672795;4152.546608686996;4186.476690413699;4234.428352172479;1350.4463170100212;1387.209290704309;1389.9652508687363;1401.2153194211273;1402.2217669193697;812.7074253268937;932.1424289653535;946.3943076430952;957.2103015012642;999.6501224571342;5880.117982302689;5935.614185077956;6053.092036194606;6099.664518451527;6253.624782513064;993.6522217224058;998.8551660009258;1029.9279050466546;1050.5272627317738;1086.7120213143523;3851.691864650821;3862.806859657006;3879.786611736325;3908.843646254175;3923.372260438316;10245.334053286513;10352.948235258926;10711.303765255234;10832.512536935857;10835.349879007284;10011.599536018623;10421.895781042243;10630.362178269328;10634.840477392845;10751.0324070834;8210.876836847452;8307.626156822958;8361.03848057469;8361.707340243061;8372.079071302152;4805.831795887128;5561.610687251854;5690;5736.541076713769;5832.795852145155;8462.53456059898;9219.86170207434;9855.901440985499;10296.485175741333;10324.328918620266;10165.898341016495;10301.175905927357;10417.270791044857;10467.267291289536;10476.371417714656;7008.929910700827;7107.253738357605;7162.677679504331;7198.748043818441;7209.963950180216;8246.83506329882;8273.172682731678;8369.539675317916;8380.120087390736;8382.077971423261;7325.340719335285;7522.623868806647;7609.353204977639;7726.072871255486;7739.41954353437;7294;7414.629268536443;7427.368673662799;7586.468947173645;7630.2751238632245;6972.4073453757;7066.364027237573;7150.213476517475;7150.392216661642;7152.463565232524;4824.445188803333;4832.758362081952;4962.6774259673;4985.850424487271;5001.174806157089;4851.345068415719;4881.609471242363;5023.995200959749;5037.848864534069;5267.473252674702 14:04:47 INFO - PROCESS | 2209 | |4;prototype.html;320.2058893943021;321.10572056821746;327.6575978102882;328.8569472279559;333.51307091646197;5289.365276166861;5298.23175639533;5330.227117068028;5354.678719276846;5365;4880.609551235902;5030.874228144298;5256.316678831747;5271.367435907687;5316.282301889244;3880.6715970417804;3911.4132880068073;4002.2395744808537;4090.9386359204486;4118.979405102985;3055.4500189965797;3580.874669386572;4087.589781525384;4100.63094321511;4130.917381652365;3635.4365073413665;3669.8439991402756;3825.445310429986;3903.668188204006;4114.835406583733;3536.7877927324316;3835.9041023974623;3905.2775236581183;3994.7003974702016;4021.3766866135797;3056.510958246692;3516;3577.338192434408;3582.158192824684;3635.291118231946;5116.488351164891;5123.692578445305;5128.5640720538795;5143.742812859379;5201.479852014768;3538.7127608730298;4040.7979601020124;4278.272693642089;4642.744649044335;4765.785539650724;4506.436695413074;5110.390227078458;5275.683458992473;5505.752241149158;5543.223948647153;3945.447637330776;3945.4946109220564;3985.04358953849;3985.5815139410233;3988.9229907924987;5455;5537.889242215173;5586.553075753889;5902.852428689317;5916.733746981353;3985.501812273466;3995.6004399560393;3996.86010989614;3997.8600748973645;4011.157656892027;4049.190161967618;4067.678004648501;4071.0229544909603;4078.632923036941;4091.5908409158847;4398.406215160912;4653.627709783209;4679.660169915042;4679.67242293043;4705.976470117627;5159.491545748851;5362.812301569426;5472.753726082336;5647.407022262603;5660.85847853807;1469.2727100085312;1498.1385703220692;1498.7002599480147;1506.6308754355034;1507.3141720517137;929.6334388448969;966.5988614724951;1005.5123265216364;1008.3395376028712;1018.2719355660738;5095.31213286209;5197.8440646780655;5268.2097685346735;5278.4721527846905;5527.397054854047;5746.856328591819;5784.942150578525;5795.275590551181;5808.427816892665;5834.299884013861;4674;4968.031233909425;4988.603191106496;5190.429052804188;5357.1696387060065;3324.268660894599;3329.4850842866435;3335.666433356645;3343.278211720966;3348.961821835239;5794.913076303775;6307.4954003679595;6518;6615.768448104293;6656.500762442836;5900;5965.13505541694;6512.381323774234;6527.2167339919515;6571.9671401643645;6561.770338038145;6590.604563726191;6605.8348541285895;6623.43700785429;6696.794576976191;4857.80215169765;4886.706797592014;5410.702411367412;5840.561957853093;6284.637718820409;5746.798862039808;5804.361520232856;5817.738201780845;5819.098039803837;5820.214271073521;5007.749612519432;5909.852253693692;6069.939300606938;6086.695665216633;6091.238595175603;3441.7934923904645;3755.2489502099143;3907.5115610548683;3959.8614048509316;3962.841486340514;4895.779689913891;5815.883682326415;5860.120981852756;5912.70436478183;5941.346451890202;4366.009283640717;4705.576498115186;5651.012213733028;5755.827325180251;5765.365809761007;4480.686351955332;5181.689098654093;5461.208124821958;5678.290213723285;5705.600607957404;4644.767761611974;5547.306586676666;5566.276384070045;5571.637843540157;5605.299337582802;4625.190591646381;4924.433690125538;5100.48995100487;5622.437756224344;5626.831195064155;4905.566103727477;5530.585206109477;5552.083906155601;5557.221988921473;5653.915191272052 14:04:47 INFO - PROCESS | 2209 | |5;yui.html;665.5607299182539;697.560536861777;734.7501849371213;749.0674110732143;755.953005087953;12038;12219.938900305497;13509.59471215865;14471.204083775388;14774.335154918028;13861.930690346559;14038.649033774162;14082.57752267431;14088.36602352894;14109.858901410982;759.2748924776853;790.683726509398;950.9857352139707;965.6861520005991;970.0396607358699;928.535732133933;968.6125549780074;968.7529679931607;970.6457143142773;976.5263847034183;1006.4112494190871;1013.285633628294;1021.3463383434607;1021.5862575656834;1023.0843395161326;792.3423558446505;957.9185769209626;1007.0483393193399;1011.9241056920723;1023.150784848574;746.0413368821094;747.8990336304583;748.3152915082693;750.3959312753232;752.6575408189316;13947.860521394758;13963.860361396357;13975.65060873476;13987.300634968211;14013.719725605533;12040.638780836589;12146;12229.510819567207;12332.506699732;12338.383080845922;10723.03492685662;10861.86422919185;10906.563737450493;10946.4526773661;11629.825552616718;2897.478453878301;4050.797460126982;4060.1473690525027;4189.539150693421;4393.143337049277;82674;83237;84081.99999999939;84454.73317900236;84717;7914;9559;9633.421994680202;9713.90286097144;9911.752206194758;22465.775342246696;22487.212947547083;22490.775092249194;22499.88750056272;22507.887460562593;7456.440766942501;7508.511946723445;7518.060242469692;7594.696212151563;7675.309222170032;3090.90727278182;4097.610726980932;4099.733517321424;4111.1366613011005;4114.248043509751;3653.634636536325;3731.570869350005;3733.141377483194;3735.0662334416397;3738.775673459601;484.3074403602882;630.9432151106422;650.5836264790538;689.1936434371797;690.3062422265591;502.43977964569973;572.985675358111;592.4963780786297;607.1924340626956;607.9513638908877;7986.880196797053;8101.326562234449;8197.83604327922;8324.334053275723;8341.708040218564;474.232851312588;576.4898065212317;589.1575047681856;597.7071235094772;626.589583822597;3810.1427178885083;3811;3826.463475795368;3857.0550215196895;4066.552679205285;89674.20651586931;90141.19717605611;91750;97645.51177244069;99363;79627.8055829163;80232.19767802248;82821;83130;83484;69876;71599.64200178966;72079;72350.63824680843;73115.68843115646;7659.578723170279;7663.233676632515;7696.057946789264;7885.2114788520685;7911.485753426239;34149.80475683339;34894.825525872206;45108.77445612751;45510.317345239186;45513.40703075376;61378.38621613727;61387.69306153619;61642.4589385269;62088.379116208256;63320;10448.42533660656;10665.093467055387;10708.30396024256;10838.891611083789;10841.67474975752;10377.481125943521;10484.42335671515;11041.06150977176;11172.888271117185;11316.83024754613;8752.862127923328;9886.604535818775;10395.792084158124;10483;10636.52135653913;10270.33242839213;10346.844797327896;10387;10413.9479302603;10763;10104.69685909424;10285.331453455501;10341.172706183637;10607.575696972035;10659.840102398626;8846.601902914514;8895.688650897187;8950.462972221687;9303.209227215491;9314.301427393108;8685;8737.475751454933;8801.40408796424;8809.383343165917;8979.775505612412 14:04:47 INFO - PROCESS | 2209 | __end_tp_report 14:04:47 INFO - PROCESS | 2209 | __start_cc_report 14:04:47 INFO - PROCESS | 2209 | _x_x_mozilla_cycle_collect,1160 14:04:47 INFO - PROCESS | 2209 | __end_cc_report 14:04:47 INFO - PROCESS | 2209 | __startTimestamp1461877487736__endTimestamp 14:04:47 INFO - PROCESS | 2209 | 14:04:47 INFO - PROCESS | 2209 | ------- Summary: start ------- 14:04:47 INFO - PROCESS | 2209 | Number of tests: 6 14:04:47 INFO - PROCESS | 2209 | 14:04:47 INFO - PROCESS | 2209 | [#0] dojo.html Cycles:165 Average:5608.15 Median:5805.33 stddev:626.66 (10.8%) stddev-sans-first:601.02 14:04:47 INFO - PROCESS | 2209 | Values: 3265.2 3321.9 3330.9 3333.3 3381.2 5425.5 5490.6 5499.2 5527.5 5537.0 5477.5 5506.2 5536.9 5551.5 5553.4 5052.7 5068.0 5106.6 5138.0 5161.5 5079.6 5133.2 5156.7 5162.6 5169.5 5098.8 5135.1 5139.4 5152.2 5154.7 4196.4 5160.3 5167.3 5178.7 5232.9 5007.1 5051.8 5119.3 5121.8 5122.8 5411.4 5434.8 5446.5 5456.7 5485.0 6008.9 6046.2 6058.1 6071.0 6071.7 5963.2 6062.9 6111.7 6130.9 6134.2 5603.6 5635.5 5653.2 5666.5 5683.5 6233.5 6283.7 6285.5 6297.4 6303.3 5100.6 5732.0 5940.0 5941.5 5958.5 6076.1 6140.8 6141.1 6154.8 6184.1 5996.3 5997.0 6005.4 6024.2 6049.2 5865.9 5881.6 6015.1 6018.5 6031.2 4769.2 4775.3 4805.7 4814.8 4819.2 4348.2 4360.1 4415.3 4444.6 4449.7 5593.8 5596.3 5599.6 5600.7 5616.4 6031.5 6138.4 6143.9 6169.2 6173.4 5479.7 5535.6 5567.3 5590.6 5592.2 5268.2 5271.9 5272.5 5274.9 5296.0 6279.7 6325.0 6328.2 6333.1 6335.0 5990.3 6118.3 6128.1 6145.5 6171.7 6281.2 6307.5 6319.8 6342.1 6348.1 6028.7 6034.5 6047.2 6055.4 6057.2 5977.2 6064.6 6106.8 6131.2 6134.2 5851.3 5894.6 5898.2 5907.8 5946.3 5849.6 5889.0 5896.5 5902.1 5918.0 5648.1 5730.9 5784.8 5819.1 5862.0 5768.7 5897.9 5933.2 5941.0 6000.9 5720.3 5805.3 5821.9 5824.7 5830.0 14:04:47 INFO - PROCESS | 2209 | 14:04:47 INFO - PROCESS | 2209 | [#1] ext.html Cycles:180 Average:63664.67 Median:35808.37 stddev:134696.80 (376.2%) stddev-sans-first:134991.23 14:04:47 INFO - PROCESS | 2209 | Values: 522.3 529.5 581.1 593.0 619.2 30426.2 37911.2 39276.8 39277.7 39527.4 43692.3 44456.8 44489.6 44620.6 44793.0 8444.6 9460.8 9695.0 9700.0 9704.3 8471.2 8621.2 8629.3 8637.9 11089.0 11417.0 11618.3 11624.5 11627.8 11646.2 11495.9 11617.9 11624.3 11629.9 11635.8 8308.2 11200.5 11399.9 11467.3 11474.0 40684.8 41269.6 41331.2 41366.2 41596.6 3300.8 3415.9 3485.1 3525.4 3568.6 28684.7 28688.7 28919.9 28972.6 29641.9 2744.7 2763.9 2815.9 2881.2 2956.1 501718.0 502105.5 504104.0 507880.0 507971.0 63298.4 63693.7 63807.4 63947.7 63947.7 67449.3 67460.0 67553.3 67669.7 67690.0 14604.3 16837.3 17136.6 17137.7 17178.1 11735.4 11869.9 11882.3 11941.0 12610.6 16918.7 17121.3 17251.8 17353.7 17383.8 7324.2 7501.7 7508.0 7537.7 7605.5 935.9 939.0 972.7 1116.4 1167.7 24531.5 25635.7 27713.3 27851.2 27881.4 1114.4 1122.5 1123.1 1187.0 1276.6 14505.2 14673.2 14701.5 14894.0 14960.3 517631.0 524668.0 645035.0 660742.0 664495.0 59454.0 59669.8 59682.7 59724.7 59733.0 1345.1 1490.9 1500.8 1508.2 1552.5 28617.0 28727.0 29138.4 29165.6 29411.4 47373.5 47554.8 47955.3 47956.8 47972.1 373273.0 375919.0 377314.0 377715.0 377958.0 20028.6 21228.0 22538.8 25905.6 26459.3 43285.4 43592.3 43788.0 43824.8 43827.3 31453.0 35859.8 37041.1 37230.0 38347.6 36217.0 36672.6 37178.8 37306.8 37360.4 35292.3 35756.9 36223.3 36472.3 37283.3 26242.7 29224.4 31507.7 31618.7 31809.2 24377.0 24425.0 24693.0 24995.6 25080.7 14:04:47 INFO - PROCESS | 2209 | 14:04:47 INFO - PROCESS | 2209 | [#2] jquery.html Cycles:180 Average:34239.95 Median:12008.51 stddev:98309.94 (818.7%) stddev-sans-first:98552.78 14:04:47 INFO - PROCESS | 2209 | Values: 344.2 390.6 395.7 398.7 409.1 19672.4 21131.6 21828.8 21898.0 21957.6 20705.0 20774.7 21758.7 21780.2 22000.2 5736.3 5896.7 6156.3 6166.0 6168.0 3935.4 4186.6 5801.5 6097.7 6151.8 6144.0 6147.0 6147.2 6147.3 6165.5 6400.4 6700.3 6701.9 6706.2 6722.3 3842.3 5543.8 5686.0 5862.6 5883.2 11040.4 13751.6 13764.3 19801.7 25656.7 1977.1 2100.5 2112.5 2188.2 2787.0 9678.4 10182.4 10275.2 13201.7 13639.0 1600.5 1637.4 1676.1 1689.8 1764.3 101198.0 118696.4 118807.0 119266.4 122491.4 9945.3 11663.7 11693.2 11747.2 11884.0 15038.9 15150.7 15168.5 15174.4 15201.8 8517.2 8729.5 8733.0 8793.6 8877.0 8532.1 8547.0 8551.7 8695.0 8699.5 4576.3 4663.3 4684.9 4718.1 4739.1 1782.3 1809.6 1841.9 1879.6 2019.3 933.3 938.3 983.9 1015.7 1034.2 17085.0 18342.2 19135.6 19873.4 20416.4 940.4 946.3 962.7 998.2 1005.6 10368.2 10822.7 10831.3 10835.9 10862.8 581165.8 582367.2 591755.0 594789.0 595191.0 123328.4 125057.0 126034.4 127254.0 131628.3 989.3 997.0 1015.8 1019.6 1021.8 17459.9 17717.8 17760.6 17762.6 18079.0 49020.0 49460.8 49517.8 52256.7 52926.0 71062.6 73301.0 74427.0 74623.0 74921.6 8009.8 8095.2 8128.4 8405.8 8420.8 9009.5 11656.2 12233.4 12551.4 12819.7 10564.3 10692.8 10800.9 10888.8 10962.3 10488.3 10552.1 10607.7 10821.7 10859.7 10534.6 10606.7 10967.9 11054.7 11282.8 8072.2 8173.4 8235.8 8340.8 8358.8 9712.4 10652.8 10904.9 10946.8 10951.1 14:04:47 INFO - PROCESS | 2209 | 14:04:47 INFO - PROCESS | 2209 | [#3] mootools.html Cycles:180 Average:5743.40 Median:4842.05 stddev:3182.98 (65.7%) stddev-sans-first:3175.46 14:04:47 INFO - PROCESS | 2209 | Values: 1437.0 1602.4 1623.5 1905.8 2047.2 7611.9 8657.3 8882.5 8888.6 8890.9 8454.7 8739.7 8742.4 8744.9 8755.2 1751.4 2242.4 2451.6 2483.7 2492.5 2484.8 2517.0 2517.8 2519.5 2524.0 2440.5 2496.2 2498.6 2511.2 2518.9 2031.9 2163.0 2395.0 2476.1 2478.1 2437.9 2463.3 2486.6 2489.2 2490.2 8682.3 8773.8 8784.5 8787.0 8790.0 4238.6 5332.1 5489.1 5522.4 5528.1 2960.0 3448.8 3624.3 3686.7 3714.6 998.5 1005.2 1016.4 1059.5 1072.8 11809.8 11823.8 11825.5 11831.8 11885.9 4826.5 4920.1 4993.4 5021.6 5022.3 10134.5 10144.5 10148.9 10184.1 10188.8 5467.4 5510.7 5525.8 5549.8 5557.2 4476.9 4681.3 4873.7 5022.6 5033.6 4035.2 4066.2 4152.5 4186.5 4234.4 1350.4 1387.2 1390.0 1401.2 1402.2 812.7 932.1 946.4 957.2 999.7 5880.1 5935.6 6053.1 6099.7 6253.6 993.7 998.9 1029.9 1050.5 1086.7 3851.7 3862.8 3879.8 3908.8 3923.4 10245.3 10352.9 10711.3 10832.5 10835.3 10011.6 10421.9 10630.4 10634.8 10751.0 8210.9 8307.6 8361.0 8361.7 8372.1 4805.8 5561.6 5690.0 5736.5 5832.8 8462.5 9219.9 9855.9 10296.5 10324.3 10165.9 10301.2 10417.3 10467.3 10476.4 7008.9 7107.3 7162.7 7198.7 7210.0 8246.8 8273.2 8369.5 8380.1 8382.1 7325.3 7522.6 7609.4 7726.1 7739.4 7294.0 7414.6 7427.4 7586.5 7630.3 6972.4 7066.4 7150.2 7150.4 7152.5 4824.4 4832.8 4962.7 4985.9 5001.2 4851.3 4881.6 5024.0 5037.8 5267.5 14:04:47 INFO - PROCESS | 2209 | 14:04:47 INFO - PROCESS | 2209 | [#4] prototype.html Cycles:180 Average:4624.87 Median:5097.90 stddev:1431.47 (28.1%) stddev-sans-first:1398.54 14:04:47 INFO - PROCESS | 2209 | Values: 320.2 321.1 327.7 328.9 333.5 5289.4 5298.2 5330.2 5354.7 5365.0 4880.6 5030.9 5256.3 5271.4 5316.3 3880.7 3911.4 4002.2 4090.9 4119.0 3055.5 3580.9 4087.6 4100.6 4130.9 3635.4 3669.8 3825.4 3903.7 4114.8 3536.8 3835.9 3905.3 3994.7 4021.4 3056.5 3516.0 3577.3 3582.2 3635.3 5116.5 5123.7 5128.6 5143.7 5201.5 3538.7 4040.8 4278.3 4642.7 4765.8 4506.4 5110.4 5275.7 5505.8 5543.2 3945.4 3945.5 3985.0 3985.6 3988.9 5455.0 5537.9 5586.6 5902.9 5916.7 3985.5 3995.6 3996.9 3997.9 4011.2 4049.2 4067.7 4071.0 4078.6 4091.6 4398.4 4653.6 4679.7 4679.7 4706.0 5159.5 5362.8 5472.8 5647.4 5660.9 1469.3 1498.1 1498.7 1506.6 1507.3 929.6 966.6 1005.5 1008.3 1018.3 5095.3 5197.8 5268.2 5278.5 5527.4 5746.9 5784.9 5795.3 5808.4 5834.3 4674.0 4968.0 4988.6 5190.4 5357.2 3324.3 3329.5 3335.7 3343.3 3349.0 5794.9 6307.5 6518.0 6615.8 6656.5 5900.0 5965.1 6512.4 6527.2 6572.0 6561.8 6590.6 6605.8 6623.4 6696.8 4857.8 4886.7 5410.7 5840.6 6284.6 5746.8 5804.4 5817.7 5819.1 5820.2 5007.7 5909.9 6069.9 6086.7 6091.2 3441.8 3755.2 3907.5 3959.9 3962.8 4895.8 5815.9 5860.1 5912.7 5941.3 4366.0 4705.6 5651.0 5755.8 5765.4 4480.7 5181.7 5461.2 5678.3 5705.6 4644.8 5547.3 5566.3 5571.6 5605.3 4625.2 4924.4 5100.5 5622.4 5626.8 4905.6 5530.6 5552.1 5557.2 5653.9 14:04:47 INFO - PROCESS | 2209 | 14:04:47 INFO - PROCESS | 2209 | [#5] yui.html Cycles:180 Average:17972.11 Median:582.82 stddev:25897.61 (4443.5%) stddev-sans-first:25937.66 14:04:47 INFO - PROCESS | 2209 | Values: 665.6 697.6 734.8 749.1 756.0 12038.0 12219.9 13509.6 14471.2 14774.3 13861.9 14038.6 14082.6 14088.4 14109.9 759.3 790.7 951.0 965.7 970.0 928.5 968.6 968.8 970.6 976.5 1006.4 1013.3 1021.3 1021.6 1023.1 792.3 957.9 1007.0 1011.9 1023.2 746.0 747.9 748.3 750.4 752.7 13947.9 13963.9 13975.7 13987.3 14013.7 12040.6 12146.0 12229.5 12332.5 12338.4 10723.0 10861.9 10906.6 10946.5 11629.8 2897.5 4050.8 4060.1 4189.5 4393.1 82674.0 83237.0 84082.0 84454.7 84717.0 7914.0 9559.0 9633.4 9713.9 9911.8 22465.8 22487.2 22490.8 22499.9 22507.9 7456.4 7508.5 7518.1 7594.7 7675.3 3090.9 4097.6 4099.7 4111.1 4114.2 3653.6 3731.6 3733.1 3735.1 3738.8 484.3 630.9 650.6 689.2 690.3 502.4 573.0 592.5 607.2 608.0 7986.9 8101.3 8197.8 8324.3 8341.7 474.2 576.5 589.2 597.7 626.6 3810.1 3811.0 3826.5 3857.1 4066.6 89674.2 90141.2 91750.0 97645.5 99363.0 79627.8 80232.2 82821.0 83130.0 83484.0 69876.0 71599.6 72079.0 72350.6 73115.7 7659.6 7663.2 7696.1 7885.2 7911.5 34149.8 34894.8 45108.8 45510.3 45513.4 61378.4 61387.7 61642.5 62088.4 63320.0 10448.4 10665.1 10708.3 10838.9 10841.7 10377.5 10484.4 11041.1 11172.9 11316.8 8752.9 9886.6 10395.8 10483.0 10636.5 10270.3 10346.8 10387.0 10413.9 10763.0 10104.7 10285.3 10341.2 10607.6 10659.8 8846.6 8895.7 8950.5 9303.2 9314.3 8685.0 8737.5 8801.4 8809.4 8979.8 14:04:47 INFO - PROCESS | 2209 | -------- Summary: end -------- 14:04:47 INFO - PROCESS | 2209 | 14:04:48 INFO - TEST-INFO | 2209: exit 0 14:04:48 INFO - TEST-OK | dromaeo_css | took 1115413ms 14:04:48 INFO - TEST-START | kraken 14:04:48 INFO - operating with platform_type : mac_ 14:04:48 INFO - Initialising browser for kraken test... 14:04:48 INFO - TEST-INFO | started process 2212 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpAE0Uma/profile http://localhost:55483/getInfo.html) 14:04:50 INFO - PROCESS | 2212 | __metrics Screen width/height:1600/1200 14:04:50 INFO - PROCESS | 2212 | colorDepth:24 14:04:50 INFO - PROCESS | 2212 | Browser inner width/height: 1024/689 14:04:50 INFO - PROCESS | 2212 | __metrics 14:04:50 INFO - PROCESS | 2212 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:04:50 ERROR - PROCESS | 2212 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:04:51 INFO - TEST-INFO | 2212: exit 0 14:04:51 INFO - Browser initialized. 14:04:51 INFO - Running cycle 1/1 for kraken test... 14:04:51 INFO - TEST-INFO | started process 2214 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpAE0Uma/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:05:03 INFO - PROCESS | 2214 | RSS: Main: 239435776 14:05:03 INFO - PROCESS | 2214 | 14:05:05 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:55483/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55483/tests/kraken/driver.html?testName=audio-beat-detection) 14:05:06 INFO - PROCESS | 2214 | RSS: Main: 286961664 14:05:06 INFO - PROCESS | 2214 | 14:05:09 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:55483/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55483/tests/kraken/driver.html?testName=audio-dft) 14:05:10 INFO - PROCESS | 2214 | RSS: Main: 295833600 14:05:10 INFO - PROCESS | 2214 | 14:05:13 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:55483/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55483/tests/kraken/driver.html?testName=audio-fft) 14:05:14 INFO - PROCESS | 2214 | RSS: Main: 381280256 14:05:14 INFO - PROCESS | 2214 | 14:05:16 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:55483/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55483/tests/kraken/driver.html?testName=audio-oscillator) 14:05:16 INFO - PROCESS | 2214 | RSS: Main: 279896064 14:05:16 INFO - PROCESS | 2214 | 14:05:19 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:55483/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55483/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:05:19 INFO - PROCESS | 2214 | RSS: Main: 283729920 14:05:19 INFO - PROCESS | 2214 | 14:05:22 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:55483/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55483/tests/kraken/driver.html?testName=imaging-darkroom) 14:05:23 INFO - PROCESS | 2214 | RSS: Main: 320495616 14:05:23 INFO - PROCESS | 2214 | 14:05:25 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:55483/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55483/tests/kraken/driver.html?testName=imaging-desaturate) 14:05:26 INFO - PROCESS | 2214 | RSS: Main: 323530752 14:05:26 INFO - PROCESS | 2214 | 14:05:29 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:55483/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55483/tests/kraken/driver.html?testName=json-parse-financial) 14:05:29 INFO - PROCESS | 2214 | RSS: Main: 319705088 14:05:29 INFO - PROCESS | 2214 | 14:05:31 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:55483/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55483/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:05:32 INFO - PROCESS | 2214 | RSS: Main: 313171968 14:05:32 INFO - PROCESS | 2214 | 14:05:33 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:55483/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55483/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:05:34 INFO - PROCESS | 2214 | RSS: Main: 320331776 14:05:34 INFO - PROCESS | 2214 | 14:05:36 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:55483/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55483/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:05:37 INFO - PROCESS | 2214 | RSS: Main: 321658880 14:05:37 INFO - PROCESS | 2214 | 14:05:40 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:55483/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55483/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:05:40 INFO - PROCESS | 2214 | RSS: Main: 327454720 14:05:40 INFO - PROCESS | 2214 | 14:05:43 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:55483/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55483/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:05:44 INFO - PROCESS | 2214 | RSS: Main: 324378624 14:05:44 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | Cycle 1(1): loaded http://localhost:55483/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55483/tests/kraken/driver.html?testName=ai-astar) 14:05:46 INFO - PROCESS | 2214 | RSS: Main: 388755456 14:05:46 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | __start_tp_report 14:05:46 INFO - PROCESS | 2214 | _x_x_mozilla_page_load 14:05:46 INFO - PROCESS | 2214 | _x_x_mozilla_page_load_details 14:05:46 INFO - PROCESS | 2214 | |i|pagename|runs| 14:05:46 INFO - PROCESS | 2214 | |0;ai-astar;113;113;106;111;112;111;112;113;105;112 14:05:46 INFO - PROCESS | 2214 | |1;audio-beat-detection;161;123;150;203;150;169;140;122;213;117 14:05:46 INFO - PROCESS | 2214 | |2;audio-dft;189;185;184;183;185;181;188;181;185;182 14:05:46 INFO - PROCESS | 2214 | |3;audio-fft;73;75;89;98;83;118;84;90;89;56 14:05:46 INFO - PROCESS | 2214 | |4;audio-oscillator;89;101;136;78;80;81;125;80;77;130 14:05:46 INFO - PROCESS | 2214 | |5;imaging-gaussian-blur;87;88;88;86;86;84;88;85;94;83 14:05:46 INFO - PROCESS | 2214 | |6;imaging-darkroom;93;93;93;93;93;93;93;94;92;92 14:05:46 INFO - PROCESS | 2214 | |7;imaging-desaturate;87;84;84;85;84;83;85;86;87;88 14:05:46 INFO - PROCESS | 2214 | |8;json-parse-financial;57;58;59;59;60;60;60;79;58;56 14:05:46 INFO - PROCESS | 2214 | |9;json-stringify-tinderbox;66;65;82;74;70;68;68;68;70;70 14:05:46 INFO - PROCESS | 2214 | |10;stanford-crypto-aes;83;83;82;81;82;80;82;82;82;83 14:05:46 INFO - PROCESS | 2214 | |11;stanford-crypto-ccm;156;157;125;157;152;122;141;129;163;148 14:05:46 INFO - PROCESS | 2214 | |12;stanford-crypto-pbkdf2;169;185;186;202;170;170;167;209;166;169 14:05:46 INFO - PROCESS | 2214 | |13;stanford-crypto-sha256-iterative;69;68;72;81;101;98;101;75;67;66 14:05:46 INFO - PROCESS | 2214 | __end_tp_report 14:05:46 INFO - PROCESS | 2214 | __start_cc_report 14:05:46 INFO - PROCESS | 2214 | _x_x_mozilla_cycle_collect,2031 14:05:46 INFO - PROCESS | 2214 | __end_cc_report 14:05:46 INFO - PROCESS | 2214 | __startTimestamp1461877546552__endTimestamp 14:05:46 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | ------- Summary: start ------- 14:05:46 INFO - PROCESS | 2214 | Number of tests: 14 14:05:46 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:2.90 (2.6%) stddev-sans-first:2.96 14:05:46 INFO - PROCESS | 2214 | Values: 113.0 113.0 106.0 111.0 112.0 111.0 112.0 113.0 105.0 112.0 14:05:46 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:155.50 stddev:32.88 (21.1%) stddev-sans-first:34.80 14:05:46 INFO - PROCESS | 2214 | Values: 161.0 123.0 150.0 203.0 150.0 169.0 140.0 122.0 213.0 117.0 14:05:46 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:2.71 (1.5%) stddev-sans-first:2.28 14:05:46 INFO - PROCESS | 2214 | Values: 189.0 185.0 184.0 183.0 185.0 181.0 188.0 181.0 185.0 182.0 14:05:46 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | [#3] audio-fft Cycles:10 Average:85.50 Median:86.50 stddev:16.34 (18.9%) stddev-sans-first:16.69 14:05:46 INFO - PROCESS | 2214 | Values: 73.0 75.0 89.0 98.0 83.0 118.0 84.0 90.0 89.0 56.0 14:05:46 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:79.00 stddev:23.72 (30.0%) stddev-sans-first:24.95 14:05:46 INFO - PROCESS | 2214 | Values: 89.0 101.0 136.0 78.0 80.0 81.0 125.0 80.0 77.0 130.0 14:05:46 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:87.50 stddev:3.03 (3.5%) stddev-sans-first:3.22 14:05:46 INFO - PROCESS | 2214 | Values: 87.0 88.0 88.0 86.0 86.0 84.0 88.0 85.0 94.0 83.0 14:05:46 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 14:05:46 INFO - PROCESS | 2214 | Values: 93.0 93.0 93.0 93.0 93.0 93.0 93.0 94.0 92.0 92.0 14:05:46 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.50 stddev:1.64 (1.9%) stddev-sans-first:1.62 14:05:46 INFO - PROCESS | 2214 | Values: 87.0 84.0 84.0 85.0 84.0 83.0 85.0 86.0 87.0 88.0 14:05:46 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:59.50 stddev:6.60 (11.1%) stddev-sans-first:6.87 14:05:46 INFO - PROCESS | 2214 | Values: 57.0 58.0 59.0 59.0 60.0 60.0 60.0 79.0 58.0 56.0 14:05:46 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:4.86 (6.9%) stddev-sans-first:4.93 14:05:46 INFO - PROCESS | 2214 | Values: 66.0 65.0 82.0 74.0 70.0 68.0 68.0 68.0 70.0 70.0 14:05:46 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:0.94 (1.1%) stddev-sans-first:0.93 14:05:46 INFO - PROCESS | 2214 | Values: 83.0 83.0 82.0 81.0 82.0 80.0 82.0 82.0 82.0 83.0 14:05:46 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:154.00 stddev:14.88 (9.7%) stddev-sans-first:15.24 14:05:46 INFO - PROCESS | 2214 | Values: 156.0 157.0 125.0 157.0 152.0 122.0 141.0 129.0 163.0 148.0 14:05:46 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:177.50 stddev:15.59 (8.8%) stddev-sans-first:16.09 14:05:46 INFO - PROCESS | 2214 | Values: 169.0 185.0 186.0 202.0 170.0 170.0 167.0 209.0 166.0 169.0 14:05:46 INFO - PROCESS | 2214 | 14:05:46 INFO - PROCESS | 2214 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.80 Median:70.50 stddev:14.63 (20.7%) stddev-sans-first:14.98 14:05:46 INFO - PROCESS | 2214 | Values: 69.0 68.0 72.0 81.0 101.0 98.0 101.0 75.0 67.0 66.0 14:05:46 INFO - PROCESS | 2214 | -------- Summary: end -------- 14:05:46 INFO - PROCESS | 2214 | 14:05:47 INFO - TEST-INFO | 2214: exit 0 14:05:47 INFO - TEST-OK | kraken | took 58946ms 14:05:47 INFO - SUITE-END | took 1174s 14:05:47 INFO - Completed test suite (00:19:34) 14:05:47 INFO - javascript benchmark 14:05:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3265.2000259936312, 3321.8837340693094, 3330.933381332373, 3333.2666813301066, 3381.2223188666608, 5425.457454254582, 5490.6431081979645, 5499.175123731437, 5527.50252477277, 5536.9999999999945, 5477.452254774521, 5506.201600767887, 5536.861578460541, 5551.500364967153, 5553.444655534445, 5052.696838189702, 5068.0, 5106.591472682177, 5137.99809037236, 5161.535461808437, 5079.6190285728535, 5133.1786914093755, 5156.69059856408, 5162.561182299509, 5169.48305169482, 5098.847034588968, 5135.05001574708, 5139.4346621871755, 5152.201408781645, 5154.716490593016, 4196.3705444183315, 5160.303359046518, 5167.328247327823, 5178.689278643294, 5232.947670523284, 5007.123753343187, 5051.772670229849, 5119.283300337956, 5121.769520371592, 5122.795088196468, 5411.377691565442, 5434.83695489132, 5446.537044351235, 5456.727163641802, 5485.01269771441, 6008.939910600881, 6046.244219472566, 6058.1215723719815, 6071.028635418312, 6071.726772295257, 5963.165156878041, 6062.9090563641585, 6111.663858487781, 6130.8773824523705, 6134.17188679527, 5603.635763675348, 5635.520980716603, 5653.208550802891, 5666.490015898547, 5683.54531637468, 6233.501319894398, 6283.748650054038, 6285.497160227171, 6297.433231009231, 6303.3066362700065, 5100.642954993189, 5732.0, 5939.970300148471, 5941.465268125889, 5958.523318134538, 6076.118962750376, 6140.754369825247, 6141.109539116803, 6154.83058218937, 6184.072389141665, 5996.340402555803, 5996.970015149984, 6005.369436209223, 6024.216851809237, 6049.18336024631, 5865.88268234633, 5881.5882888198275, 6015.1278064681255, 6018.548608854353, 6031.2159419276095, 4769.213079841857, 4775.307580400822, 4805.687630304019, 4814.831480898151, 4819.228923372314, 4348.195583817004, 4360.149770794665, 4415.271480205794, 4444.622207112367, 4449.7330160190495, 5593.8321850344555, 5596.300462442195, 5599.552035837123, 5600.747966341524, 5616.410276920865, 6031.5476339273855, 6138.416850399205, 6143.907841382383, 6169.2288463942, 6173.382661733881, 5479.726013699299, 5535.612507124543, 5567.331920169606, 5590.636608620427, 5592.189132575753, 5268.157094864803, 5271.868203294948, 5272.472752724773, 5274.868128296746, 5296.0, 6279.7488100476385, 6325.0, 6328.240611126602, 6333.050042493663, 6335.049742538656, 5990.31111422192, 6118.2658081028785, 6128.111423843607, 6145.539084568586, 6171.691415429121, 6281.152044473937, 6307.463865571478, 6319.8104056878365, 6342.112104305494, 6348.111264422892, 6028.668423236764, 6034.517238620812, 6047.183630209865, 6055.364186760503, 6057.151998720271, 5977.193078934288, 6064.636121832704, 6106.82471942484, 6131.202943617302, 6134.191681013941, 5851.297844258716, 5894.557908156991, 5898.203742494708, 5907.822765317047, 5946.256717910262, 5849.6197747148, 5888.998870191992, 5896.498797602252, 5902.085176797603, 5918.0, 5648.096304591246, 5730.9397761414275, 5784.797532086525, 5819.0689489681445, 5861.9706901465215, 5768.653880767168, 5897.882042359214, 5933.199018132497, 5941.0197317442135, 6000.939990600038, 5720.3421606515785, 5805.332386775575, 5821.854453638523, 5824.70876456167, 5829.970850145722], "value": 5568.282522301759, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.2688236468942, 529.4678847758003, 581.1370115378662, 592.9563967417345, 619.1826788638996, 30426.239344016383, 37911.24177516448, 39276.80361598195, 39277.67945525993, 39527.40708889369, 43692.3446148308, 44456.77771611138, 44489.55510444895, 44620.553794462045, 44792.99999999992, 8444.57777111142, 9460.81078378432, 9695.0, 9699.951500242489, 9704.27217958656, 8471.15288471154, 8621.224089831914, 8629.266512346458, 8637.870431943526, 11089.0, 11417.02955248805, 11618.302901825875, 11624.476898539586, 11627.767444651103, 11646.24299420535, 11495.885041149566, 11617.883821161764, 11624.302541847432, 11629.88370116305, 11635.82546261811, 8308.210719981593, 11200.495977681025, 11399.943000285028, 11467.254628449124, 11474.024707899838, 40684.79657601723, 41269.58730412687, 41331.1733765323, 41366.1726765466, 41596.584034159576, 3300.818454984975, 3415.9487607685905, 3485.093875592339, 3525.4183059795105, 3568.589612194605, 28684.71315286841, 28688.713112868812, 28919.855400722863, 28972.565411518844, 29641.851790741122, 2744.7118052604387, 2763.8618069096465, 2815.9296017599722, 2881.236472334812, 2956.054062699937, 501718.0, 502105.48947255395, 504104.0, 507880.0, 507971.0, 63298.4041914964, 63693.68153159297, 63807.361926380145, 63947.68026159839, 63947.68026159932, 67449.25507449314, 67459.98810017854, 67553.31116722024, 67669.66165169241, 67690.0, 14604.34280457382, 16837.32650693983, 17136.57158571046, 17137.742933856003, 17178.055206963487, 11735.4132293385, 11869.931706146488, 11882.28706277626, 11941.0, 12610.558630448073, 16918.74621880673, 17121.315147393965, 17251.82748172502, 17353.7396939046, 17383.826161738474, 7324.2309557496765, 7501.737439189711, 7507.962460187773, 7537.7386783965685, 7605.505642133355, 935.9110884465965, 938.957746901391, 972.7227740094039, 1116.3971455413985, 1167.6963989362828, 24531.509369812506, 25635.718214089222, 27713.307167320574, 27851.164465066082, 27881.442371152465, 1114.426070573639, 1122.5173175534435, 1123.1127409346525, 1187.0325684567051, 1276.6170148955275, 14505.186851643544, 14673.192974386511, 14701.485448009269, 14894.031887927467, 14960.32678529447, 517631.0, 524668.0, 645035.0, 660742.0, 664495.0, 59454.0, 59669.80660386768, 59682.70158649266, 59724.70137649284, 59733.0, 1345.0786211444995, 1490.917999509994, 1500.7748837674217, 1508.1931166825696, 1552.5187191970526, 28617.0, 28726.994555191304, 29138.417231655672, 29165.562516561844, 29411.411771764873, 47373.52626473829, 47554.76222618865, 47955.28067078927, 47956.760216198694, 47972.08111675494, 373273.0, 375919.0, 377314.0, 377715.0, 377958.0, 20028.59942801165, 21228.0, 22538.774612253666, 25905.611415829153, 26459.338516537242, 43285.35071973986, 43592.34611480894, 43788.0, 43824.78087609669, 43827.34258986054, 31453.0, 35859.82070089633, 37041.07397315089, 37230.0, 38347.61652383552, 36217.0, 36672.63327366692, 37178.81410593038, 37306.81346593249, 37360.43959340558, 35292.294154117284, 35756.92729218127, 36223.27553448864, 36472.27055458823, 37283.254334912606, 26242.737572624028, 29224.415511690073, 31507.68492315139, 31618.683813161573, 31809.204769880937, 24377.0, 24425.022999079836, 24693.0, 24995.625065623666, 25080.749192507843], "value": 19648.536432561064, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.2357965316995, 390.58597886240585, 395.7467220978576, 398.7388260689249, 409.07344863883327, 19672.409827705156, 21131.57736845262, 21828.781712182874, 21898.01458934348, 21957.560848783036, 20705.0, 20774.688379674317, 21758.673619895715, 21780.237691680795, 22000.229991950284, 5736.340320863092, 5896.734646940888, 6156.292026416974, 6166.0, 6168.0439531872635, 3935.3900145477355, 4186.623203911648, 5801.47786699197, 6097.6951152442425, 6151.753929842801, 6143.969280153593, 6146.969265153691, 6147.231596050494, 6147.262328520584, 6165.506759459233, 6400.39196276353, 6700.262971073178, 6701.93298067018, 6706.161729783777, 6722.294159113296, 3842.3275926712713, 5543.805966791143, 5686.0, 5862.648241105548, 5883.176355310217, 11040.447977601169, 13751.587452376445, 13764.31178441074, 19801.702974455395, 25656.74343256581, 1977.149825575002, 2100.4643815826867, 2112.535242246703, 2188.245055455865, 2787.0, 9678.370905891095, 10182.439965801877, 10275.22935779812, 13201.669958251121, 13638.977076719286, 1600.4878438899557, 1637.3941641592687, 1676.1284132251162, 1689.8056723476834, 1764.3207365164376, 101197.99999999926, 118696.40651796685, 118807.0, 119266.40366798197, 122491.3875430626, 9945.254105942084, 11663.650090497298, 11693.181477296677, 11747.17769756126, 11884.0, 15038.924805375904, 15150.696986060217, 15168.469103581543, 15174.393024278905, 15201.771973420407, 8517.190866867637, 8729.51987640686, 8732.995705493822, 8793.560321983876, 8876.955615221883, 8532.104129066483, 8546.957265213634, 8551.700690475804, 8694.956525217334, 8699.521526315986, 4576.336431217454, 4663.300504924288, 4684.906301874012, 4718.127146477913, 4739.075880203396, 1782.2710424449292, 1809.6018875847292, 1841.9171137298854, 1879.6146789908037, 2019.293247363411, 933.2580598424269, 938.3290946972947, 983.9114479696862, 1015.7206768138673, 1034.182995433599, 17085.0, 18342.17460214267, 19135.617287654168, 19873.403797886087, 20416.387508374773, 940.4263399326405, 946.3422921069928, 962.7015625156224, 998.2164001258977, 1005.5726316315537, 10368.170546356274, 10822.729431764268, 10831.2959657622, 10835.916408359259, 10862.782744345226, 581165.7892500205, 582367.1763282397, 591755.0, 594789.0, 595191.0, 123328.38335808263, 125057.0, 126034.3698281521, 127254.0, 131628.3418582901, 989.317371013998, 996.9750756231152, 1015.7866847961863, 1019.5717798524637, 1021.8313978193515, 17459.912700436416, 17717.822821771617, 17760.644787104444, 17762.5559361017, 18079.005654689117, 49020.0, 49460.75269623629, 49517.752411237714, 52256.73871630617, 52926.00257956234, 71062.64468677624, 73301.0, 74427.0, 74623.0, 74921.62539187487, 8009.83857340694, 8095.23095305945, 8128.431009829492, 8405.789855253668, 8420.789480263042, 9009.459432433812, 11656.242344247597, 12233.388330583613, 12551.372431378211, 12819.743605127658, 10564.313319634199, 10692.786144277226, 10800.891991079989, 10888.782224355311, 10962.342259464458, 10488.26582139243, 10552.050315471644, 10607.681769546925, 10821.67534973952, 10859.728506787078, 10534.631287904887, 10606.681799546026, 10967.890321096687, 11054.723631909266, 11282.75889652154, 8072.233137851895, 8173.386995975445, 8235.794105147419, 8340.791480213044, 8358.791030224293, 9712.417254964725, 10652.84020739674, 10904.890951090705, 10946.835797462885, 10951.069159121564], "value": 9422.0495237189, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.008464159729, 1602.3910913852737, 1623.54540728596, 1905.752252207213, 2047.1606641277078, 7611.885821712672, 8657.264132548733, 8882.511461869595, 8888.555572221396, 8890.86663700045, 8454.746357609267, 8739.650413983432, 8742.388032837687, 8744.868826967584, 8755.168259015383, 1751.378260717446, 2242.372135801978, 2451.595486744685, 2483.6522886795865, 2492.47657991821, 2484.7887929526014, 2516.9748302517014, 2517.8237523373373, 2519.4709111086695, 2523.974760252392, 2440.4996975619956, 2496.151308555091, 2498.5502609530276, 2511.208969174704, 2518.874056297187, 2031.878087314766, 2162.956740865182, 2394.9521009579885, 2476.0962248779065, 2478.1326535712537, 2437.9390515237083, 2463.322586288767, 2486.5772818620876, 2489.191012920808, 2490.1657944588583, 8682.30541556674, 8773.780655483664, 8784.47293162406, 8786.956065219632, 8790.0, 4238.554951730086, 5332.120200166968, 5489.1217405215375, 5522.3649280332875, 5528.143137813605, 2959.9704002960125, 3448.81031543265, 3624.2932628137523, 3686.668199862025, 3714.5542534895717, 998.5057396588662, 1005.2360206243235, 1016.4104819204917, 1059.4914441068331, 1072.7908057928707, 11809.763804723943, 11823.822642660367, 11825.526978920832, 11831.763364732657, 11885.881141188564, 4826.493218212107, 4920.089783390084, 4993.400791904995, 5021.573166280907, 5022.271770593244, 10134.493275336205, 10144.492775361203, 10148.949255253825, 10184.134348580454, 10188.796224075477, 5467.371252305956, 5510.724463776795, 5525.834224973177, 5549.833504994856, 5557.166425036277, 4476.865694029184, 4681.32120842476, 4873.658843880894, 5022.648414611015, 5033.647644664911, 4035.21313343901, 4066.2477441672795, 4152.546608686996, 4186.476690413699, 4234.428352172479, 1350.4463170100212, 1387.209290704309, 1389.9652508687363, 1401.2153194211273, 1402.2217669193697, 812.7074253268937, 932.1424289653535, 946.3943076430952, 957.2103015012642, 999.6501224571342, 5880.117982302689, 5935.614185077956, 6053.092036194606, 6099.664518451527, 6253.624782513064, 993.6522217224058, 998.8551660009258, 1029.9279050466546, 1050.5272627317738, 1086.7120213143523, 3851.691864650821, 3862.806859657006, 3879.786611736325, 3908.843646254175, 3923.372260438316, 10245.334053286513, 10352.948235258926, 10711.303765255234, 10832.512536935857, 10835.349879007284, 10011.599536018623, 10421.895781042243, 10630.362178269328, 10634.840477392845, 10751.0324070834, 8210.876836847452, 8307.626156822958, 8361.03848057469, 8361.707340243061, 8372.079071302152, 4805.831795887128, 5561.610687251854, 5690.0, 5736.541076713769, 5832.795852145155, 8462.53456059898, 9219.86170207434, 9855.901440985499, 10296.485175741333, 10324.328918620266, 10165.898341016495, 10301.175905927357, 10417.270791044857, 10467.267291289536, 10476.371417714656, 7008.929910700827, 7107.253738357605, 7162.677679504331, 7198.748043818441, 7209.963950180216, 8246.83506329882, 8273.172682731678, 8369.539675317916, 8380.120087390736, 8382.077971423261, 7325.340719335285, 7522.623868806647, 7609.353204977639, 7726.072871255486, 7739.41954353437, 7294.0, 7414.629268536443, 7427.368673662799, 7586.468947173645, 7630.2751238632245, 6972.4073453757, 7066.364027237573, 7150.213476517475, 7150.392216661642, 7152.463565232524, 4824.445188803333, 4832.758362081952, 4962.6774259673, 4985.850424487271, 5001.174806157089, 4851.345068415719, 4881.609471242363, 5023.995200959749, 5037.848864534069, 5267.473252674702], "value": 4650.011877239571, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.2058893943021, 321.10572056821746, 327.6575978102882, 328.8569472279559, 333.51307091646197, 5289.365276166861, 5298.23175639533, 5330.227117068028, 5354.678719276846, 5365.0, 4880.609551235902, 5030.874228144298, 5256.316678831747, 5271.367435907687, 5316.282301889244, 3880.6715970417804, 3911.4132880068073, 4002.2395744808537, 4090.9386359204486, 4118.979405102985, 3055.4500189965797, 3580.874669386572, 4087.589781525384, 4100.63094321511, 4130.917381652365, 3635.4365073413665, 3669.8439991402756, 3825.445310429986, 3903.668188204006, 4114.835406583733, 3536.7877927324316, 3835.9041023974623, 3905.2775236581183, 3994.7003974702016, 4021.3766866135797, 3056.510958246692, 3516.0, 3577.338192434408, 3582.158192824684, 3635.291118231946, 5116.488351164891, 5123.692578445305, 5128.5640720538795, 5143.742812859379, 5201.479852014768, 3538.7127608730298, 4040.7979601020124, 4278.272693642089, 4642.744649044335, 4765.785539650724, 4506.436695413074, 5110.390227078458, 5275.683458992473, 5505.752241149158, 5543.223948647153, 3945.447637330776, 3945.4946109220564, 3985.04358953849, 3985.5815139410233, 3988.9229907924987, 5455.0, 5537.889242215173, 5586.553075753889, 5902.852428689317, 5916.733746981353, 3985.501812273466, 3995.6004399560393, 3996.86010989614, 3997.8600748973645, 4011.157656892027, 4049.190161967618, 4067.678004648501, 4071.0229544909603, 4078.632923036941, 4091.5908409158847, 4398.406215160912, 4653.627709783209, 4679.660169915042, 4679.67242293043, 4705.976470117627, 5159.491545748851, 5362.812301569426, 5472.753726082336, 5647.407022262603, 5660.85847853807, 1469.2727100085312, 1498.1385703220692, 1498.7002599480147, 1506.6308754355034, 1507.3141720517137, 929.6334388448969, 966.5988614724951, 1005.5123265216364, 1008.3395376028712, 1018.2719355660738, 5095.31213286209, 5197.8440646780655, 5268.2097685346735, 5278.4721527846905, 5527.397054854047, 5746.856328591819, 5784.942150578525, 5795.275590551181, 5808.427816892665, 5834.299884013861, 4674.0, 4968.031233909425, 4988.603191106496, 5190.429052804188, 5357.1696387060065, 3324.268660894599, 3329.4850842866435, 3335.666433356645, 3343.278211720966, 3348.961821835239, 5794.913076303775, 6307.4954003679595, 6518.0, 6615.768448104293, 6656.500762442836, 5900.0, 5965.13505541694, 6512.381323774234, 6527.2167339919515, 6571.9671401643645, 6561.770338038145, 6590.604563726191, 6605.8348541285895, 6623.43700785429, 6696.794576976191, 4857.80215169765, 4886.706797592014, 5410.702411367412, 5840.561957853093, 6284.637718820409, 5746.798862039808, 5804.361520232856, 5817.738201780845, 5819.098039803837, 5820.214271073521, 5007.749612519432, 5909.852253693692, 6069.939300606938, 6086.695665216633, 6091.238595175603, 3441.7934923904645, 3755.2489502099143, 3907.5115610548683, 3959.8614048509316, 3962.841486340514, 4895.779689913891, 5815.883682326415, 5860.120981852756, 5912.70436478183, 5941.346451890202, 4366.009283640717, 4705.576498115186, 5651.012213733028, 5755.827325180251, 5765.365809761007, 4480.686351955332, 5181.689098654093, 5461.208124821958, 5678.290213723285, 5705.600607957404, 4644.767761611974, 5547.306586676666, 5566.276384070045, 5571.637843540157, 5605.299337582802, 4625.190591646381, 4924.433690125538, 5100.48995100487, 5622.437756224344, 5626.831195064155, 4905.566103727477, 5530.585206109477, 5552.083906155601, 5557.221988921473, 5653.915191272052], "value": 4189.28552062534, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.5607299182539, 697.560536861777, 734.7501849371213, 749.0674110732143, 755.953005087953, 12038.0, 12219.938900305497, 13509.59471215865, 14471.204083775388, 14774.335154918028, 13861.930690346559, 14038.649033774162, 14082.57752267431, 14088.36602352894, 14109.858901410982, 759.2748924776853, 790.683726509398, 950.9857352139707, 965.6861520005991, 970.0396607358699, 928.535732133933, 968.6125549780074, 968.7529679931607, 970.6457143142773, 976.5263847034183, 1006.4112494190871, 1013.285633628294, 1021.3463383434607, 1021.5862575656834, 1023.0843395161326, 792.3423558446505, 957.9185769209626, 1007.0483393193399, 1011.9241056920723, 1023.150784848574, 746.0413368821094, 747.8990336304583, 748.3152915082693, 750.3959312753232, 752.6575408189316, 13947.860521394758, 13963.860361396357, 13975.65060873476, 13987.300634968211, 14013.719725605533, 12040.638780836589, 12146.0, 12229.510819567207, 12332.506699732, 12338.383080845922, 10723.03492685662, 10861.86422919185, 10906.563737450493, 10946.4526773661, 11629.825552616718, 2897.478453878301, 4050.797460126982, 4060.1473690525027, 4189.539150693421, 4393.143337049277, 82674.0, 83237.0, 84081.99999999939, 84454.73317900236, 84717.0, 7914.0, 9559.0, 9633.421994680202, 9713.90286097144, 9911.752206194758, 22465.775342246696, 22487.212947547083, 22490.775092249194, 22499.88750056272, 22507.887460562593, 7456.440766942501, 7508.511946723445, 7518.060242469692, 7594.696212151563, 7675.309222170032, 3090.90727278182, 4097.610726980932, 4099.733517321424, 4111.1366613011005, 4114.248043509751, 3653.634636536325, 3731.570869350005, 3733.141377483194, 3735.0662334416397, 3738.775673459601, 484.3074403602882, 630.9432151106422, 650.5836264790538, 689.1936434371797, 690.3062422265591, 502.43977964569973, 572.985675358111, 592.4963780786297, 607.1924340626956, 607.9513638908877, 7986.880196797053, 8101.326562234449, 8197.83604327922, 8324.334053275723, 8341.708040218564, 474.232851312588, 576.4898065212317, 589.1575047681856, 597.7071235094772, 626.589583822597, 3810.1427178885083, 3811.0, 3826.463475795368, 3857.0550215196895, 4066.552679205285, 89674.20651586931, 90141.19717605611, 91750.0, 97645.51177244069, 99363.0, 79627.8055829163, 80232.19767802248, 82821.0, 83130.0, 83484.0, 69876.0, 71599.64200178966, 72079.0, 72350.63824680843, 73115.68843115646, 7659.578723170279, 7663.233676632515, 7696.057946789264, 7885.2114788520685, 7911.485753426239, 34149.80475683339, 34894.825525872206, 45108.77445612751, 45510.317345239186, 45513.40703075376, 61378.38621613727, 61387.69306153619, 61642.4589385269, 62088.379116208256, 63320.0, 10448.42533660656, 10665.093467055387, 10708.30396024256, 10838.891611083789, 10841.67474975752, 10377.481125943521, 10484.42335671515, 11041.06150977176, 11172.888271117185, 11316.83024754613, 8752.862127923328, 9886.604535818775, 10395.792084158124, 10483.0, 10636.52135653913, 10270.33242839213, 10346.844797327896, 10387.0, 10413.9479302603, 10763.0, 10104.69685909424, 10285.331453455501, 10341.172706183637, 10607.575696972035, 10659.840102398626, 8846.601902914514, 8895.688650897187, 8950.462972221687, 9303.209227215491, 9314.301427393108, 8685.0, 8737.475751454933, 8801.40408796424, 8809.383343165917, 8979.775505612412], "value": 6788.827175321899, "unit": "score"}], "name": "dromaeo_css", "value": 7174.169025449354, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 106.0, 111.0, 112.0, 111.0, 112.0, 113.0, 105.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 123.0, 150.0, 203.0, 150.0, 169.0, 140.0, 122.0, 213.0, 117.0], "value": 154.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 185.0, 184.0, 183.0, 185.0, 181.0, 188.0, 181.0, 185.0, 182.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 89.0, 98.0, 83.0, 118.0, 84.0, 90.0, 89.0, 56.0], "value": 85.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 101.0, 136.0, 78.0, 80.0, 81.0, 125.0, 80.0, 77.0, 130.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 88.0, 86.0, 86.0, 84.0, 88.0, 85.0, 94.0, 83.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 94.0, 92.0, 92.0], "value": 92.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 84.0, 85.0, 84.0, 83.0, 85.0, 86.0, 87.0, 88.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 59.0, 59.0, 60.0, 60.0, 60.0, 79.0, 58.0, 56.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 82.0, 74.0, 70.0, 68.0, 68.0, 68.0, 70.0, 70.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 81.0, 82.0, 80.0, 82.0, 82.0, 82.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 125.0, 157.0, 152.0, 122.0, 141.0, 129.0, 163.0, 148.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 185.0, 186.0, 202.0, 170.0, 170.0, 167.0, 209.0, 166.0, 169.0], "value": 179.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 72.0, 81.0, 101.0, 98.0, 101.0, 75.0, 67.0, 66.0], "value": 79.8, "unit": "score"}], "name": "kraken", "value": 1515.0, "alertThreshold": 2.0}]} 14:05:47 INFO - Return code: 0 14:05:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:05:47 ERROR - # TBPL SUCCESS # 14:05:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:05:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:05:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:05:47 INFO - 2016-04-28 14:05:47.851 screenresolution[2218:23243] starting screenresolution argv=screenresolution get 14:05:47 INFO - 2016-04-28 14:05:47.854 screenresolution[2218:23243] Display 0: 1600x1200x32@60 14:05:47 INFO - 2016-04-28 14:05:47.860 screenresolution[2219:23246] starting screenresolution argv=screenresolution list 14:05:47 INFO - Available Modes on Display 0 14:05:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:05:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:05:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:05:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:05:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:05:48 INFO - Intel Iris: 14:05:48 INFO - Chipset Model: Intel Iris 14:05:48 INFO - Type: GPU 14:05:48 INFO - Bus: Built-In 14:05:48 INFO - VRAM (Dynamic, Max): 1536 MB 14:05:48 INFO - Vendor: Intel (0x8086) 14:05:48 INFO - Device ID: 0x0a2e 14:05:48 INFO - Revision ID: 0x0009 14:05:48 INFO - Displays: 14:05:48 INFO - Display: 14:05:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:05:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:05:48 INFO - Display Serial Number: 1600x1200 60 14:05:48 INFO - Main Display: Yes 14:05:48 INFO - Mirror: Off 14:05:48 INFO - Online: Yes 14:05:48 INFO - Rotation: Supported 14:05:48 INFO - Return code: 0 14:05:48 INFO - Running post-action listener: _resource_record_post_action 14:05:48 INFO - Running post-run listener: _resource_record_post_run 14:05:49 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 712704; Write bytes: 694155776; Read time: 7; Write time: 1963 14:05:49 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 385100288; Write bytes: 378451456; Read time: 28544; Write time: 764 14:05:49 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 712704; Write bytes: 293778432; Read time: 7; Write time: 1152 14:05:49 INFO - Running post-run listener: _upload_blobber_files 14:05:49 INFO - Blob upload gear active. 14:05:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:05:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:05:49 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'] 14:05:49 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 14:05:49 INFO - (blobuploader) - INFO - Open directory for files ... 14:05:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:05:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:05:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:05:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:05:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:05:50 INFO - (blobuploader) - INFO - Done attempting. 14:05:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:05:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:05:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:05:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:05:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:05:51 INFO - (blobuploader) - INFO - Done attempting. 14:05:51 INFO - (blobuploader) - INFO - Iteration through files over. 14:05:51 INFO - Return code: 0 14:05:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:05:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:05:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52a1454b9dd32a47c16d41d453076465d9f0358af6c92a005a4f66a53d7e899fbe094dc5c7b994be55a7f2fbc9186cea0b3d735d8a1c308d0451af636c3ceeae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5046c12e424e47d56d678c33a0c5e03d1f6dc9b7ec3432c335c0d235bfaa24894b64bb8c5d4f8f107d27a574f986ad9aab467b3a915ca18b844eb0b237dd62f8"} 14:05:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:05:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:05:51 INFO - Contents: 14:05:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52a1454b9dd32a47c16d41d453076465d9f0358af6c92a005a4f66a53d7e899fbe094dc5c7b994be55a7f2fbc9186cea0b3d735d8a1c308d0451af636c3ceeae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5046c12e424e47d56d678c33a0c5e03d1f6dc9b7ec3432c335c0d235bfaa24894b64bb8c5d4f8f107d27a574f986ad9aab467b3a915ca18b844eb0b237dd62f8"} 14:05:51 INFO - Running post-run listener: copy_logs_to_upload_dir 14:05:51 INFO - Copying logs to upload dir... 14:05:51 INFO - mkdir: /builds/slave/test/build/upload/logs 14:05:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.614670 ========= master_lag: 16.85 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-04-28 14:06:08.584871) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-28 14:06:08.599676) ========= 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.UEVn7OCguR/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.wSvhchxDGK/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52a1454b9dd32a47c16d41d453076465d9f0358af6c92a005a4f66a53d7e899fbe094dc5c7b994be55a7f2fbc9186cea0b3d735d8a1c308d0451af636c3ceeae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5046c12e424e47d56d678c33a0c5e03d1f6dc9b7ec3432c335c0d235bfaa24894b64bb8c5d4f8f107d27a574f986ad9aab467b3a915ca18b844eb0b237dd62f8"} build_url:https://queue.taskcluster.net/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011084 build_url: 'https://queue.taskcluster.net/v1/task/ewTPLwsgTBOm9kDSm6fVlA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52a1454b9dd32a47c16d41d453076465d9f0358af6c92a005a4f66a53d7e899fbe094dc5c7b994be55a7f2fbc9186cea0b3d735d8a1c308d0451af636c3ceeae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5046c12e424e47d56d678c33a0c5e03d1f6dc9b7ec3432c335c0d235bfaa24894b64bb8c5d4f8f107d27a574f986ad9aab467b3a915ca18b844eb0b237dd62f8"}' ========= master_lag: 3.28 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-28 14:06:11.887686) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 23 secs) (at 2016-04-28 14:06:11.887999) ========= 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.UEVn7OCguR/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.wSvhchxDGK/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.005154 ========= master_lag: 23.60 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 23 secs) (at 2016-04-28 14:06:35.488565) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-28 14:06:35.488872) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-28 14:06:36.830212) ========= ========= Total master_lag: 43.78 =========