builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0276 starttime: 1481301246.42 results: success (0) buildid: 20161209060650 builduid: 2c3fc1794d494affa82dcfdfc9689e0a revision: f6f2e2b9fa87a1cf454dec44bcf52cd4f96288a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-09 08:34:06.419805) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-09 08:34:06.420224) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-09 08:34:06.420494) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-09 08:34:06.446443) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 08:34:06.446747) ========= 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.Nsb1qyF30j/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.aUfSDm8a4z/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-09 08:34:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 138M=0s 2016-12-09 08:34:06 (138 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128091 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 08:34:06.598364) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 08:34:06.598673) ========= 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.Nsb1qyF30j/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.aUfSDm8a4z/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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.024957 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 08:34:06.647675) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-09 08:34:06.648037) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f6f2e2b9fa87a1cf454dec44bcf52cd4f96288a0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f6f2e2b9fa87a1cf454dec44bcf52cd4f96288a0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Nsb1qyF30j/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.aUfSDm8a4z/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-09 08:34:06,734 truncating revision to first 12 chars 2016-12-09 08:34:06,734 Setting DEBUG logging. 2016-12-09 08:34:06,734 attempt 1/10 2016-12-09 08:34:06,734 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f6f2e2b9fa87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-09 08:34:08,421 unpacking tar archive at: mozilla-aurora-f6f2e2b9fa87/testing/mozharness/ program finished with exit code 0 elapsedTime=1.967606 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-09 08:34:08.639233) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-09 08:34:08.639599) ========= script_repo_revision: f6f2e2b9fa87a1cf454dec44bcf52cd4f96288a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-09 08:34:08.640051) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-09 08:34:08.640331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-09 08:34:08.660089) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-12-09 08:34:08.660364) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Nsb1qyF30j/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.aUfSDm8a4z/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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 08:34:08 INFO - MultiFileLogger online at 20161209 08:34:08 in /builds/slave/test 08:34:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:34:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:34:08 INFO - {'append_to_log': False, 08:34:08 INFO - 'base_work_dir': '/builds/slave/test', 08:34:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:34:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:34:08 INFO - 'branch': 'Mozilla-Aurora', 08:34:08 INFO - 'buildbot_json_path': 'buildprops.json', 08:34:08 INFO - 'config_files': ('talos/mac_config.py',), 08:34:08 INFO - 'default_actions': ('clobber', 08:34:08 INFO - 'read-buildbot-config', 08:34:08 INFO - 'download-and-extract', 08:34:08 INFO - 'populate-webroot', 08:34:08 INFO - 'create-virtualenv', 08:34:08 INFO - 'install', 08:34:08 INFO - 'run-tests'), 08:34:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:34:08 INFO - 'download_minidump_stackwalk': True, 08:34:08 INFO - 'download_symbols': 'ondemand', 08:34:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:34:08 INFO - 'tooltool.py': '/tools/tooltool.py', 08:34:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:34:08 INFO - '/tools/misc-python/virtualenv.py')}, 08:34:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:34:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:34:08 INFO - 'installer_path': 'installer.exe', 08:34:08 INFO - 'log_level': 'info', 08:34:08 INFO - 'log_name': 'talos', 08:34:08 INFO - 'log_to_console': True, 08:34:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:34:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:34:08 INFO - 'opt_config_files': (), 08:34:08 INFO - 'pip_index': False, 08:34:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:34:08 INFO - 'cmd': ('bash', 08:34:08 INFO - '-c', 08:34:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:34:08 INFO - 'enabled': True, 08:34:08 INFO - 'halt_on_failure': False, 08:34:08 INFO - 'name': 'check_screen_resolution'},), 08:34:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:34:08 INFO - 'cmd': ('bash', 08:34:08 INFO - '-c', 08:34:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:34:08 INFO - 'enabled': True, 08:34:08 INFO - 'halt_on_failure': False, 08:34:08 INFO - 'name': 'check_screen_resolution'},), 08:34:08 INFO - 'run_cmd_checks_enabled': True, 08:34:08 INFO - 'sps_profile': False, 08:34:08 INFO - 'sps_profile_interval': 0, 08:34:08 INFO - 'suite': 'dromaeojs', 08:34:08 INFO - 'system_bits': '32', 08:34:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:34:08 INFO - 'title': 't-yosemite-r7-0276', 08:34:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:34:08 INFO - 'use_talos_json': True, 08:34:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:34:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:34:08 INFO - 'work_dir': 'build'} 08:34:08 INFO - [mozharness: 2016-12-09 16:34:08.853283Z] Running clobber step. 08:34:08 INFO - Running pre-action listener: _resource_record_pre_action 08:34:08 INFO - Running main action method: clobber 08:34:08 INFO - rmtree: /builds/slave/test/build 08:34:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:34:11 INFO - Running post-action listener: _resource_record_post_action 08:34:11 INFO - [mozharness: 2016-12-09 16:34:11.129824Z] Finished clobber step (success) 08:34:11 INFO - [mozharness: 2016-12-09 16:34:11.129947Z] Running read-buildbot-config step. 08:34:11 INFO - Running pre-action listener: _resource_record_pre_action 08:34:11 INFO - Running main action method: read_buildbot_config 08:34:11 INFO - Using buildbot properties: 08:34:11 INFO - { 08:34:11 INFO - "project": "", 08:34:11 INFO - "product": "firefox", 08:34:11 INFO - "script_repo_revision": "production", 08:34:11 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:34:11 INFO - "repository": "", 08:34:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:34:11 INFO - "buildid": "20161209060650", 08:34:11 INFO - "pgo_build": "False", 08:34:11 INFO - "basedir": "/builds/slave/test", 08:34:11 INFO - "buildnumber": 21, 08:34:11 INFO - "slavename": "t-yosemite-r7-0276", 08:34:11 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:34:11 INFO - "platform": "yosemite_r7", 08:34:11 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:34:11 INFO - "branch": "mozilla-aurora", 08:34:11 INFO - "repo_path": "releases/mozilla-aurora", 08:34:11 INFO - "revision": "f6f2e2b9fa87a1cf454dec44bcf52cd4f96288a0", 08:34:11 INFO - "stage_platform": "macosx64", 08:34:11 INFO - "builduid": "2c3fc1794d494affa82dcfdfc9689e0a", 08:34:11 INFO - "slavebuilddir": "test" 08:34:11 INFO - } 08:34:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 08:34:11 INFO - Running post-action listener: _resource_record_post_action 08:34:11 INFO - [mozharness: 2016-12-09 16:34:11.133298Z] Finished read-buildbot-config step (success) 08:34:11 INFO - [mozharness: 2016-12-09 16:34:11.133428Z] Running download-and-extract step. 08:34:11 INFO - Running pre-action listener: _resource_record_pre_action 08:34:11 INFO - Running main action method: download_and_extract 08:34:11 INFO - mkdir: /builds/slave/test/build/tests 08:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:11 INFO - trying https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 08:34:11 INFO - Downloading https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:34:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 08:34:12 INFO - Downloaded 1199 bytes. 08:34:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:34:12 INFO - Using the following test package requirements: 08:34:12 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:34:12 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:34:12 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 08:34:12 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:34:12 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 08:34:12 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:34:12 INFO - u'jsshell-mac.zip'], 08:34:12 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:34:12 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 08:34:12 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:34:12 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:34:12 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 08:34:12 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:34:12 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 08:34:12 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:34:12 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 08:34:12 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:34:12 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 08:34:12 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:34:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:34:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:34:12 INFO - Fetch https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:34:12 INFO - Http code: 200 08:34:12 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 08:34:12 INFO - x-amz-cf-id: 0Ks_jw_KfUJxGvBlAtkg1hvlBMSAHda3hCq4DFVbPv2JUIGWqdE9BQ== 08:34:12 INFO - x-amz-version-id: szeVb_5gNyunXaWM7dQI.Wy2QSJNu7_G 08:34:13 INFO - Expected file size: 16281040 08:34:13 INFO - Obtained file size: 16281040 08:34:19 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:34:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:34:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:34:19 INFO - Fetch https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:34:20 INFO - Http code: 200 08:34:20 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 08:34:20 INFO - x-amz-cf-id: uLxy9Emyap5-raVl3QLtUUpi9nh5sOtd-2GKDNFwpa37oGVdgkXiYw== 08:34:20 INFO - x-amz-version-id: szeVb_5gNyunXaWM7dQI.Wy2QSJNu7_G 08:34:20 INFO - Expected file size: 16281040 08:34:20 INFO - Obtained file size: 16281040 08:34:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 08:34:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:34:27 INFO - Fetch https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 08:34:28 INFO - Http code: 200 08:34:28 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 08:34:28 INFO - x-amz-cf-id: o1-szgyj-EPNZg7eP8_d2cId0tmpi-nQvLM5f5J_ZcjnOy75keH-Yg== 08:34:28 INFO - x-amz-version-id: Ck_QnPAs5f_UCgxlH.SU7wRumzivXr1_ 08:34:28 INFO - Expected file size: 14409038 08:34:28 INFO - Obtained file size: 14409038 08:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:28 INFO - trying https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:34:28 INFO - Downloading https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 08:34:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 08:34:31 INFO - Downloaded 109785285 bytes. 08:34:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:34:31 INFO - mkdir: /builds/slave/test/properties 08:34:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:34:31 INFO - Writing to file /builds/slave/test/properties/build_url 08:34:31 INFO - Contents: 08:34:31 INFO - build_url:https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:34:32 INFO - Running post-action listener: _resource_record_post_action 08:34:32 INFO - Running post-action listener: set_extra_try_arguments 08:34:32 INFO - [mozharness: 2016-12-09 16:34:32.509639Z] Finished download-and-extract step (success) 08:34:32 INFO - [mozharness: 2016-12-09 16:34:32.509777Z] Running populate-webroot step. 08:34:32 INFO - Running pre-action listener: _resource_record_pre_action 08:34:32 INFO - Running main action method: populate_webroot 08:34:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:34:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:34:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:34:32 INFO - '--tppagecycles', 08:34:32 INFO - '7'], 08:34:32 INFO - 'tests': ['tsvgm']}}, 08:34:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:34:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:34:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:34:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:34:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:34:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:34:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:32 INFO - 'talos_options': ['--disable-e10s'], 08:34:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:34:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:34:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:32 INFO - 'talos_options': ['--disable-e10s'], 08:34:32 INFO - 'tests': ['damp', 'tps']}, 08:34:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:32 INFO - 'tests': ['damp', 'tps']}, 08:34:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:34:32 INFO - 'tests': ['dromaeo_dom']}, 08:34:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:34:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:34:32 INFO - 'tests': ['basic_compositor_video']}, 08:34:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:34:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:34:32 INFO - 'tests': ['a11yr', 08:34:32 INFO - 'ts_paint', 08:34:32 INFO - 'tpaint', 08:34:32 INFO - 'sessionrestore', 08:34:32 INFO - 'sessionrestore_no_auto_restore', 08:34:32 INFO - 'tabpaint']}, 08:34:32 INFO - 'other-e10s': {'tests': ['a11yr', 08:34:32 INFO - 'ts_paint', 08:34:32 INFO - 'tpaint', 08:34:32 INFO - 'sessionrestore', 08:34:32 INFO - 'sessionrestore_no_auto_restore', 08:34:32 INFO - 'tabpaint']}, 08:34:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:34:32 INFO - 'ts_paint', 08:34:32 INFO - 'tpaint', 08:34:32 INFO - 'sessionrestore', 08:34:32 INFO - 'sessionrestore_no_auto_restore', 08:34:32 INFO - 'tabpaint']}, 08:34:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:34:32 INFO - 'ts_paint', 08:34:32 INFO - 'tpaint', 08:34:32 INFO - 'sessionrestore', 08:34:32 INFO - 'sessionrestore_no_auto_restore', 08:34:32 INFO - 'tabpaint']}, 08:34:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:34:32 INFO - 'tests': ['a11yr', 08:34:32 INFO - 'ts_paint', 08:34:32 INFO - 'tpaint', 08:34:32 INFO - 'sessionrestore', 08:34:32 INFO - 'sessionrestore_no_auto_restore', 08:34:32 INFO - 'tabpaint']}, 08:34:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:34:32 INFO - 'tests': ['a11yr', 08:34:32 INFO - 'ts_paint', 08:34:32 INFO - 'tpaint', 08:34:32 INFO - 'sessionrestore', 08:34:32 INFO - 'sessionrestore_no_auto_restore', 08:34:32 INFO - 'tabpaint']}, 08:34:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:34:32 INFO - 'tests': ['tsvgx', 08:34:32 INFO - 'tsvgr_opacity', 08:34:32 INFO - 'tart', 08:34:32 INFO - 'tscrollx', 08:34:32 INFO - 'cart']}, 08:34:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:34:32 INFO - 'tsvgr_opacity', 08:34:32 INFO - 'tart', 08:34:32 INFO - 'tscrollx', 08:34:32 INFO - 'cart']}, 08:34:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:32 INFO - 'talos_options': ['--disable-e10s'], 08:34:32 INFO - 'tests': ['tp5o']}, 08:34:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:32 INFO - 'tests': ['tp5o']}, 08:34:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:32 INFO - 'talos_options': ['--disable-e10s', 08:34:32 INFO - '--xperf_path', 08:34:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:34:32 INFO - 'tests': ['tp5n']}, 08:34:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:32 INFO - 'talos_options': ['--xperf_path', 08:34:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:34:32 INFO - 'tests': ['tp5n']}}, 08:34:32 INFO - 'talos.zip': {'path': '', 08:34:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:34:32 INFO - Running post-action listener: _resource_record_post_action 08:34:32 INFO - [mozharness: 2016-12-09 16:34:32.528384Z] Finished populate-webroot step (success) 08:34:32 INFO - [mozharness: 2016-12-09 16:34:32.528521Z] Running create-virtualenv step. 08:34:32 INFO - Running pre-action listener: _resource_record_pre_action 08:34:32 INFO - Running main action method: create_virtualenv 08:34:32 INFO - Creating virtualenv /builds/slave/test/build/venv 08:34:32 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 08:34:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:34:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:34:32 INFO - Using real prefix '/tools/python27' 08:34:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:34:33 INFO - Installing distribute.............................................................................................................................................................................................done. 08:34:36 INFO - Installing pip.................done. 08:34:36 INFO - Return code: 0 08:34:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:34:36 INFO - Reading from file tmpfile_stdout 08:34:36 INFO - Output received: 08:34:36 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:34:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:36 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 0x10e984490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b586380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e798d30>, '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 0x10e5fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e790b20>, '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.Nsb1qyF30j/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.aUfSDm8a4z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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 08:34:36 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 08:34:36 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 08:34:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nsb1qyF30j/Render', 08:34:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:36 INFO - 'HOME': '/Users/cltbld', 08:34:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:36 INFO - 'LOGNAME': 'cltbld', 08:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:36 INFO - 'MOZ_NO_REMOTE': '1', 08:34:36 INFO - 'NO_EM_RESTART': '1', 08:34:36 INFO - 'PAGER': '/bin/cat', 08:34:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:36 INFO - 'PWD': '/builds/slave/test', 08:34:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:36 INFO - 'SHELL': '/bin/bash', 08:34:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aUfSDm8a4z/Listeners', 08:34:36 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 08:34:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:36 INFO - 'USER': 'cltbld', 08:34:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:36 INFO - 'XPC_FLAGS': '0x0', 08:34:36 INFO - 'XPC_SERVICE_NAME': '0', 08:34:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:36 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 08:34:36 INFO - Cleaning up... 08:34:36 INFO - Return code: 0 08:34:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e984490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b586380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e798d30>, '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 0x10e5fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e790b20>, '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.Nsb1qyF30j/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.aUfSDm8a4z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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 08:34:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:34:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nsb1qyF30j/Render', 08:34:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:36 INFO - 'HOME': '/Users/cltbld', 08:34:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:36 INFO - 'LOGNAME': 'cltbld', 08:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:36 INFO - 'MOZ_NO_REMOTE': '1', 08:34:36 INFO - 'NO_EM_RESTART': '1', 08:34:36 INFO - 'PAGER': '/bin/cat', 08:34:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:36 INFO - 'PWD': '/builds/slave/test', 08:34:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:36 INFO - 'SHELL': '/bin/bash', 08:34:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aUfSDm8a4z/Listeners', 08:34:36 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 08:34:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:36 INFO - 'USER': 'cltbld', 08:34:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:36 INFO - 'XPC_FLAGS': '0x0', 08:34:36 INFO - 'XPC_SERVICE_NAME': '0', 08:34:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:37 INFO - Downloading/unpacking psutil>=3.1.1 08:34:37 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 08:34:37 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 08:34:37 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 08:34:37 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 08:34:37 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 08:34:37 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 08:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:34:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:34:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:34:40 INFO - Installing collected packages: psutil 08:34:40 INFO - Running setup.py install for psutil 08:34:40 INFO - building 'psutil._psutil_osx' extension 08:34:40 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 08:34:41 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 08:34:41 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 08:34:41 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 08:34:41 INFO - building 'psutil._psutil_posix' extension 08:34:41 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 08:34:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:34:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:34:41 INFO - ^ 08:34:41 INFO - 1 warning generated. 08:34:41 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 08:34:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:34:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:34:41 INFO - Successfully installed psutil 08:34:41 INFO - Cleaning up... 08:34:41 INFO - Return code: 0 08:34:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:34: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e984490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b586380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e798d30>, '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 0x10e5fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e790b20>, '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.Nsb1qyF30j/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.aUfSDm8a4z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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 08:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:34:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nsb1qyF30j/Render', 08:34:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:41 INFO - 'HOME': '/Users/cltbld', 08:34:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:41 INFO - 'LOGNAME': 'cltbld', 08:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:41 INFO - 'MOZ_NO_REMOTE': '1', 08:34:41 INFO - 'NO_EM_RESTART': '1', 08:34:41 INFO - 'PAGER': '/bin/cat', 08:34:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:41 INFO - 'PWD': '/builds/slave/test', 08:34:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:41 INFO - 'SHELL': '/bin/bash', 08:34:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aUfSDm8a4z/Listeners', 08:34:41 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 08:34:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:41 INFO - 'USER': 'cltbld', 08:34:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:41 INFO - 'XPC_FLAGS': '0x0', 08:34:41 INFO - 'XPC_SERVICE_NAME': '0', 08:34:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:34:42 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 08:34:42 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 08:34:42 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 08:34:42 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 08:34:42 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 08:34:42 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 08:34:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:34:44 INFO - Installing collected packages: mozsystemmonitor 08:34:44 INFO - Running setup.py install for mozsystemmonitor 08:34:44 INFO - Successfully installed mozsystemmonitor 08:34:44 INFO - Cleaning up... 08:34:44 INFO - Return code: 0 08:34:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e984490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b586380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e798d30>, '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 0x10e5fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e790b20>, '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.Nsb1qyF30j/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.aUfSDm8a4z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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 08:34:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:34:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:34:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nsb1qyF30j/Render', 08:34:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:44 INFO - 'HOME': '/Users/cltbld', 08:34:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:44 INFO - 'LOGNAME': 'cltbld', 08:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:44 INFO - 'MOZ_NO_REMOTE': '1', 08:34:44 INFO - 'NO_EM_RESTART': '1', 08:34:44 INFO - 'PAGER': '/bin/cat', 08:34:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:44 INFO - 'PWD': '/builds/slave/test', 08:34:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:44 INFO - 'SHELL': '/bin/bash', 08:34:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aUfSDm8a4z/Listeners', 08:34:44 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 08:34:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:44 INFO - 'USER': 'cltbld', 08:34:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:44 INFO - 'XPC_FLAGS': '0x0', 08:34:44 INFO - 'XPC_SERVICE_NAME': '0', 08:34:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:45 INFO - Downloading/unpacking jsonschema==2.5.1 08:34:45 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 08:34:45 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 08:34:45 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 08:34:45 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 08:34:45 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 08:34:45 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 08:34:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:34:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:34:47 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 08:34:47 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 08:34:47 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 08:34:47 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 08:34:47 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 08:34:47 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 08:34:48 INFO - Downloading functools32-3.2.3-2.tar.gz 08:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:34:48 INFO - warning: no files found matching '*.txt' 08:34:48 INFO - no previously-included directories found matching 'build' 08:34:48 INFO - no previously-included directories found matching 'dist' 08:34:48 INFO - no previously-included directories found matching '.git*' 08:34:48 INFO - Installing collected packages: jsonschema, functools32 08:34:48 INFO - Running setup.py install for functools32 08:34:48 INFO - warning: no files found matching '*.txt' 08:34:48 INFO - no previously-included directories found matching 'build' 08:34:48 INFO - no previously-included directories found matching 'dist' 08:34:48 INFO - no previously-included directories found matching '.git*' 08:34:48 INFO - Successfully installed jsonschema functools32 08:34:48 INFO - Cleaning up... 08:34:48 INFO - Return code: 0 08:34:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e984490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b586380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e798d30>, '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 0x10e5fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e790b20>, '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.Nsb1qyF30j/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.aUfSDm8a4z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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 08:34:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:34:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nsb1qyF30j/Render', 08:34:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:48 INFO - 'HOME': '/Users/cltbld', 08:34:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:48 INFO - 'LOGNAME': 'cltbld', 08:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:48 INFO - 'MOZ_NO_REMOTE': '1', 08:34:48 INFO - 'NO_EM_RESTART': '1', 08:34:48 INFO - 'PAGER': '/bin/cat', 08:34:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:48 INFO - 'PWD': '/builds/slave/test', 08:34:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:48 INFO - 'SHELL': '/bin/bash', 08:34:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aUfSDm8a4z/Listeners', 08:34:48 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 08:34:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:48 INFO - 'USER': 'cltbld', 08:34:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:48 INFO - 'XPC_FLAGS': '0x0', 08:34:48 INFO - 'XPC_SERVICE_NAME': '0', 08:34:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:34:48 INFO - Cleaning up... 08:34:48 INFO - Return code: 0 08:34:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:48 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 0x10e984490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b586380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e798d30>, '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 0x10e5fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e790b20>, '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.Nsb1qyF30j/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.aUfSDm8a4z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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 08:34:48 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 08:34:48 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 08:34:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nsb1qyF30j/Render', 08:34:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:48 INFO - 'HOME': '/Users/cltbld', 08:34:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:48 INFO - 'LOGNAME': 'cltbld', 08:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:48 INFO - 'MOZ_NO_REMOTE': '1', 08:34:48 INFO - 'NO_EM_RESTART': '1', 08:34:48 INFO - 'PAGER': '/bin/cat', 08:34:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:48 INFO - 'PWD': '/builds/slave/test', 08:34:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:48 INFO - 'SHELL': '/bin/bash', 08:34:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aUfSDm8a4z/Listeners', 08:34:48 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 08:34:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:48 INFO - 'USER': 'cltbld', 08:34:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:48 INFO - 'XPC_FLAGS': '0x0', 08:34:48 INFO - 'XPC_SERVICE_NAME': '0', 08:34:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:49 INFO - Downloading/unpacking blobuploader==1.2.4 08:34:49 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 08:34:49 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 08:34:49 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 08:34:49 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 08:34:49 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 08:34:49 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 08:34:51 INFO - Downloading blobuploader-1.2.4.tar.gz 08:34:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:34:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:34:51 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 08:34:51 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 08:34:51 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 08:34:51 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 08:34:51 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 08:34:51 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 08:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:34:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:34:52 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 08:34:52 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 08:34:52 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 08:34:52 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 08:34:52 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 08:34:52 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 08:34:52 INFO - Downloading docopt-0.6.1.tar.gz 08:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:34:52 INFO - Installing collected packages: blobuploader, requests, docopt 08:34:52 INFO - Running setup.py install for blobuploader 08:34:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:34:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:34:53 INFO - Running setup.py install for requests 08:34:53 INFO - Running setup.py install for docopt 08:34:53 INFO - Successfully installed blobuploader requests docopt 08:34:53 INFO - Cleaning up... 08:34:53 INFO - Return code: 0 08:34:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:53 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 0x10e984490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b586380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e798d30>, '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 0x10e5fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e790b20>, '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.Nsb1qyF30j/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.aUfSDm8a4z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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 08:34:53 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 08:34:53 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 08:34:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nsb1qyF30j/Render', 08:34:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:53 INFO - 'HOME': '/Users/cltbld', 08:34:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:53 INFO - 'LOGNAME': 'cltbld', 08:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:53 INFO - 'MOZ_NO_REMOTE': '1', 08:34:53 INFO - 'NO_EM_RESTART': '1', 08:34:53 INFO - 'PAGER': '/bin/cat', 08:34:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:53 INFO - 'PWD': '/builds/slave/test', 08:34:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:53 INFO - 'SHELL': '/bin/bash', 08:34:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aUfSDm8a4z/Listeners', 08:34:53 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 08:34:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:53 INFO - 'USER': 'cltbld', 08:34:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:53 INFO - 'XPC_FLAGS': '0x0', 08:34:53 INFO - 'XPC_SERVICE_NAME': '0', 08:34:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:34:54 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-bwkAA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:34:54 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-K9s_Uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:34:54 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-_5LMiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:34:54 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-S1ugpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:34:54 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-l3GDon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:34:54 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-zfGtzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:34:54 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-iykfye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:34:54 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-lIcCWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:34:54 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-KJNobE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:34:55 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-qeu8WF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:34:55 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-qjqQGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:34:55 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-kIwYlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:34:55 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-tUxdVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:34:55 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-hvTPuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:55 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-aTYTrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:34:55 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-m0bnv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:34:55 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-EX2JfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:34:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:34:55 INFO - Running setup.py install for manifestparser 08:34:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:34:56 INFO - Running setup.py install for mozcrash 08:34:56 INFO - Running setup.py install for mozdebug 08:34:56 INFO - Running setup.py install for mozdevice 08:34:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:34:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:34:56 INFO - Running setup.py install for mozfile 08:34:56 INFO - Running setup.py install for mozhttpd 08:34:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:34:56 INFO - Running setup.py install for mozinfo 08:34:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:34:56 INFO - Running setup.py install for mozInstall 08:34:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:34:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:34:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:34:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:34:57 INFO - Running setup.py install for mozleak 08:34:57 INFO - Running setup.py install for mozlog 08:34:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:34:57 INFO - Running setup.py install for moznetwork 08:34:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:34:57 INFO - Running setup.py install for mozprocess 08:34:57 INFO - Running setup.py install for mozprofile 08:34:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:34:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:34:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:34:57 INFO - Running setup.py install for mozrunner 08:34:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:34:58 INFO - Running setup.py install for mozscreenshot 08:34:58 INFO - Running setup.py install for moztest 08:34:58 INFO - Running setup.py install for mozversion 08:34:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:34:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:34:58 INFO - Cleaning up... 08:34:58 INFO - Return code: 0 08:34:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:58 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 0x10e984490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b586380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e798d30>, '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 0x10e5fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e790b20>, '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.Nsb1qyF30j/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.aUfSDm8a4z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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 08:34:58 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 08:34:58 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 08:34:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nsb1qyF30j/Render', 08:34:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:58 INFO - 'HOME': '/Users/cltbld', 08:34:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:58 INFO - 'LOGNAME': 'cltbld', 08:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:58 INFO - 'MOZ_NO_REMOTE': '1', 08:34:58 INFO - 'NO_EM_RESTART': '1', 08:34:58 INFO - 'PAGER': '/bin/cat', 08:34:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:58 INFO - 'PWD': '/builds/slave/test', 08:34:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:58 INFO - 'SHELL': '/bin/bash', 08:34:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aUfSDm8a4z/Listeners', 08:34:58 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 08:34:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:58 INFO - 'USER': 'cltbld', 08:34:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:58 INFO - 'XPC_FLAGS': '0x0', 08:34:58 INFO - 'XPC_SERVICE_NAME': '0', 08:34:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:34:58 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-uHnQ5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:34:58 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)) 08:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:34:58 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-GMtVdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:34:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-72SWwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:34:59 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)) 08:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:34:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-oDZk6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:34:59 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)) 08:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:34:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-vhUlWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:34:59 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)) 08:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:34:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-mK19NH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:34:59 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)) 08:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:34:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-xlqPjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:34:59 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)) 08:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:34:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-ZsXgc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:34:59 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)) 08:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:34:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-4tSudd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:34:59 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)) 08:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:34:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-owMVYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:34:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-0ibBBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:34:59 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)) 08:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:34:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-7HJkOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:35:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:35:00 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-hEW4zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:35:00 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)) 08:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:35:00 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-7OhblG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:35:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:00 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-3Ib5GG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:00 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)) 08:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:35:00 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-BfftVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:35:00 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)) 08:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:35:00 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-QSi2U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:35:00 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)) 08:35:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:35:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:35:00 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)) 08:35:00 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)) 08:35:00 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)) 08:35:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:03 INFO - Downloading blessings-1.6.tar.gz 08:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:35:03 INFO - Installing collected packages: blessings 08:35:03 INFO - Running setup.py install for blessings 08:35:03 INFO - Successfully installed blessings 08:35:03 INFO - Cleaning up... 08:35:03 INFO - Return code: 0 08:35:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:35:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:35:03 INFO - Reading from file tmpfile_stdout 08:35:03 INFO - Current package versions: 08:35:03 INFO - blessings == 1.6 08:35:03 INFO - blobuploader == 1.2.4 08:35:03 INFO - docopt == 0.6.1 08:35:03 INFO - functools32 == 3.2.3-2 08:35:03 INFO - jsonschema == 2.5.1 08:35:03 INFO - manifestparser == 1.1 08:35:03 INFO - mozInstall == 1.12 08:35:03 INFO - mozcrash == 1.0 08:35:03 INFO - mozdebug == 0.1 08:35:03 INFO - mozdevice == 0.48 08:35:03 INFO - mozfile == 1.2 08:35:03 INFO - mozhttpd == 0.7 08:35:03 INFO - mozinfo == 0.9 08:35:03 INFO - mozleak == 0.1 08:35:03 INFO - mozlog == 3.4 08:35:03 INFO - moznetwork == 0.27 08:35:03 INFO - mozprocess == 0.23 08:35:03 INFO - mozprofile == 0.28 08:35:03 INFO - mozrunner == 6.13 08:35:03 INFO - mozscreenshot == 0.1 08:35:03 INFO - mozsystemmonitor == 0.3 08:35:03 INFO - moztest == 0.7 08:35:03 INFO - mozversion == 1.4 08:35:03 INFO - psutil == 3.1.1 08:35:03 INFO - requests == 1.2.3 08:35:03 INFO - wsgiref == 0.1.2 08:35:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:04 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 0x10e984490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b586380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e798d30>, '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 0x10e5fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e790b20>, '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.Nsb1qyF30j/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.aUfSDm8a4z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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 08:35:04 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 08:35:04 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 08:35:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nsb1qyF30j/Render', 08:35:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:04 INFO - 'HOME': '/Users/cltbld', 08:35:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:04 INFO - 'LOGNAME': 'cltbld', 08:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:04 INFO - 'MOZ_NO_REMOTE': '1', 08:35:04 INFO - 'NO_EM_RESTART': '1', 08:35:04 INFO - 'PAGER': '/bin/cat', 08:35:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:04 INFO - 'PWD': '/builds/slave/test', 08:35:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:04 INFO - 'SHELL': '/bin/bash', 08:35:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aUfSDm8a4z/Listeners', 08:35:04 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 08:35:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:04 INFO - 'USER': 'cltbld', 08:35:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:04 INFO - 'XPC_FLAGS': '0x0', 08:35:04 INFO - 'XPC_SERVICE_NAME': '0', 08:35:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:04 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)) 08:35:04 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)) 08:35:04 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)) 08:35:04 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)) 08:35:04 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)) 08:35:04 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)) 08:35:04 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)) 08:35:04 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)) 08:35:04 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)) 08:35:04 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)) 08:35:04 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)) 08:35:04 INFO - Cleaning up... 08:35:04 INFO - Return code: 0 08:35:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e984490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8fa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad8b586380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e798d30>, '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 0x10e5fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e790b20>, '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.Nsb1qyF30j/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.aUfSDm8a4z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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 08:35:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:35:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nsb1qyF30j/Render', 08:35:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:05 INFO - 'HOME': '/Users/cltbld', 08:35:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:05 INFO - 'LOGNAME': 'cltbld', 08:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:05 INFO - 'MOZ_NO_REMOTE': '1', 08:35:05 INFO - 'NO_EM_RESTART': '1', 08:35:05 INFO - 'PAGER': '/bin/cat', 08:35:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:05 INFO - 'PWD': '/builds/slave/test', 08:35:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:05 INFO - 'SHELL': '/bin/bash', 08:35:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aUfSDm8a4z/Listeners', 08:35:05 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 08:35:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:05 INFO - 'USER': 'cltbld', 08:35:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:05 INFO - 'XPC_FLAGS': '0x0', 08:35:05 INFO - 'XPC_SERVICE_NAME': '0', 08:35:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:35:05 INFO - Cleaning up... 08:35:05 INFO - Return code: 0 08:35:05 INFO - Running post-action listener: _resource_record_post_action 08:35:05 INFO - Running post-action listener: _start_resource_monitoring 08:35:05 INFO - Starting resource monitoring. 08:35:05 INFO - [mozharness: 2016-12-09 16:35:05.652837Z] Finished create-virtualenv step (success) 08:35:05 INFO - [mozharness: 2016-12-09 16:35:05.653869Z] Running install step. 08:35:05 INFO - Running pre-action listener: _resource_record_pre_action 08:35:05 INFO - Running main action method: install 08:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:35:05 INFO - Reading from file tmpfile_stdout 08:35:05 INFO - Detecting whether we're running mozinstall >=1.0... 08:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:35:06 INFO - Reading from file tmpfile_stdout 08:35:06 INFO - Output received: 08:35:06 INFO - Usage: mozinstall [options] installer 08:35:06 INFO - Options: 08:35:06 INFO - -h, --help show this help message and exit 08:35:06 INFO - -d DEST, --destination=DEST 08:35:06 INFO - Directory to install application into. [default: 08:35:06 INFO - "/builds/slave/test"] 08:35:06 INFO - --app=APP Application being installed. [default: firefox] 08:35:06 INFO - mkdir: /builds/slave/test/build/application 08:35:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:35:37 INFO - Reading from file tmpfile_stdout 08:35:37 INFO - Output received: 08:35:37 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:35:37 INFO - Running post-action listener: _resource_record_post_action 08:35:37 INFO - [mozharness: 2016-12-09 16:35:37.310725Z] Finished install step (success) 08:35:37 INFO - [mozharness: 2016-12-09 16:35:37.310883Z] Running run-tests step. 08:35:37 INFO - Running pre-action listener: _resource_record_pre_action 08:35:37 INFO - Running main action method: run_tests 08:35:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:35:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:35:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:35:37 INFO - 2016-12-09 08:35:37.325 screenresolution[1626:7324] starting screenresolution argv=screenresolution get 08:35:37 INFO - 2016-12-09 08:35:37.327 screenresolution[1626:7324] Display 0: 1600x1200x32@60 08:35:37 INFO - 2016-12-09 08:35:37.333 screenresolution[1627:7326] starting screenresolution argv=screenresolution list 08:35:37 INFO - Available Modes on Display 0 08:35:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:35:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:35:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:35:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:35:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:35:37 INFO - Intel Iris: 08:35:37 INFO - Chipset Model: Intel Iris 08:35:37 INFO - Type: GPU 08:35:37 INFO - Bus: Built-In 08:35:37 INFO - VRAM (Dynamic, Max): 1536 MB 08:35:37 INFO - Vendor: Intel (0x8086) 08:35:37 INFO - Device ID: 0x0a2e 08:35:37 INFO - Revision ID: 0x0009 08:35:37 INFO - Displays: 08:35:37 INFO - Display: 08:35:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:35:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:35:37 INFO - Display Serial Number: 1600x1200 60 08:35:37 INFO - Main Display: Yes 08:35:37 INFO - Mirror: Off 08:35:37 INFO - Online: Yes 08:35:37 INFO - Rotation: Supported 08:35:37 INFO - Return code: 0 08:35:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:35:37 INFO - Python 2.7.3 08:35:37 INFO - Return code: 0 08:35:37 INFO - grabbing minidump binary from tooltool 08:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:37 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e798d30>, '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 0x10e5fedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e790b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:35:37 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 08:35:37 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 08:35:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:35:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:35:37 INFO - Return code: 0 08:35:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:35:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:35:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:35:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:35:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:35:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0276', '--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 08:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0276 --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 08:35:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Nsb1qyF30j/Render', 08:35:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:37 INFO - 'HOME': '/Users/cltbld', 08:35:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:37 INFO - 'LOGNAME': 'cltbld', 08:35:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:35:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:37 INFO - 'MOZ_NO_REMOTE': '1', 08:35:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:35:37 INFO - 'NO_EM_RESTART': '1', 08:35:37 INFO - 'PAGER': '/bin/cat', 08:35:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:37 INFO - 'PWD': '/builds/slave/test', 08:35:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:35:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:37 INFO - 'SHELL': '/bin/bash', 08:35:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aUfSDm8a4z/Listeners', 08:35:37 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 08:35:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:37 INFO - 'USER': 'cltbld', 08:35:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:37 INFO - 'XPC_FLAGS': '0x0', 08:35:37 INFO - 'XPC_SERVICE_NAME': '0', 08:35:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0276', '--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 08:35:37 INFO - mozversion application_buildid: 20161209060650 08:35:37 INFO - mozversion application_changeset: f6f2e2b9fa87a1cf454dec44bcf52cd4f96288a0 08:35:37 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:35:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:35:37 INFO - mozversion application_name: Firefox 08:35:37 INFO - mozversion application_remotingname: firefox-dev 08:35:37 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:35:37 INFO - mozversion application_vendor: Mozilla 08:35:37 INFO - mozversion application_version: 52.0a2 08:35:37 INFO - mozversion platform_buildid: 20161209060650 08:35:37 INFO - mozversion platform_changeset: f6f2e2b9fa87a1cf454dec44bcf52cd4f96288a0 08:35:37 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:35:37 INFO - mozversion platform_version: 52.0a2 08:35:37 INFO - using testdate: 1481301337 08:35:37 INFO - actual date: 1481301337 08:35:37 INFO - starting webserver on 'localhost:49241' 08:35:37 INFO - SUITE-START | Running 2 tests 08:35:37 INFO - TEST-START | dromaeo_css 08:35:37 INFO - operating with platform_type : mac_ 08:35:37 INFO - Initialising browser for dromaeo_css test... 08:35:37 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/tmpIT3Cy_/profile http://localhost:49241/getInfo.html) 08:35:40 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 08:35:40 INFO - PROCESS | 1637 | colorDepth:24 08:35:40 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 08:35:40 INFO - PROCESS | 1637 | __metrics 08:35:40 INFO - PROCESS | 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:35:40 INFO - PROCESS | 1637 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:35:41 INFO - TEST-INFO | 1637: exit 0 08:35:41 INFO - Browser initialized. 08:35:41 INFO - Running cycle 1/1 for dromaeo_css test... 08:35:41 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/tmpIT3Cy_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:53 INFO - PROCESS | 1639 | RSS: Main: 222830592 08:35:53 INFO - PROCESS | 1639 | 08:36:45 INFO - PROCESS | 1639 | 1481301405312 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] 08:38:58 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:39:00 INFO - PROCESS | 1639 | RSS: Main: 397070336 08:39:00 INFO - PROCESS | 1639 | 08:42:03 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 08:42:04 INFO - PROCESS | 1639 | RSS: Main: 348577792 08:42:04 INFO - PROCESS | 1639 | 08:45:06 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 08:45:07 INFO - PROCESS | 1639 | RSS: Main: 326180864 08:45:07 INFO - PROCESS | 1639 | 08:48:09 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 08:48:10 INFO - PROCESS | 1639 | RSS: Main: 332595200 08:48:10 INFO - PROCESS | 1639 | 08:51:13 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 08:51:14 INFO - PROCESS | 1639 | RSS: Main: 315973632 08:51:14 INFO - PROCESS | 1639 | 08:54:17 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 08:54:17 INFO - PROCESS | 1639 | RSS: Main: 380977152 08:54:17 INFO - PROCESS | 1639 | 08:54:17 INFO - PROCESS | 1639 | __start_tp_report 08:54:17 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 08:54:17 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 08:54:17 INFO - PROCESS | 1639 | |i|pagename|runs| 08:54:17 INFO - PROCESS | 1639 | |0;dojo.html;2648.2849630599726;3163.14595059334;3332.2339160245065;3341.264921717222;3344.662135145943;5532.336119665641;5591.888162236753;5607.355154157273;5624.71876406179;5666.348369937464;5569.303837020372;5630.09918413054;5649.774009039634;5653.236813030239;5680.744366503507;5117.923231151536;5135.05001574708;5143.871403214931;5188.9881473112755;5228.972217673714;5120.8975820483565;5139.023585518739;5152.587792976572;5210.55710264626;5243.501867322599;5113.693178409308;5136.075506408845;5156.613254005946;5164.2770012198325;5199.272101905736;5154.5103215194495;5201.739913004335;5230.058589453897;5233.842984710427;5275.393329767049;4964.975175124137;5122.257272695476;5162.5611822994715;5164.147915593922;5169.4572069932865;5528.087865502228;5534.557235421156;5575.219469274305;5584.748686309126;5620.662760234399;6136.9079463808075;6147.323794382614;6187.535934804908;6224.719887605069;6256.0303153011355;6279.748810047593;6322.4942004639515;6328.873422531524;6330.177076979963;6330.588511746768;5652.208690783294;5709.0865461525955;5710.685912274865;5785.074388097884;5819.185314056035;6341.112244285804;6352;6405.423511883952;6407.807765767035;6415.615063096229;5340.679559226459;6014.879702406015;6115.4190351916495;6125.234345706786;6134.570580059353;5990.281166260077;6025.548083893726;6028.276606807123;6040.6677632730625;6113.755449782047;5984.880302393928;6002.399760023963;6006.6696331701305;6009.038553831366;6010.429009244115;6000.699965001732;6033.698315084228;6048.546359023091;6053.4551890330085;6069;4807.711537307773;4831;4835.468098509161;4842.806287748451;4850.296706977469;4392.934105988349;4433.4236549249035;4442.067165895198;4466.307722303049;4491.146682130385;5680.261565996394;5747;5754.625949313281;5772.769089236467;5780.16187652788;6067.1202675611785;6212.409821066992;6235.96882015587;6241.157443745127;6267.059941008885;5625.690587017753;5674.177244299636;5693.886122277614;5715.799947001835;5718.714064296769;5296.576273898079;5348.679079255257;5355.571554275649;5367.651102678314;5381.67709937405;6371.776987805404;6374.74501019954;6384.329645387167;6396.360363963752;6400.167978162809;4784.928226076542;6061.302950160788;6068.787592434243;6199.814005579839;6209.161763162096;6319.652419116993;6350.650714210763;6360.872782544416;6361.427471527585;6362.745490180526;5290.8941821164135;6106.5114790817515;6184.907226391518;6208.317085120723;6228.22147231596;6055.636661800306;6080.847978800565;6104.755809767737;6252.781152659635;6307.621542707452;5855;5880.705964701662;5907.822765317047;5916.585838991401;5919.822405327847;5821.94178058231;5932.940670593239;5964.343922168645;5975.970120149372;6092.573519853745;4944.085344211332;5834.912476312774;5872.882542349214;5876.853078673067;5900.70496475166;5853.882922341614;6036.758529658764;6041.2750469943885;6047.576669633084;6052.122442245762;5762.740676669476;5782.421757824352;5804.1874137619925;5811.883762324815;5857.765689372548 08:54:17 INFO - PROCESS | 1639 | |1;ext.html;448.4148186616465;508.96437249392534;510.68848002718346;528.4741682026385;555.8415851482329;29560.556591651144;31649.84175079124;31666.366672666532;37786.622133778656;39074.41388379176;41296.38055429171;41673.16653666925;41677.58322416775;41736.791316043375;41840.79079604598;9299.488528130967;9472.384295020836;9472.479013654247;9476.14714675679;9485;9324.300677449184;9407;9432.103950124761;9439.95280023599;9454.90545094547;9371.718848434557;9423.38747981379;9431.669891553796;9463.81072378552;9477.38397004196;9360.531973401337;9365.438073715564;9376.624935002592;9381.577828997712;9382.24942004638;9400.435973841522;9454.95272523633;9470.384425012353;9472.715818525456;9500.287478439075;38814.80592597019;39156.412653810214;39162;39165.41251881224;39429;3258.4949332853444;3317.270200555874;3320.667933206684;3338.983305083459;3667.963320366789;28337.291567710767;28879.989200378095;29701.851490742407;29800.552991705143;30296.788128475055;2630.658014458127;3098.2409309719037;3109.284864481182;3225.645179030305;3229.580154579913;436202;437638;437670;437884;438925.9999999968;57355.13967290494;57374.426255737744;57669.13496297475;57702;57882.131768023515;48290.75854620704;59957.40042599518;60208;60233;60252.39747602468;14255.429782808778;14451.349689264009;14460.20468874201;14463.27683615815;14475.85524144745;11342.546298147981;11456.026237769716;11480.712982175346;11487.195896287347;11509.827352589718;15710.450134245246;15721.292541835644;15723;15836.445724399591;15845.207739612973;4942.308076869242;5013.5989120870245;5033.6476446648385;5830.076074895274;5969.403059694083;724.5399171526013;833.4832403909494;915.8534634458455;973.9366941148803;1032.1020711980625;24165.637515437284;28935;28999;29342;29692.47613952795;1027.5684212630713;1076.381080878498;1082.6156714366443;1104.1829046505527;1192.8687844337117;14812.111273323635;15055.54833355001;15173.620659483602;15509;15516;632899.8355008288;638632;639433;640574;641000;56050.71974640101;56206.71896640491;56346;56414.43585564092;56483.71758141183;1047;1279.36031984008;1340.6916409225737;1367.131871261756;1396.315805255438;28807.27981800388;30175.547366789953;30286;30327.241818954702;30871.691283086882;41197.58802411937;46735.29897051479;47062.529374707185;47939.801504962656;47943;528586;531499;532388;533750;534174;25130.617816020294;26089.478210436064;26139.477210456065;26707;26828.463430730884;44664.55335446604;44736.15070021068;44954.65136045924;45712;45882.54117458916;36877.26245475022;37116.443253350684;37465.4380184292;38300.80849595734;38717.419238712006;35275.64724352724;37055.258894822495;37338;38324.6167538321;38337;36198.8190059048;37104.73295571044;37296;37366.62633373631;37499.81250093732;31068.84465577748;33055.173620659676;33464.665353347125;33535.82624608127;33876;24543.754562454145;24758.50482990366;24964.251072467854;25095.372615684755;25471.87264063742 08:54:17 INFO - PROCESS | 1639 | |2;jquery.html;334.1445898499842;368.10183153106425;368.64057543894705;378.748132491893;397.3642172523962;14557.92721036396;14897.776533351995;15535.378584856593;19428.708569371436;19970.001499924983;18744.531386715338;19608.803911960877;19700.408987730392;19709;19863.20547178111;5614.157876318544;5984.820455386323;5987.6108052976415;5988.281406231258;5990.292766561531;4773.832915847946;5528.419515950827;5813.244278243844;5880.294364676245;5886.76452941884;5804.651720896739;5829.067349224125;5833.795817146401;5838.737256823432;5859.267591551056;5633.155026746001;5931.110333449974;5964.015937370329;6005.369436209179;6017.608855424383;4974.37820272466;5522.66863988162;5731.340895796995;5753.137029445575;5787.074068149076;10770.838437423445;13097.86902130976;17490.65018699619;24645.87677061621;25511.851966661543;2150.827933765295;2222.2222222222094;2272.9204477843364;2356.3166681662296;2363.9645405318934;8227.629756660965;9497.287703422202;10151.289409741321;10250.846237306447;13495.257760823151;1787.6603445345343;1819.7261916658392;1830.4417152768401;1857.0436225343958;1860.2280053777665;108324.45837770839;116462.41768791186;120161;125559.74440255572;127409;10613.718050619154;11024.393658348707;11084.279521831055;11334.092134427585;11499.540018399337;14242.643933901529;14269.215193164267;14278.785818212735;14281.428742850378;14305.57083287503;6634.734610615521;7779.961100194463;7982.640781164861;8048.0342358917305;8169.387295952827;7823.608819558999;7828;7839.843203135905;7924.920750792534;7988.840223195503;4367.10474352757;4369.257226271541;4373.890652733707;4381.101874115799;4429.53489883564;1591.6498370358502;1714.768506251665;1827.9360222392152;1870.661672908864;1872.4944265048632;702.9578225306498;727.756201672435;795.2047952047952;879.3185281406961;926.7822061815468;16441;17697.469075927744;20705.792942070686;21444.463888402915;21752.347429577138;863.7581477186397;870.8214815962713;921.7142685767434;948.9478078705599;999.7500624843789;10559.102476289449;11145.16411269158;11369.431528423711;11431.828522572168;11447.599334023269;603812;624816;626034;648106;650021;77129;131747;131857;134690;142961;932.8227636749132;993.9900600994042;1003.5684655598017;1003.9548220330249;1010.7978404319166;18616.441506754818;18664.34674786376;18974.810251897303;19092.33176838804;19341.1296491661;43767.12465750731;54026;54602.72698636481;55701.7214913939;56805.431945680015;80085.59957200177;81476;81660.59169704113;82147.58926205331;84340;7978.481398709066;8073.031236251687;8103.565390279037;8146.103928567972;8320.084790673141;11555.537778488766;12815.295158766357;12908.612741617766;13057.869421305666;13188.274644894624;8926.152015558511;11063.889361106609;11156.776864462827;11406.771864562828;11448.542058317575;8368.321992181727;10251.128654064489;11071.557137714723;11186;11265.549378024787;11272.718182045515;11314.208005439541;11442.256253343507;11479.311241325548;11620.302781833117;7799.142094369501;7974;7987.64055617487;8141.307988821017;8338.791530211793;9793.902060979299;10652;10656.680299591024;11092.223544351818;11115.94398532138 08:54:17 INFO - PROCESS | 1639 | |3;mootools.html;1182.8349076159984;1387.7571425000622;1531.708975294694;1796;1826.2238548616835;8014.438989270746;8443.282321002722;8446.15538446155;8447.535385553792;8452.07027227006;7371.594562299071;7653;7660.616969151548;7734.38124950004;7754.418418618612;2084.6664533674652;2241.9887900560557;2323.349462150592;2325.5232677301115;2337.9415514612188;2335.754745751697;2362.751911049341;2371.21749822559;2373.0626402570974;2378.857268563892;2314.143766806284;2342.273895092518;2345.296411076679;2345.3433038749176;2348.037304705071;2290.690756747843;2328.592496313155;2332.195392589554;2335.1593426366494;2336.1661096039697;2323.93028209154;2328.8253380996493;2356.3166681662296;2358.25714899806;2358.3750306168877;8323.1260717625;8353.707620233263;8422.15778422159;8439.02951160612;8460.153984601491;4148.937765933513;5121.462246464105;5122.667026643257;5126.2054381570915;5129.153689641204;3148.511980643004;3264.183954011497;3284.770066095374;3349.279904820451;3357.8992630220887;922.3866129024191;964.7636329099346;1000.6547741029333;1003.4731765822928;1005.572631631561;10765.3540787553;10827.67516974492;10849;10862.293950893167;10890.40102794338;3945.704072194597;4339.869803905888;4507.211238033331;4592.88517787058;4595.356650068993;9253.491057991874;9322.440653560809;9322.720318390458;9333.486658233727;9337.299702522203;5025.045241404122;5025.748712564357;5027.899442011212;5032.974835125801;5032.974835125874;4558.8632341029825;4605.861824145281;4610;4623.329617205553;4670.136024835417;3590.1204204969426;3634.8727794527063;3641.253543023674;3670.9082272942856;3708.721845861571;1140.1391949078559;1142.5772464188137;1150.0282261489028;1150.2983180260035;1153.3887039868714;770.3144201660526;867.2714919467677;901.4771432569095;912.5072460871188;919.7332773495746;5531.502164805106;5631.211630371751;5631.4087020863035;5697.9430205698245;5807.490052586358;853.2278288149234;888.5113187746842;902.2421166220275;908.355067901784;929.762910457829;3153.880372467787;3626.5648122224975;3791.0901383668274;3953.0512676957896;3975.662068724133;9983.151432128205;10180.694579162637;10199.796004079877;10209.642662506776;10232;8577.914220857836;10006.449645269435;10023.348482348623;10153.390796552083;10169.694909152737;6154.7230374633245;7567.723658596092;7673.079230492265;7798.922010779933;7865.370770338359;5526.447355264602;5532.1701744737;5537;5611.438856114356;5885.440883116097;9097.044810294823;9164.221041211571;9310.394824336396;9329.673461428818;9422.811543769223;7919.920800791919;9385.577649005947;9434.386764860263;9566.569504372459;9590.568424421057;7072.929270707227;7271.563706177646;7280.927190728236;7286.7085316586745;7314.96342518284;7667.88498172539;7750.379969602531;7761.534307941542;7777.805554861174;7823.8435231293915;7107.75122870697;7108.07595012645;7124.857502850017;7151.2848715128075;7194.496385252982;7022.578645281299;7061.964690176516;7077.150741911004;7078.469114816512;7089.36195742365;6596.670166491752;6649.700763465559;6650.235222949423;6737.157855268091;6740.662966851736;4702.576768090888;4784.976075119602;4852.927206091841;4879.634027447884;4891.413030436371;4778.641601879943;4780.187368147493;4862.95137048625;4919.7540122993;5047.747612619428 08:54:17 INFO - PROCESS | 1639 | |4;prototype.html;280.22797193731265;294.3729855407981;296.26230685592867;303.9878404863805;306.2206683989247;4298.001429335359;4541.911500179876;4691.460482044566;4867.513248675135;5123.205903085019;4894.5594896459315;5072.568831649314;5110.795568177268;5142.254373115905;5164.483551644834;3452.9813704956973;3942.5162147846886;3980.5471003083812;3995.720299579031;4032.495938007749;3740.438934159884;3926.548446928597;3944.6252606002386;3972.423998520213;4037.4953130858644;3257.65794591568;3448.6723761242642;3889.6580679665612;3907.550631677365;4094.672426205911;3506.0899453453826;3845.6346647068485;3903.70722195835;3920.941185882214;3927.6661483773914;2843.24653966699;3417.3848707232687;3427.280271143038;3433.5879694436576;3441.4493681010917;4102.671786257092;4657.301404789275;4832.710037397732;4898.755062246873;5046.167382381903;3896.3960586109197;4424.601785839258;4450.399196108517;4461.776911154462;4474.328850672393;5111.565516931066;5168.165301318053;5400.945990540084;5408.972955135238;5419.83740487786;3331.4836200388977;3594.4248920172645;3692.335379631665;3701.6298370163036;3703.2963736889906;5337.626366154371;5580.469855363734;5615.438456154434;5637.915431268534;5653.632513886584;3193.163930739834;3789.962100379016;3794.6774524165753;3807.459063071315;3808.8095595220684;3235.9514607280908;3674.9448758268645;3770.434434834797;3825.5600605930117;3847.8076096195077;4166.312558427886;4294.227039132924;4305.48334199898;4310.22415965123;4461.215513794508;4847.345608342899;5208.713520756319;5452.890942181213;5462.2079798429;5479.356193142042;1098.3629494892944;1130.282270758058;1200.565324437289;1205.5961252980173;1246.5574720974105;759.8214419611387;787.9172686867796;804.2038382001776;825.6202147012322;846.4413487098485;4701.506341834058;4704.576588107018;4753.811547113221;4780.4624577812165;4817.735024573612;4555.749433781174;4749.762511874393;5183.041137389595;5217.973910130425;5235.764390602432;4467.486239082482;4667.393238878924;4682.929756053662;4733.644976626767;4939.2838038484215;2343.7890589846997;2379.0729509097687;2723.305557082931;2725.877335519867;2734.5077885980713;4552.179128348621;4819.3252744726315;5399.759099973467;5419.729013549307;5463.289772329572;4838.95161048392;5058.974705126524;5080.593552515864;5224.582033437316;5327.0482020962245;4848.442429120626;5404.32445944257;5416.674999500043;5423.213634023124;5427.755750991215;4271.7009809314295;4307.633851122564;4412.624926881251;4527.4340707411575;5192.870178245423;4146.5024197096545;4484.955150448584;4674;5184.377874655065;5233.869153271199;4705.517761904989;4717.787699553597;4818.0133561763405;4836.7666245107275;5165.811863271544;3274.9672503274664;3550.6271841456273;3562.239264569979;3566.199069469901;3595.280943811196;4926.975365123151;5024.397072351341;5174.663646862942;5208.895822083613;5227.790888364423;4290.592393722592;5332.33345831771;5358.839234822962;5363.881266899631;5396.9730151348995;4492.191405547033;4897.159647404568;5074.416442109205;5469.156038859691;5493.945060549343;5064.4935506449065;5289.418164002033;5335.572314596771;5338.519533242027;5392.838214853561;5416.862458883678;5428.267183930277;5443.727813609383;5470.234167216513;5472.069748142905;4427.335899615084;4456.955430445654;5293.338332708411;5326.6537675050995;5337.386200586982 08:54:17 INFO - PROCESS | 1639 | |5;yui.html;623.697506709246;757.2049348184408;771.8340556780291;780.6448066129908;783.1229023493686;12485.375731213426;12628.24230546168;13011.73976520469;13115.409806558704;13121.475140994373;12443.377831108432;14158.575242742709;14504.782428263585;14658.63353416165;15012.849871501308;801.5591424716412;804.1998211779259;815.4617952151581;821.5317269156583;829.854775414303;653.1900443450112;674.1977047313705;822.8436597046542;826.0871736730916;827.0158511371449;839.3830534557096;862.4264863865553;865.5801936061036;867.5878957495171;867.6225841758824;848.0163010907318;848.1603212819265;849.4818160921833;850.5322072859902;850.5407080176728;627.4447114303829;627.5230824573312;627.6359711367442;628.0453710360273;628.6573817269599;13722.725545489135;13972.231527266098;13992.650183745385;14010.439582416691;14030.158190508602;12544.74910501794;12713.745725085539;12766.978641708642;12780.169288996185;12834.037447191404;10192.79614407715;11956;12171.208871423329;12194.878051219463;12681.30252836103;3626.4197728363333;3786.2238241160494;4310.590493903074;4379.605835474823;4418.182636212279;63413;72104;84607.15392846054;84726.15273847306;86029;10227.232957528215;10239.027292407209;10250.692479225636;10336.17310615149;10416.010479004482;19445.708314375297;19457.51356216106;19650.31223907185;19658;19681.901590491954;6406.8718625627225;7114.14630244374;7279.927200728031;7575.053118360205;7624.085109786861;3469.3755720937575;4130.876073717734;4258.850940217078;4285.571442855689;4335.417572586047;3304.1739565108724;3406.199543107368;3423.5720534933134;3432.262063656326;3434.21013166973;635.8187916443791;637.6747858592058;646.6475770704977;651.1502489251573;652.1228947066188;583.9445252700987;627.7583130494793;632.9898850597469;636.8853606350808;682.1507223506766;8243.917560824435;8276.917230827736;8673;8677.956610217036;8780.648774049094;604.8548348396441;610.1001023490405;621.7854840080256;639.888019596578;652.9934700652933;3980.960190398117;4202.873913782591;4212.304969679968;4300.005472010643;4312.69811113219;109692;110951.44524277328;112854;113784.86215137743;117323;90550.09449905549;91121.54439227762;95025.5248723752;95378;98752;84995;86854.56572717348;89539.55230223807;91003.08996909946;92766.07233927575;8160.224778646019;8238.794030149294;8533.87199192025;9157.77105572366;9314.580843862179;42528.57471425246;51814;52353.47646523486;53188;54930.725346373016;57249;59878.10792298487;62246;74901.64122919875;77199.61400192963;11712.70718232051;11751.941240293743;11845.230060046415;11914.344711040629;12232.082593805322;12816.423260953467;13297.933510332774;13381.66545836362;13405.262710551013;13434.798478023033;12159.088068395082;12246.87753122493;12415.565455209024;12482.875171248172;12489.31308778026;12215.69460763488;12423.254604723745;12451.331028265213;12481.56314528987;12868.163569367962;9959.45628427595;10379.792404151724;12116.697082573006;12210.816837747618;12227.69430764238;10358.948205259227;10373.792524149625;10414.895851041392;10509.369437833755;10631.20265980039;10138.543765530716;10237.464913724109;10659.307145035547;10713.464326783786;10774.461276935965 08:54:17 INFO - PROCESS | 1639 | __end_tp_report 08:54:17 INFO - PROCESS | 1639 | __start_cc_report 08:54:17 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1987 08:54:17 INFO - PROCESS | 1639 | __end_cc_report 08:54:17 INFO - PROCESS | 1639 | __startTimestamp1481302457501__endTimestamp 08:54:17 INFO - PROCESS | 1639 | 08:54:17 INFO - PROCESS | 1639 | ------- Summary: start ------- 08:54:17 INFO - PROCESS | 1639 | Number of tests: 6 08:54:17 INFO - PROCESS | 1639 | 08:54:17 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5661.85 Median:5819.19 stddev:658.99 (11.3%) stddev-sans-first:617.16 08:54:17 INFO - PROCESS | 1639 | Values: 2648.3 3163.1 3332.2 3341.3 3344.7 5532.3 5591.9 5607.4 5624.7 5666.3 5569.3 5630.1 5649.8 5653.2 5680.7 5117.9 5135.1 5143.9 5189.0 5229.0 5120.9 5139.0 5152.6 5210.6 5243.5 5113.7 5136.1 5156.6 5164.3 5199.3 5154.5 5201.7 5230.1 5233.8 5275.4 4965.0 5122.3 5162.6 5164.1 5169.5 5528.1 5534.6 5575.2 5584.7 5620.7 6136.9 6147.3 6187.5 6224.7 6256.0 6279.7 6322.5 6328.9 6330.2 6330.6 5652.2 5709.1 5710.7 5785.1 5819.2 6341.1 6352.0 6405.4 6407.8 6415.6 5340.7 6014.9 6115.4 6125.2 6134.6 5990.3 6025.5 6028.3 6040.7 6113.8 5984.9 6002.4 6006.7 6009.0 6010.4 6000.7 6033.7 6048.5 6053.5 6069.0 4807.7 4831.0 4835.5 4842.8 4850.3 4392.9 4433.4 4442.1 4466.3 4491.1 5680.3 5747.0 5754.6 5772.8 5780.2 6067.1 6212.4 6236.0 6241.2 6267.1 5625.7 5674.2 5693.9 5715.8 5718.7 5296.6 5348.7 5355.6 5367.7 5381.7 6371.8 6374.7 6384.3 6396.4 6400.2 4784.9 6061.3 6068.8 6199.8 6209.2 6319.7 6350.7 6360.9 6361.4 6362.7 5290.9 6106.5 6184.9 6208.3 6228.2 6055.6 6080.8 6104.8 6252.8 6307.6 5855.0 5880.7 5907.8 5916.6 5919.8 5821.9 5932.9 5964.3 5976.0 6092.6 4944.1 5834.9 5872.9 5876.9 5900.7 5853.9 6036.8 6041.3 6047.6 6052.1 5762.7 5782.4 5804.2 5811.9 5857.8 08:54:17 INFO - PROCESS | 1639 | 08:54:17 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:66375.75 Median:38944.61 stddev:145000.15 (372.3%) stddev-sans-first:145322.42 08:54:17 INFO - PROCESS | 1639 | Values: 448.4 509.0 510.7 528.5 555.8 29560.6 31649.8 31666.4 37786.6 39074.4 41296.4 41673.2 41677.6 41736.8 41840.8 9299.5 9472.4 9472.5 9476.1 9485.0 9324.3 9407.0 9432.1 9440.0 9454.9 9371.7 9423.4 9431.7 9463.8 9477.4 9360.5 9365.4 9376.6 9381.6 9382.2 9400.4 9455.0 9470.4 9472.7 9500.3 38814.8 39156.4 39162.0 39165.4 39429.0 3258.5 3317.3 3320.7 3339.0 3668.0 28337.3 28880.0 29701.9 29800.6 30296.8 2630.7 3098.2 3109.3 3225.6 3229.6 436202.0 437638.0 437670.0 437884.0 438926.0 57355.1 57374.4 57669.1 57702.0 57882.1 48290.8 59957.4 60208.0 60233.0 60252.4 14255.4 14451.3 14460.2 14463.3 14475.9 11342.5 11456.0 11480.7 11487.2 11509.8 15710.5 15721.3 15723.0 15836.4 15845.2 4942.3 5013.6 5033.6 5830.1 5969.4 724.5 833.5 915.9 973.9 1032.1 24165.6 28935.0 28999.0 29342.0 29692.5 1027.6 1076.4 1082.6 1104.2 1192.9 14812.1 15055.5 15173.6 15509.0 15516.0 632899.8 638632.0 639433.0 640574.0 641000.0 56050.7 56206.7 56346.0 56414.4 56483.7 1047.0 1279.4 1340.7 1367.1 1396.3 28807.3 30175.5 30286.0 30327.2 30871.7 41197.6 46735.3 47062.5 47939.8 47943.0 528586.0 531499.0 532388.0 533750.0 534174.0 25130.6 26089.5 26139.5 26707.0 26828.5 44664.6 44736.2 44954.7 45712.0 45882.5 36877.3 37116.4 37465.4 38300.8 38717.4 35275.6 37055.3 37338.0 38324.6 38337.0 36198.8 37104.7 37296.0 37366.6 37499.8 31068.8 33055.2 33464.7 33535.8 33876.0 24543.8 24758.5 24964.3 25095.4 25471.9 08:54:17 INFO - PROCESS | 1639 | 08:54:17 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:35523.05 Median:25078.86 stddev:105127.15 (419.2%) stddev-sans-first:105388.86 08:54:17 INFO - PROCESS | 1639 | Values: 334.1 368.1 368.6 378.7 397.4 14557.9 14897.8 15535.4 19428.7 19970.0 18744.5 19608.8 19700.4 19709.0 19863.2 5614.2 5984.8 5987.6 5988.3 5990.3 4773.8 5528.4 5813.2 5880.3 5886.8 5804.7 5829.1 5833.8 5838.7 5859.3 5633.2 5931.1 5964.0 6005.4 6017.6 4974.4 5522.7 5731.3 5753.1 5787.1 10770.8 13097.9 17490.7 24645.9 25511.9 2150.8 2222.2 2272.9 2356.3 2364.0 8227.6 9497.3 10151.3 10250.8 13495.3 1787.7 1819.7 1830.4 1857.0 1860.2 108324.5 116462.4 120161.0 125559.7 127409.0 10613.7 11024.4 11084.3 11334.1 11499.5 14242.6 14269.2 14278.8 14281.4 14305.6 6634.7 7780.0 7982.6 8048.0 8169.4 7823.6 7828.0 7839.8 7924.9 7988.8 4367.1 4369.3 4373.9 4381.1 4429.5 1591.6 1714.8 1827.9 1870.7 1872.5 703.0 727.8 795.2 879.3 926.8 16441.0 17697.5 20705.8 21444.5 21752.3 863.8 870.8 921.7 948.9 999.8 10559.1 11145.2 11369.4 11431.8 11447.6 603812.0 624816.0 626034.0 648106.0 650021.0 77129.0 131747.0 131857.0 134690.0 142961.0 932.8 994.0 1003.6 1004.0 1010.8 18616.4 18664.3 18974.8 19092.3 19341.1 43767.1 54026.0 54602.7 55701.7 56805.4 80085.6 81476.0 81660.6 82147.6 84340.0 7978.5 8073.0 8103.6 8146.1 8320.1 11555.5 12815.3 12908.6 13057.9 13188.3 8926.2 11063.9 11156.8 11406.8 11448.5 8368.3 10251.1 11071.6 11186.0 11265.5 11272.7 11314.2 11442.3 11479.3 11620.3 7799.1 7974.0 7987.6 8141.3 8338.8 9793.9 10652.0 10656.7 11092.2 11115.9 08:54:17 INFO - PROCESS | 1639 | 08:54:17 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5385.73 Median:5040.36 stddev:2964.04 (58.8%) stddev-sans-first:2955.52 08:54:17 INFO - PROCESS | 1639 | Values: 1182.8 1387.8 1531.7 1796.0 1826.2 8014.4 8443.3 8446.2 8447.5 8452.1 7371.6 7653.0 7660.6 7734.4 7754.4 2084.7 2242.0 2323.3 2325.5 2337.9 2335.8 2362.8 2371.2 2373.1 2378.9 2314.1 2342.3 2345.3 2345.3 2348.0 2290.7 2328.6 2332.2 2335.2 2336.2 2323.9 2328.8 2356.3 2358.3 2358.4 8323.1 8353.7 8422.2 8439.0 8460.2 4148.9 5121.5 5122.7 5126.2 5129.2 3148.5 3264.2 3284.8 3349.3 3357.9 922.4 964.8 1000.7 1003.5 1005.6 10765.4 10827.7 10849.0 10862.3 10890.4 3945.7 4339.9 4507.2 4592.9 4595.4 9253.5 9322.4 9322.7 9333.5 9337.3 5025.0 5025.7 5027.9 5033.0 5033.0 4558.9 4605.9 4610.0 4623.3 4670.1 3590.1 3634.9 3641.3 3670.9 3708.7 1140.1 1142.6 1150.0 1150.3 1153.4 770.3 867.3 901.5 912.5 919.7 5531.5 5631.2 5631.4 5697.9 5807.5 853.2 888.5 902.2 908.4 929.8 3153.9 3626.6 3791.1 3953.1 3975.7 9983.2 10180.7 10199.8 10209.6 10232.0 8577.9 10006.4 10023.3 10153.4 10169.7 6154.7 7567.7 7673.1 7798.9 7865.4 5526.4 5532.2 5537.0 5611.4 5885.4 9097.0 9164.2 9310.4 9329.7 9422.8 7919.9 9385.6 9434.4 9566.6 9590.6 7072.9 7271.6 7280.9 7286.7 7315.0 7667.9 7750.4 7761.5 7777.8 7823.8 7107.8 7108.1 7124.9 7151.3 7194.5 7022.6 7062.0 7077.2 7078.5 7089.4 6596.7 6649.7 6650.2 6737.2 6740.7 4702.6 4785.0 4852.9 4879.6 4891.4 4778.6 4780.2 4863.0 4919.8 5047.7 08:54:17 INFO - PROCESS | 1639 | 08:54:17 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4234.34 Median:4696.48 stddev:1288.89 (27.4%) stddev-sans-first:1257.88 08:54:17 INFO - PROCESS | 1639 | Values: 280.2 294.4 296.3 304.0 306.2 4298.0 4541.9 4691.5 4867.5 5123.2 4894.6 5072.6 5110.8 5142.3 5164.5 3453.0 3942.5 3980.5 3995.7 4032.5 3740.4 3926.5 3944.6 3972.4 4037.5 3257.7 3448.7 3889.7 3907.6 4094.7 3506.1 3845.6 3903.7 3920.9 3927.7 2843.2 3417.4 3427.3 3433.6 3441.4 4102.7 4657.3 4832.7 4898.8 5046.2 3896.4 4424.6 4450.4 4461.8 4474.3 5111.6 5168.2 5400.9 5409.0 5419.8 3331.5 3594.4 3692.3 3701.6 3703.3 5337.6 5580.5 5615.4 5637.9 5653.6 3193.2 3790.0 3794.7 3807.5 3808.8 3236.0 3674.9 3770.4 3825.6 3847.8 4166.3 4294.2 4305.5 4310.2 4461.2 4847.3 5208.7 5452.9 5462.2 5479.4 1098.4 1130.3 1200.6 1205.6 1246.6 759.8 787.9 804.2 825.6 846.4 4701.5 4704.6 4753.8 4780.5 4817.7 4555.7 4749.8 5183.0 5218.0 5235.8 4467.5 4667.4 4682.9 4733.6 4939.3 2343.8 2379.1 2723.3 2725.9 2734.5 4552.2 4819.3 5399.8 5419.7 5463.3 4839.0 5059.0 5080.6 5224.6 5327.0 4848.4 5404.3 5416.7 5423.2 5427.8 4271.7 4307.6 4412.6 4527.4 5192.9 4146.5 4485.0 4674.0 5184.4 5233.9 4705.5 4717.8 4818.0 4836.8 5165.8 3275.0 3550.6 3562.2 3566.2 3595.3 4927.0 5024.4 5174.7 5208.9 5227.8 4290.6 5332.3 5358.8 5363.9 5397.0 4492.2 4897.2 5074.4 5469.2 5493.9 5064.5 5289.4 5335.6 5338.5 5392.8 5416.9 5428.3 5443.7 5470.2 5472.1 4427.3 4457.0 5293.3 5326.7 5337.4 08:54:17 INFO - PROCESS | 1639 | 08:54:17 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:19891.25 Median:4311.64 stddev:29517.88 (684.6%) stddev-sans-first:29565.23 08:54:17 INFO - PROCESS | 1639 | Values: 623.7 757.2 771.8 780.6 783.1 12485.4 12628.2 13011.7 13115.4 13121.5 12443.4 14158.6 14504.8 14658.6 15012.8 801.6 804.2 815.5 821.5 829.9 653.2 674.2 822.8 826.1 827.0 839.4 862.4 865.6 867.6 867.6 848.0 848.2 849.5 850.5 850.5 627.4 627.5 627.6 628.0 628.7 13722.7 13972.2 13992.7 14010.4 14030.2 12544.7 12713.7 12767.0 12780.2 12834.0 10192.8 11956.0 12171.2 12194.9 12681.3 3626.4 3786.2 4310.6 4379.6 4418.2 63413.0 72104.0 84607.2 84726.2 86029.0 10227.2 10239.0 10250.7 10336.2 10416.0 19445.7 19457.5 19650.3 19658.0 19681.9 6406.9 7114.1 7279.9 7575.1 7624.1 3469.4 4130.9 4258.9 4285.6 4335.4 3304.2 3406.2 3423.6 3432.3 3434.2 635.8 637.7 646.6 651.2 652.1 583.9 627.8 633.0 636.9 682.2 8243.9 8276.9 8673.0 8678.0 8780.6 604.9 610.1 621.8 639.9 653.0 3981.0 4202.9 4212.3 4300.0 4312.7 109692.0 110951.4 112854.0 113784.9 117323.0 90550.1 91121.5 95025.5 95378.0 98752.0 84995.0 86854.6 89539.6 91003.1 92766.1 8160.2 8238.8 8533.9 9157.8 9314.6 42528.6 51814.0 52353.5 53188.0 54930.7 57249.0 59878.1 62246.0 74901.6 77199.6 11712.7 11751.9 11845.2 11914.3 12232.1 12816.4 13297.9 13381.7 13405.3 13434.8 12159.1 12246.9 12415.6 12482.9 12489.3 12215.7 12423.3 12451.3 12481.6 12868.2 9959.5 10379.8 12116.7 12210.8 12227.7 10358.9 10373.8 10414.9 10509.4 10631.2 10138.5 10237.5 10659.3 10713.5 10774.5 08:54:17 INFO - PROCESS | 1639 | -------- Summary: end -------- 08:54:17 INFO - PROCESS | 1639 | 08:54:18 INFO - TEST-INFO | 1639: exit 0 08:54:18 INFO - TEST-OK | dromaeo_css | took 1120210ms 08:54:18 INFO - TEST-START | kraken 08:54:18 INFO - operating with platform_type : mac_ 08:54:18 INFO - Initialising browser for kraken test... 08:54:18 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/tmpqaH29L/profile http://localhost:49241/getInfo.html) 08:54:20 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 08:54:20 INFO - PROCESS | 1649 | colorDepth:24 08:54:20 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 08:54:20 INFO - PROCESS | 1649 | __metrics 08:54:20 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:54:20 INFO - PROCESS | 1649 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:54:21 INFO - TEST-INFO | 1649: exit 0 08:54:21 INFO - Browser initialized. 08:54:21 INFO - Running cycle 1/1 for kraken test... 08:54:21 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/tmpqaH29L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:34 INFO - PROCESS | 1650 | RSS: Main: 222461952 08:54:34 INFO - PROCESS | 1650 | 08:54:36 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 08:54:37 INFO - PROCESS | 1650 | RSS: Main: 272416768 08:54:37 INFO - PROCESS | 1650 | 08:54:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 08:54:40 INFO - PROCESS | 1650 | RSS: Main: 283021312 08:54:40 INFO - PROCESS | 1650 | 08:54:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 08:54:44 INFO - PROCESS | 1650 | RSS: Main: 380145664 08:54:44 INFO - PROCESS | 1650 | 08:54:46 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 08:54:47 INFO - PROCESS | 1650 | RSS: Main: 282898432 08:54:47 INFO - PROCESS | 1650 | 08:54:49 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:54:50 INFO - PROCESS | 1650 | RSS: Main: 284569600 08:54:50 INFO - PROCESS | 1650 | 08:54:52 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 08:54:53 INFO - PROCESS | 1650 | RSS: Main: 324116480 08:54:53 INFO - PROCESS | 1650 | 08:54:56 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 08:54:57 INFO - PROCESS | 1650 | RSS: Main: 326340608 08:54:57 INFO - PROCESS | 1650 | 08:54:59 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 08:55:00 INFO - PROCESS | 1650 | RSS: Main: 323502080 08:55:00 INFO - PROCESS | 1650 | 08:55:02 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:55:02 INFO - PROCESS | 1650 | RSS: Main: 299909120 08:55:02 INFO - PROCESS | 1650 | 08:55:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:55:05 INFO - PROCESS | 1650 | RSS: Main: 299593728 08:55:05 INFO - PROCESS | 1650 | 08:55:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:55:08 INFO - PROCESS | 1650 | RSS: Main: 302641152 08:55:08 INFO - PROCESS | 1650 | 08:55:11 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:55:11 INFO - PROCESS | 1650 | RSS: Main: 308867072 08:55:11 INFO - PROCESS | 1650 | 08:55:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:55:15 INFO - PROCESS | 1650 | RSS: Main: 309018624 08:55:15 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 08:55:17 INFO - PROCESS | 1650 | RSS: Main: 352907264 08:55:17 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | __start_tp_report 08:55:17 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 08:55:17 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 08:55:17 INFO - PROCESS | 1650 | |i|pagename|runs| 08:55:17 INFO - PROCESS | 1650 | |0;ai-astar;116;115;115;114;114;115;114;115;112;114 08:55:17 INFO - PROCESS | 1650 | |1;audio-beat-detection;165;144;148;147;119;115;118;116;145;115 08:55:17 INFO - PROCESS | 1650 | |2;audio-dft;185;185;184;186;182;183;183;183;184;183 08:55:17 INFO - PROCESS | 1650 | |3;audio-fft;81;60;75;79;66;84;84;82;112;58 08:55:17 INFO - PROCESS | 1650 | |4;audio-oscillator;82;70;93;69;67;69;88;68;69;91 08:55:17 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;88;86;88;86;89;86;89;86;134;129 08:55:17 INFO - PROCESS | 1650 | |6;imaging-darkroom;96;97;97;97;98;97;96;96;95;97 08:55:17 INFO - PROCESS | 1650 | |7;imaging-desaturate;83;80;78;80;83;81;82;95;118;83 08:55:17 INFO - PROCESS | 1650 | |8;json-parse-financial;54;54;55;54;57;56;58;79;82;58 08:55:17 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;64;69;78;75;71;68;70;70;70;71 08:55:17 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;83;85;85;85;85;86;85;87;86;85 08:55:17 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;149;148;147;148;150;150;155;152;248;162 08:55:17 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;167;170;169;171;167;169;169;169;165;169 08:55:17 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;63;66;91;67;68;68;68;69;67;68 08:55:17 INFO - PROCESS | 1650 | __end_tp_report 08:55:17 INFO - PROCESS | 1650 | __start_cc_report 08:55:17 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1990 08:55:17 INFO - PROCESS | 1650 | __end_cc_report 08:55:17 INFO - PROCESS | 1650 | __startTimestamp1481302517323__endTimestamp 08:55:17 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | ------- Summary: start ------- 08:55:17 INFO - PROCESS | 1650 | Number of tests: 14 08:55:17 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:1.07 (0.9%) stddev-sans-first:0.97 08:55:17 INFO - PROCESS | 1650 | Values: 116.0 115.0 115.0 114.0 114.0 115.0 114.0 115.0 112.0 114.0 08:55:17 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:133.20 Median:144.50 stddev:18.46 (12.8%) stddev-sans-first:15.59 08:55:17 INFO - PROCESS | 1650 | Values: 165.0 144.0 148.0 147.0 119.0 115.0 118.0 116.0 145.0 115.0 08:55:17 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.23 (0.7%) stddev-sans-first:1.22 08:55:17 INFO - PROCESS | 1650 | Values: 185.0 185.0 184.0 186.0 182.0 183.0 183.0 183.0 184.0 183.0 08:55:17 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:78.10 Median:80.00 stddev:15.39 (19.2%) stddev-sans-first:16.28 08:55:17 INFO - PROCESS | 1650 | Values: 81.0 60.0 75.0 79.0 66.0 84.0 84.0 82.0 112.0 58.0 08:55:17 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:76.00 stddev:10.64 (14.0%) stddev-sans-first:11.10 08:55:17 INFO - PROCESS | 1650 | Values: 82.0 70.0 93.0 69.0 67.0 69.0 88.0 68.0 69.0 91.0 08:55:17 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:96.10 Median:87.00 stddev:18.73 (21.5%) stddev-sans-first:19.64 08:55:17 INFO - PROCESS | 1650 | Values: 88.0 86.0 88.0 86.0 89.0 86.0 89.0 86.0 134.0 129.0 08:55:17 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:96.60 Median:97.00 stddev:0.84 (0.9%) stddev-sans-first:0.87 08:55:17 INFO - PROCESS | 1650 | Values: 96.0 97.0 97.0 97.0 98.0 97.0 96.0 96.0 95.0 97.0 08:55:17 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:82.50 stddev:12.06 (14.6%) stddev-sans-first:12.73 08:55:17 INFO - PROCESS | 1650 | Values: 83.0 80.0 78.0 80.0 83.0 81.0 82.0 95.0 118.0 83.0 08:55:17 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:57.50 stddev:10.57 (18.4%) stddev-sans-first:10.93 08:55:17 INFO - PROCESS | 1650 | Values: 54.0 54.0 55.0 54.0 57.0 56.0 58.0 79.0 82.0 58.0 08:55:17 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:70.50 stddev:3.78 (5.4%) stddev-sans-first:3.16 08:55:17 INFO - PROCESS | 1650 | Values: 64.0 69.0 78.0 75.0 71.0 68.0 70.0 70.0 70.0 71.0 08:55:17 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:1.03 (1.2%) stddev-sans-first:0.73 08:55:17 INFO - PROCESS | 1650 | Values: 83.0 85.0 85.0 85.0 85.0 86.0 85.0 87.0 86.0 85.0 08:55:17 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:160.90 Median:151.00 stddev:30.92 (20.5%) stddev-sans-first:32.50 08:55:17 INFO - PROCESS | 1650 | Values: 149.0 148.0 147.0 148.0 150.0 150.0 155.0 152.0 248.0 162.0 08:55:17 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:169.00 stddev:1.72 (1.0%) stddev-sans-first:1.73 08:55:17 INFO - PROCESS | 1650 | Values: 167.0 170.0 169.0 171.0 167.0 169.0 169.0 169.0 165.0 169.0 08:55:17 INFO - PROCESS | 1650 | 08:55:17 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:68.00 stddev:7.74 (11.4%) stddev-sans-first:7.84 08:55:17 INFO - PROCESS | 1650 | Values: 63.0 66.0 91.0 67.0 68.0 68.0 68.0 69.0 67.0 68.0 08:55:17 INFO - PROCESS | 1650 | -------- Summary: end -------- 08:55:17 INFO - PROCESS | 1650 | 08:55:18 INFO - TEST-INFO | 1650: exit 0 08:55:18 INFO - TEST-OK | kraken | took 60264ms 08:55:18 INFO - SUITE-END | took 1180s 08:55:18 INFO - Completed test suite (00:19:40) 08:55:18 INFO - javascript benchmark 08:55:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2648.2849630599726, 3163.14595059334, 3332.2339160245065, 3341.264921717222, 3344.662135145943, 5532.336119665641, 5591.888162236753, 5607.355154157273, 5624.71876406179, 5666.348369937464, 5569.303837020372, 5630.09918413054, 5649.774009039634, 5653.236813030239, 5680.744366503507, 5117.923231151536, 5135.05001574708, 5143.871403214931, 5188.9881473112755, 5228.972217673714, 5120.8975820483565, 5139.023585518739, 5152.587792976572, 5210.55710264626, 5243.501867322599, 5113.693178409308, 5136.075506408845, 5156.613254005946, 5164.2770012198325, 5199.272101905736, 5154.5103215194495, 5201.739913004335, 5230.058589453897, 5233.842984710427, 5275.393329767049, 4964.975175124137, 5122.257272695476, 5162.5611822994715, 5164.147915593922, 5169.4572069932865, 5528.087865502228, 5534.557235421156, 5575.219469274305, 5584.748686309126, 5620.662760234399, 6136.9079463808075, 6147.323794382614, 6187.535934804908, 6224.719887605069, 6256.0303153011355, 6279.748810047593, 6322.4942004639515, 6328.873422531524, 6330.177076979963, 6330.588511746768, 5652.208690783294, 5709.0865461525955, 5710.685912274865, 5785.074388097884, 5819.185314056035, 6341.112244285804, 6352.0, 6405.423511883952, 6407.807765767035, 6415.615063096229, 5340.679559226459, 6014.879702406015, 6115.4190351916495, 6125.234345706786, 6134.570580059353, 5990.281166260077, 6025.548083893726, 6028.276606807123, 6040.6677632730625, 6113.755449782047, 5984.880302393928, 6002.399760023963, 6006.6696331701305, 6009.038553831366, 6010.429009244115, 6000.699965001732, 6033.698315084228, 6048.546359023091, 6053.4551890330085, 6069.0, 4807.711537307773, 4831.0, 4835.468098509161, 4842.806287748451, 4850.296706977469, 4392.934105988349, 4433.4236549249035, 4442.067165895198, 4466.307722303049, 4491.146682130385, 5680.261565996394, 5747.0, 5754.625949313281, 5772.769089236467, 5780.16187652788, 6067.1202675611785, 6212.409821066992, 6235.96882015587, 6241.157443745127, 6267.059941008885, 5625.690587017753, 5674.177244299636, 5693.886122277614, 5715.799947001835, 5718.714064296769, 5296.576273898079, 5348.679079255257, 5355.571554275649, 5367.651102678314, 5381.67709937405, 6371.776987805404, 6374.74501019954, 6384.329645387167, 6396.360363963752, 6400.167978162809, 4784.928226076542, 6061.302950160788, 6068.787592434243, 6199.814005579839, 6209.161763162096, 6319.652419116993, 6350.650714210763, 6360.872782544416, 6361.427471527585, 6362.745490180526, 5290.8941821164135, 6106.5114790817515, 6184.907226391518, 6208.317085120723, 6228.22147231596, 6055.636661800306, 6080.847978800565, 6104.755809767737, 6252.781152659635, 6307.621542707452, 5855.0, 5880.705964701662, 5907.822765317047, 5916.585838991401, 5919.822405327847, 5821.94178058231, 5932.940670593239, 5964.343922168645, 5975.970120149372, 6092.573519853745, 4944.085344211332, 5834.912476312774, 5872.882542349214, 5876.853078673067, 5900.70496475166, 5853.882922341614, 6036.758529658764, 6041.2750469943885, 6047.576669633084, 6052.122442245762, 5762.740676669476, 5782.421757824352, 5804.1874137619925, 5811.883762324815, 5857.765689372548], "value": 5618.10127100828, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.4148186616465, 508.96437249392534, 510.68848002718346, 528.4741682026385, 555.8415851482329, 29560.556591651144, 31649.84175079124, 31666.366672666532, 37786.622133778656, 39074.41388379176, 41296.38055429171, 41673.16653666925, 41677.58322416775, 41736.791316043375, 41840.79079604598, 9299.488528130967, 9472.384295020836, 9472.479013654247, 9476.14714675679, 9485.0, 9324.300677449184, 9407.0, 9432.103950124761, 9439.95280023599, 9454.90545094547, 9371.718848434557, 9423.38747981379, 9431.669891553796, 9463.81072378552, 9477.38397004196, 9360.531973401337, 9365.438073715564, 9376.624935002592, 9381.577828997712, 9382.24942004638, 9400.435973841522, 9454.95272523633, 9470.384425012353, 9472.715818525456, 9500.287478439075, 38814.80592597019, 39156.412653810214, 39162.0, 39165.41251881224, 39429.0, 3258.4949332853444, 3317.270200555874, 3320.667933206684, 3338.983305083459, 3667.963320366789, 28337.291567710767, 28879.989200378095, 29701.851490742407, 29800.552991705143, 30296.788128475055, 2630.658014458127, 3098.2409309719037, 3109.284864481182, 3225.645179030305, 3229.580154579913, 436202.0, 437638.0, 437670.0, 437884.0, 438925.9999999968, 57355.13967290494, 57374.426255737744, 57669.13496297475, 57702.0, 57882.131768023515, 48290.75854620704, 59957.40042599518, 60208.0, 60233.0, 60252.39747602468, 14255.429782808778, 14451.349689264009, 14460.20468874201, 14463.27683615815, 14475.85524144745, 11342.546298147981, 11456.026237769716, 11480.712982175346, 11487.195896287347, 11509.827352589718, 15710.450134245246, 15721.292541835644, 15723.0, 15836.445724399591, 15845.207739612973, 4942.308076869242, 5013.5989120870245, 5033.6476446648385, 5830.076074895274, 5969.403059694083, 724.5399171526013, 833.4832403909494, 915.8534634458455, 973.9366941148803, 1032.1020711980625, 24165.637515437284, 28935.0, 28999.0, 29342.0, 29692.47613952795, 1027.5684212630713, 1076.381080878498, 1082.6156714366443, 1104.1829046505527, 1192.8687844337117, 14812.111273323635, 15055.54833355001, 15173.620659483602, 15509.0, 15516.0, 632899.8355008288, 638632.0, 639433.0, 640574.0, 641000.0, 56050.71974640101, 56206.71896640491, 56346.0, 56414.43585564092, 56483.71758141183, 1047.0, 1279.36031984008, 1340.6916409225737, 1367.131871261756, 1396.315805255438, 28807.27981800388, 30175.547366789953, 30286.0, 30327.241818954702, 30871.691283086882, 41197.58802411937, 46735.29897051479, 47062.529374707185, 47939.801504962656, 47943.0, 528586.0, 531499.0, 532388.0, 533750.0, 534174.0, 25130.617816020294, 26089.478210436064, 26139.477210456065, 26707.0, 26828.463430730884, 44664.55335446604, 44736.15070021068, 44954.65136045924, 45712.0, 45882.54117458916, 36877.26245475022, 37116.443253350684, 37465.4380184292, 38300.80849595734, 38717.419238712006, 35275.64724352724, 37055.258894822495, 37338.0, 38324.6167538321, 38337.0, 36198.8190059048, 37104.73295571044, 37296.0, 37366.62633373631, 37499.81250093732, 31068.84465577748, 33055.173620659676, 33464.665353347125, 33535.82624608127, 33876.0, 24543.754562454145, 24758.50482990366, 24964.251072467854, 25095.372615684755, 25471.87264063742], "value": 18933.421127863534, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.1445898499842, 368.10183153106425, 368.64057543894705, 378.748132491893, 397.3642172523962, 14557.92721036396, 14897.776533351995, 15535.378584856593, 19428.708569371436, 19970.001499924983, 18744.531386715338, 19608.803911960877, 19700.408987730392, 19709.0, 19863.20547178111, 5614.157876318544, 5984.820455386323, 5987.6108052976415, 5988.281406231258, 5990.292766561531, 4773.832915847946, 5528.419515950827, 5813.244278243844, 5880.294364676245, 5886.76452941884, 5804.651720896739, 5829.067349224125, 5833.795817146401, 5838.737256823432, 5859.267591551056, 5633.155026746001, 5931.110333449974, 5964.015937370329, 6005.369436209179, 6017.608855424383, 4974.37820272466, 5522.66863988162, 5731.340895796995, 5753.137029445575, 5787.074068149076, 10770.838437423445, 13097.86902130976, 17490.65018699619, 24645.87677061621, 25511.851966661543, 2150.827933765295, 2222.2222222222094, 2272.9204477843364, 2356.3166681662296, 2363.9645405318934, 8227.629756660965, 9497.287703422202, 10151.289409741321, 10250.846237306447, 13495.257760823151, 1787.6603445345343, 1819.7261916658392, 1830.4417152768401, 1857.0436225343958, 1860.2280053777665, 108324.45837770839, 116462.41768791186, 120161.0, 125559.74440255572, 127409.0, 10613.718050619154, 11024.393658348707, 11084.279521831055, 11334.092134427585, 11499.540018399337, 14242.643933901529, 14269.215193164267, 14278.785818212735, 14281.428742850378, 14305.57083287503, 6634.734610615521, 7779.961100194463, 7982.640781164861, 8048.0342358917305, 8169.387295952827, 7823.608819558999, 7828.0, 7839.843203135905, 7924.920750792534, 7988.840223195503, 4367.10474352757, 4369.257226271541, 4373.890652733707, 4381.101874115799, 4429.53489883564, 1591.6498370358502, 1714.768506251665, 1827.9360222392152, 1870.661672908864, 1872.4944265048632, 702.9578225306498, 727.756201672435, 795.2047952047952, 879.3185281406961, 926.7822061815468, 16441.0, 17697.469075927744, 20705.792942070686, 21444.463888402915, 21752.347429577138, 863.7581477186397, 870.8214815962713, 921.7142685767434, 948.9478078705599, 999.7500624843789, 10559.102476289449, 11145.16411269158, 11369.431528423711, 11431.828522572168, 11447.599334023269, 603812.0, 624816.0, 626034.0, 648106.0, 650021.0, 77129.0, 131747.0, 131857.0, 134690.0, 142961.0, 932.8227636749132, 993.9900600994042, 1003.5684655598017, 1003.9548220330249, 1010.7978404319166, 18616.441506754818, 18664.34674786376, 18974.810251897303, 19092.33176838804, 19341.1296491661, 43767.12465750731, 54026.0, 54602.72698636481, 55701.7214913939, 56805.431945680015, 80085.59957200177, 81476.0, 81660.59169704113, 82147.58926205331, 84340.0, 7978.481398709066, 8073.031236251687, 8103.565390279037, 8146.103928567972, 8320.084790673141, 11555.537778488766, 12815.295158766357, 12908.612741617766, 13057.869421305666, 13188.274644894624, 8926.152015558511, 11063.889361106609, 11156.776864462827, 11406.771864562828, 11448.542058317575, 8368.321992181727, 10251.128654064489, 11071.557137714723, 11186.0, 11265.549378024787, 11272.718182045515, 11314.208005439541, 11442.256253343507, 11479.311241325548, 11620.302781833117, 7799.142094369501, 7974.0, 7987.64055617487, 8141.307988821017, 8338.791530211793, 9793.902060979299, 10652.0, 10656.680299591024, 11092.223544351818, 11115.94398532138], "value": 9266.47971044127, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1182.8349076159984, 1387.7571425000622, 1531.708975294694, 1796.0, 1826.2238548616835, 8014.438989270746, 8443.282321002722, 8446.15538446155, 8447.535385553792, 8452.07027227006, 7371.594562299071, 7653.0, 7660.616969151548, 7734.38124950004, 7754.418418618612, 2084.6664533674652, 2241.9887900560557, 2323.349462150592, 2325.5232677301115, 2337.9415514612188, 2335.754745751697, 2362.751911049341, 2371.21749822559, 2373.0626402570974, 2378.857268563892, 2314.143766806284, 2342.273895092518, 2345.296411076679, 2345.3433038749176, 2348.037304705071, 2290.690756747843, 2328.592496313155, 2332.195392589554, 2335.1593426366494, 2336.1661096039697, 2323.93028209154, 2328.8253380996493, 2356.3166681662296, 2358.25714899806, 2358.3750306168877, 8323.1260717625, 8353.707620233263, 8422.15778422159, 8439.02951160612, 8460.153984601491, 4148.937765933513, 5121.462246464105, 5122.667026643257, 5126.2054381570915, 5129.153689641204, 3148.511980643004, 3264.183954011497, 3284.770066095374, 3349.279904820451, 3357.8992630220887, 922.3866129024191, 964.7636329099346, 1000.6547741029333, 1003.4731765822928, 1005.572631631561, 10765.3540787553, 10827.67516974492, 10849.0, 10862.293950893167, 10890.40102794338, 3945.704072194597, 4339.869803905888, 4507.211238033331, 4592.88517787058, 4595.356650068993, 9253.491057991874, 9322.440653560809, 9322.720318390458, 9333.486658233727, 9337.299702522203, 5025.045241404122, 5025.748712564357, 5027.899442011212, 5032.974835125801, 5032.974835125874, 4558.8632341029825, 4605.861824145281, 4610.0, 4623.329617205553, 4670.136024835417, 3590.1204204969426, 3634.8727794527063, 3641.253543023674, 3670.9082272942856, 3708.721845861571, 1140.1391949078559, 1142.5772464188137, 1150.0282261489028, 1150.2983180260035, 1153.3887039868714, 770.3144201660526, 867.2714919467677, 901.4771432569095, 912.5072460871188, 919.7332773495746, 5531.502164805106, 5631.211630371751, 5631.4087020863035, 5697.9430205698245, 5807.490052586358, 853.2278288149234, 888.5113187746842, 902.2421166220275, 908.355067901784, 929.762910457829, 3153.880372467787, 3626.5648122224975, 3791.0901383668274, 3953.0512676957896, 3975.662068724133, 9983.151432128205, 10180.694579162637, 10199.796004079877, 10209.642662506776, 10232.0, 8577.914220857836, 10006.449645269435, 10023.348482348623, 10153.390796552083, 10169.694909152737, 6154.7230374633245, 7567.723658596092, 7673.079230492265, 7798.922010779933, 7865.370770338359, 5526.447355264602, 5532.1701744737, 5537.0, 5611.438856114356, 5885.440883116097, 9097.044810294823, 9164.221041211571, 9310.394824336396, 9329.673461428818, 9422.811543769223, 7919.920800791919, 9385.577649005947, 9434.386764860263, 9566.569504372459, 9590.568424421057, 7072.929270707227, 7271.563706177646, 7280.927190728236, 7286.7085316586745, 7314.96342518284, 7667.88498172539, 7750.379969602531, 7761.534307941542, 7777.805554861174, 7823.8435231293915, 7107.75122870697, 7108.07595012645, 7124.857502850017, 7151.2848715128075, 7194.496385252982, 7022.578645281299, 7061.964690176516, 7077.150741911004, 7078.469114816512, 7089.36195742365, 6596.670166491752, 6649.700763465559, 6650.235222949423, 6737.157855268091, 6740.662966851736, 4702.576768090888, 4784.976075119602, 4852.927206091841, 4879.634027447884, 4891.413030436371, 4778.641601879943, 4780.187368147493, 4862.95137048625, 4919.7540122993, 5047.747612619428], "value": 4353.442668111163, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.22797193731265, 294.3729855407981, 296.26230685592867, 303.9878404863805, 306.2206683989247, 4298.001429335359, 4541.911500179876, 4691.460482044566, 4867.513248675135, 5123.205903085019, 4894.5594896459315, 5072.568831649314, 5110.795568177268, 5142.254373115905, 5164.483551644834, 3452.9813704956973, 3942.5162147846886, 3980.5471003083812, 3995.720299579031, 4032.495938007749, 3740.438934159884, 3926.548446928597, 3944.6252606002386, 3972.423998520213, 4037.4953130858644, 3257.65794591568, 3448.6723761242642, 3889.6580679665612, 3907.550631677365, 4094.672426205911, 3506.0899453453826, 3845.6346647068485, 3903.70722195835, 3920.941185882214, 3927.6661483773914, 2843.24653966699, 3417.3848707232687, 3427.280271143038, 3433.5879694436576, 3441.4493681010917, 4102.671786257092, 4657.301404789275, 4832.710037397732, 4898.755062246873, 5046.167382381903, 3896.3960586109197, 4424.601785839258, 4450.399196108517, 4461.776911154462, 4474.328850672393, 5111.565516931066, 5168.165301318053, 5400.945990540084, 5408.972955135238, 5419.83740487786, 3331.4836200388977, 3594.4248920172645, 3692.335379631665, 3701.6298370163036, 3703.2963736889906, 5337.626366154371, 5580.469855363734, 5615.438456154434, 5637.915431268534, 5653.632513886584, 3193.163930739834, 3789.962100379016, 3794.6774524165753, 3807.459063071315, 3808.8095595220684, 3235.9514607280908, 3674.9448758268645, 3770.434434834797, 3825.5600605930117, 3847.8076096195077, 4166.312558427886, 4294.227039132924, 4305.48334199898, 4310.22415965123, 4461.215513794508, 4847.345608342899, 5208.713520756319, 5452.890942181213, 5462.2079798429, 5479.356193142042, 1098.3629494892944, 1130.282270758058, 1200.565324437289, 1205.5961252980173, 1246.5574720974105, 759.8214419611387, 787.9172686867796, 804.2038382001776, 825.6202147012322, 846.4413487098485, 4701.506341834058, 4704.576588107018, 4753.811547113221, 4780.4624577812165, 4817.735024573612, 4555.749433781174, 4749.762511874393, 5183.041137389595, 5217.973910130425, 5235.764390602432, 4467.486239082482, 4667.393238878924, 4682.929756053662, 4733.644976626767, 4939.2838038484215, 2343.7890589846997, 2379.0729509097687, 2723.305557082931, 2725.877335519867, 2734.5077885980713, 4552.179128348621, 4819.3252744726315, 5399.759099973467, 5419.729013549307, 5463.289772329572, 4838.95161048392, 5058.974705126524, 5080.593552515864, 5224.582033437316, 5327.0482020962245, 4848.442429120626, 5404.32445944257, 5416.674999500043, 5423.213634023124, 5427.755750991215, 4271.7009809314295, 4307.633851122564, 4412.624926881251, 4527.4340707411575, 5192.870178245423, 4146.5024197096545, 4484.955150448584, 4674.0, 5184.377874655065, 5233.869153271199, 4705.517761904989, 4717.787699553597, 4818.0133561763405, 4836.7666245107275, 5165.811863271544, 3274.9672503274664, 3550.6271841456273, 3562.239264569979, 3566.199069469901, 3595.280943811196, 4926.975365123151, 5024.397072351341, 5174.663646862942, 5208.895822083613, 5227.790888364423, 4290.592393722592, 5332.33345831771, 5358.839234822962, 5363.881266899631, 5396.9730151348995, 4492.191405547033, 4897.159647404568, 5074.416442109205, 5469.156038859691, 5493.945060549343, 5064.4935506449065, 5289.418164002033, 5335.572314596771, 5338.519533242027, 5392.838214853561, 5416.862458883678, 5428.267183930277, 5443.727813609383, 5470.234167216513, 5472.069748142905, 4427.335899615084, 4456.955430445654, 5293.338332708411, 5326.6537675050995, 5337.386200586982], "value": 3820.4512655068006, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.697506709246, 757.2049348184408, 771.8340556780291, 780.6448066129908, 783.1229023493686, 12485.375731213426, 12628.24230546168, 13011.73976520469, 13115.409806558704, 13121.475140994373, 12443.377831108432, 14158.575242742709, 14504.782428263585, 14658.63353416165, 15012.849871501308, 801.5591424716412, 804.1998211779259, 815.4617952151581, 821.5317269156583, 829.854775414303, 653.1900443450112, 674.1977047313705, 822.8436597046542, 826.0871736730916, 827.0158511371449, 839.3830534557096, 862.4264863865553, 865.5801936061036, 867.5878957495171, 867.6225841758824, 848.0163010907318, 848.1603212819265, 849.4818160921833, 850.5322072859902, 850.5407080176728, 627.4447114303829, 627.5230824573312, 627.6359711367442, 628.0453710360273, 628.6573817269599, 13722.725545489135, 13972.231527266098, 13992.650183745385, 14010.439582416691, 14030.158190508602, 12544.74910501794, 12713.745725085539, 12766.978641708642, 12780.169288996185, 12834.037447191404, 10192.79614407715, 11956.0, 12171.208871423329, 12194.878051219463, 12681.30252836103, 3626.4197728363333, 3786.2238241160494, 4310.590493903074, 4379.605835474823, 4418.182636212279, 63413.0, 72104.0, 84607.15392846054, 84726.15273847306, 86029.0, 10227.232957528215, 10239.027292407209, 10250.692479225636, 10336.17310615149, 10416.010479004482, 19445.708314375297, 19457.51356216106, 19650.31223907185, 19658.0, 19681.901590491954, 6406.8718625627225, 7114.14630244374, 7279.927200728031, 7575.053118360205, 7624.085109786861, 3469.3755720937575, 4130.876073717734, 4258.850940217078, 4285.571442855689, 4335.417572586047, 3304.1739565108724, 3406.199543107368, 3423.5720534933134, 3432.262063656326, 3434.21013166973, 635.8187916443791, 637.6747858592058, 646.6475770704977, 651.1502489251573, 652.1228947066188, 583.9445252700987, 627.7583130494793, 632.9898850597469, 636.8853606350808, 682.1507223506766, 8243.917560824435, 8276.917230827736, 8673.0, 8677.956610217036, 8780.648774049094, 604.8548348396441, 610.1001023490405, 621.7854840080256, 639.888019596578, 652.9934700652933, 3980.960190398117, 4202.873913782591, 4212.304969679968, 4300.005472010643, 4312.69811113219, 109692.0, 110951.44524277328, 112854.0, 113784.86215137743, 117323.0, 90550.09449905549, 91121.54439227762, 95025.5248723752, 95378.0, 98752.0, 84995.0, 86854.56572717348, 89539.55230223807, 91003.08996909946, 92766.07233927575, 8160.224778646019, 8238.794030149294, 8533.87199192025, 9157.77105572366, 9314.580843862179, 42528.57471425246, 51814.0, 52353.47646523486, 53188.0, 54930.725346373016, 57249.0, 59878.10792298487, 62246.0, 74901.64122919875, 77199.61400192963, 11712.70718232051, 11751.941240293743, 11845.230060046415, 11914.344711040629, 12232.082593805322, 12816.423260953467, 13297.933510332774, 13381.66545836362, 13405.262710551013, 13434.798478023033, 12159.088068395082, 12246.87753122493, 12415.565455209024, 12482.875171248172, 12489.31308778026, 12215.69460763488, 12423.254604723745, 12451.331028265213, 12481.56314528987, 12868.163569367962, 9959.45628427595, 10379.792404151724, 12116.697082573006, 12210.816837747618, 12227.69430764238, 10358.948205259227, 10373.792524149625, 10414.895851041392, 10509.369437833755, 10631.20265980039, 10138.543765530716, 10237.464913724109, 10659.307145035547, 10713.464326783786, 10774.461276935965], "value": 7085.214908666749, "unit": "score"}], "name": "dromaeo_css", "value": 6985.22592756222, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 114.0, 114.0, 115.0, 114.0, 115.0, 112.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 144.0, 148.0, 147.0, 119.0, 115.0, 118.0, 116.0, 145.0, 115.0], "value": 133.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 184.0, 186.0, 182.0, 183.0, 183.0, 183.0, 184.0, 183.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 75.0, 79.0, 66.0, 84.0, 84.0, 82.0, 112.0, 58.0], "value": 78.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 93.0, 69.0, 67.0, 69.0, 88.0, 68.0, 69.0, 91.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 86.0, 89.0, 86.0, 89.0, 86.0, 134.0, 129.0], "value": 96.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 97.0, 98.0, 97.0, 96.0, 96.0, 95.0, 97.0], "value": 96.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 78.0, 80.0, 83.0, 81.0, 82.0, 95.0, 118.0, 83.0], "value": 86.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 57.0, 56.0, 58.0, 79.0, 82.0, 58.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 78.0, 75.0, 71.0, 68.0, 70.0, 70.0, 70.0, 71.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 85.0, 85.0, 85.0, 86.0, 85.0, 87.0, 86.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 148.0, 150.0, 150.0, 155.0, 152.0, 248.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 169.0, 171.0, 167.0, 169.0, 169.0, 169.0, 165.0, 169.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 91.0, 67.0, 68.0, 68.0, 68.0, 69.0, 67.0, 68.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1480.5000000000002, "alertThreshold": 2.0}]} 08:55:18 INFO - Return code: 0 08:55:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:55:18 INFO - # TBPL SUCCESS # 08:55:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:55:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:55:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:55:18 INFO - 2016-12-09 08:55:18.663 screenresolution[1654:9737] starting screenresolution argv=screenresolution get 08:55:18 INFO - 2016-12-09 08:55:18.668 screenresolution[1654:9737] Display 0: 1600x1200x32@60 08:55:18 INFO - 2016-12-09 08:55:18.674 screenresolution[1655:9741] starting screenresolution argv=screenresolution list 08:55:18 INFO - Available Modes on Display 0 08:55:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:55:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:55:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:55:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:55:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:55:18 INFO - Intel Iris: 08:55:18 INFO - Chipset Model: Intel Iris 08:55:18 INFO - Type: GPU 08:55:18 INFO - Bus: Built-In 08:55:18 INFO - VRAM (Dynamic, Max): 1536 MB 08:55:18 INFO - Vendor: Intel (0x8086) 08:55:18 INFO - Device ID: 0x0a2e 08:55:18 INFO - Revision ID: 0x0009 08:55:18 INFO - Displays: 08:55:18 INFO - Display: 08:55:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:55:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:55:18 INFO - Display Serial Number: 1600x1200 60 08:55:18 INFO - Main Display: Yes 08:55:18 INFO - Mirror: Off 08:55:18 INFO - Online: Yes 08:55:18 INFO - Rotation: Supported 08:55:18 INFO - Return code: 0 08:55:18 INFO - Running post-action listener: _resource_record_post_action 08:55:18 INFO - [mozharness: 2016-12-09 16:55:18.917669Z] Finished run-tests step (success) 08:55:18 INFO - Running post-run listener: _resource_record_post_run 08:55:18 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37733376; Write bytes: 651983872; Read time: 239; Write time: 1867 08:55:18 INFO - TinderboxPrint: CPU usage
53.6% 08:55:18 INFO - TinderboxPrint: I/O read bytes / time
37,733,376 / 239 08:55:18 INFO - TinderboxPrint: I/O write bytes / time
651,983,872 / 1,867 08:55:18 INFO - TinderboxPrint: CPU idle
2,249.8 (46.4%) 08:55:18 INFO - TinderboxPrint: CPU system
974.4 (20.1%) 08:55:18 INFO - TinderboxPrint: CPU user
1,625.5 (33.5%) 08:55:18 INFO - TinderboxPrint: Swap in / out
386,273,280 / 0 08:55:18 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 342594048; Write bytes: 336422400; Read time: 26737; Write time: 703 08:55:18 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 35906560; Write bytes: 300107264; Read time: 224; Write time: 1115 08:55:19 INFO - Running post-run listener: _upload_blobber_files 08:55:19 INFO - Blob upload gear active. 08:55:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:55:19 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 08:55:19 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:55:19 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:55:19 INFO - (blobuploader) - INFO - Open directory for files ... 08:55:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:55:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:55:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:21 INFO - (blobuploader) - INFO - Done attempting. 08:55:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:55:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:55:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:22 INFO - (blobuploader) - INFO - Done attempting. 08:55:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:55:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:55:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:24 INFO - (blobuploader) - INFO - Done attempting. 08:55:24 INFO - (blobuploader) - INFO - Iteration through files over. 08:55:24 INFO - Return code: 0 08:55:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:55:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:55:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1d44f52d74691ec8539a2d3513d9203c34e0bb88417411c53568fce8f6e4579329157d3879f5e7ff94c448fea2f9756ced93d9811fed340675b573c4c6dc9a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c86287b83087c9320269d0c2926109a44e001e5f86866f34f032e578458b2c60aede03eef6d4445fec7d71904c1e256bc1a6e72d60cdbdb4715a712cc1e8ac3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fdade5820a3adc8ebdbe4006cfea206dd893d8803c1f5d6cf2c7afd8e47d6325540f52f89a3c787fde83327bc1d4fc081edb13ab06a93c66693adcfdf9653f9b"} 08:55:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:55:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:55:24 INFO - Contents: 08:55:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1d44f52d74691ec8539a2d3513d9203c34e0bb88417411c53568fce8f6e4579329157d3879f5e7ff94c448fea2f9756ced93d9811fed340675b573c4c6dc9a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c86287b83087c9320269d0c2926109a44e001e5f86866f34f032e578458b2c60aede03eef6d4445fec7d71904c1e256bc1a6e72d60cdbdb4715a712cc1e8ac3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fdade5820a3adc8ebdbe4006cfea206dd893d8803c1f5d6cf2c7afd8e47d6325540f52f89a3c787fde83327bc1d4fc081edb13ab06a93c66693adcfdf9653f9b"} 08:55:24 INFO - Running post-run listener: copy_logs_to_upload_dir 08:55:24 INFO - Copying logs to upload dir... 08:55:24 INFO - mkdir: /builds/slave/test/build/upload/logs 08:55:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.328621 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-12-09 08:55:25.025465) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-09 08:55:25.029345) ========= 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.Nsb1qyF30j/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.aUfSDm8a4z/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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/Mozilla-Aurora/sha512/b1d44f52d74691ec8539a2d3513d9203c34e0bb88417411c53568fce8f6e4579329157d3879f5e7ff94c448fea2f9756ced93d9811fed340675b573c4c6dc9a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c86287b83087c9320269d0c2926109a44e001e5f86866f34f032e578458b2c60aede03eef6d4445fec7d71904c1e256bc1a6e72d60cdbdb4715a712cc1e8ac3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fdade5820a3adc8ebdbe4006cfea206dd893d8803c1f5d6cf2c7afd8e47d6325540f52f89a3c787fde83327bc1d4fc081edb13ab06a93c66693adcfdf9653f9b"} build_url:https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010945 build_url: 'https://queue.taskcluster.net/v1/task/O4KogXScQKKjCSm7hnNFPQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1d44f52d74691ec8539a2d3513d9203c34e0bb88417411c53568fce8f6e4579329157d3879f5e7ff94c448fea2f9756ced93d9811fed340675b573c4c6dc9a7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c86287b83087c9320269d0c2926109a44e001e5f86866f34f032e578458b2c60aede03eef6d4445fec7d71904c1e256bc1a6e72d60cdbdb4715a712cc1e8ac3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fdade5820a3adc8ebdbe4006cfea206dd893d8803c1f5d6cf2c7afd8e47d6325540f52f89a3c787fde83327bc1d4fc081edb13ab06a93c66693adcfdf9653f9b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-09 08:55:25.063622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 08:55:25.063958) ========= 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.Nsb1qyF30j/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.aUfSDm8a4z/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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.005352 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 08:55:25.112977) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-09 08:55:25.113302) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-09 08:55:25.113611) ========= ========= Total master_lag: 0.17 =========