builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1491754389.08 results: success (0) revision: c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 09:13:09.079302) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 09:13:09.080248) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 09:13:09.080826) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 09:13:09.136530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 09:13:09.137185) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-09 09:13:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 55.0M=0s 2017-04-09 09:13:09 (55.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.177054 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 09:13:09.369822) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 09:13:09.370242) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.056569 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 09:13:09.440113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 09:13:09.440698) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-09 09:13:09,546 truncating revision to first 12 chars 2017-04-09 09:13:09,546 Setting DEBUG logging. 2017-04-09 09:13:09,546 attempt 1/10 2017-04-09 09:13:09,546 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c6dd79ff61be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-09 09:13:09,963 unpacking tar archive at: mozilla-central-c6dd79ff61be/testing/mozharness/ program finished with exit code 0 elapsedTime=0.797087 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 09:13:10.256322) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 09:13:10.256928) ========= script_repo_revision: c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 09:13:10.257373) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 09:13:10.257684) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 09:13:10.273522) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-04-09 09:13:10.273970) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:13:10 INFO - MultiFileLogger online at 20170409 09:13:10 in /builds/slave/test 09:13:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:13:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:13:10 INFO - {'append_to_log': False, 09:13:10 INFO - 'base_work_dir': '/builds/slave/test', 09:13:10 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:13:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:13:10 INFO - 'branch': 'Firefox-Non-PGO', 09:13:10 INFO - 'buildbot_json_path': 'buildprops.json', 09:13:10 INFO - 'config_files': ('talos/linux_config.py',), 09:13:10 INFO - 'default_actions': ('clobber', 09:13:10 INFO - 'read-buildbot-config', 09:13:10 INFO - 'download-and-extract', 09:13:10 INFO - 'populate-webroot', 09:13:10 INFO - 'create-virtualenv', 09:13:10 INFO - 'install', 09:13:10 INFO - 'run-tests'), 09:13:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:13:10 INFO - 'download_minidump_stackwalk': True, 09:13:10 INFO - 'download_symbols': 'ondemand', 09:13:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:13:10 INFO - 'tooltool.py': '/tools/tooltool.py', 09:13:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:13:10 INFO - '/tools/misc-python/virtualenv.py')}, 09:13:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:13:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:13:10 INFO - 'gecko_profile': False, 09:13:10 INFO - 'gecko_profile_interval': 0, 09:13:10 INFO - 'installer_path': 'installer.exe', 09:13:10 INFO - 'log_level': 'info', 09:13:10 INFO - 'log_name': 'talos', 09:13:10 INFO - 'log_to_console': True, 09:13:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:13:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:13:10 INFO - 'opt_config_files': (), 09:13:10 INFO - 'pip_index': False, 09:13:10 INFO - 'suite': 'dromaeojs', 09:13:10 INFO - 'system_bits': '32', 09:13:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:13:10 INFO - 'title': 'talos-linux64-ix-030', 09:13:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:13:10 INFO - 'use_talos_json': True, 09:13:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:13:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:13:10 INFO - 'work_dir': 'build'} 09:13:10 INFO - [mozharness: 2017-04-09 16:13:10.579187Z] Running clobber step. 09:13:10 INFO - Running pre-action listener: _resource_record_pre_action 09:13:10 INFO - Running main action method: clobber 09:13:10 INFO - rmtree: /builds/slave/test/build 09:13:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:13:15 INFO - Running post-action listener: _resource_record_post_action 09:13:15 INFO - [mozharness: 2017-04-09 16:13:15.910242Z] Finished clobber step (success) 09:13:15 INFO - [mozharness: 2017-04-09 16:13:15.910341Z] Running read-buildbot-config step. 09:13:15 INFO - Running pre-action listener: _resource_record_pre_action 09:13:15 INFO - Running main action method: read_buildbot_config 09:13:15 INFO - Using buildbot properties: 09:13:15 INFO - { 09:13:15 INFO - "project": "", 09:13:15 INFO - "product": "firefox", 09:13:15 INFO - "who": "ffxbld@noreply.mozilla.org", 09:13:15 INFO - "installer_path": "public/build/target.tar.bz2", 09:13:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:13:15 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:13:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:13:15 INFO - "stage_platform": "linux64", 09:13:15 INFO - "basedir": "/builds/slave/test", 09:13:15 INFO - "buildnumber": 1059, 09:13:15 INFO - "platform": "ubuntu64_hw", 09:13:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:13:15 INFO - "slavebuilddir": "test", 09:13:15 INFO - "taskId": "QGip36R0TbCyL45QULU58A", 09:13:15 INFO - "branch": "mozilla-central", 09:13:15 INFO - "script_repo_revision": "production", 09:13:15 INFO - "revision": "c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba", 09:13:15 INFO - "slavename": "talos-linux64-ix-030", 09:13:15 INFO - "repo_path": "mozilla-central" 09:13:15 INFO - } 09:13:15 INFO - Finding installer, test and symbols from parent task. 09:13:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QGip36R0TbCyL45QULU58A'}, attempt #1 09:13:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QGip36R0TbCyL45QULU58A'}, attempt #1 09:13:16 INFO - Task dependencies: B5pZDEnNSu-Yffq7bio7WQ 09:13:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ'}, attempt #1 09:13:17 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.tar.bz2 09:13:17 INFO - Set test_url: https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/test_packages.json 09:13:17 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.crashreporter-symbols.zip 09:13:17 INFO - Running post-action listener: _resource_record_post_action 09:13:17 INFO - [mozharness: 2017-04-09 16:13:17.282914Z] Finished read-buildbot-config step (success) 09:13:17 INFO - [mozharness: 2017-04-09 16:13:17.283131Z] Running download-and-extract step. 09:13:17 INFO - Running pre-action listener: _resource_record_pre_action 09:13:17 INFO - Running main action method: download_and_extract 09:13:17 INFO - mkdir: /builds/slave/test/build/tests 09:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:17 INFO - trying https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.test_packages.json 09:13:17 INFO - Downloading https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:13:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:13:17 INFO - Downloaded 986 bytes. 09:13:17 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:13:17 INFO - Using the following test package requirements: 09:13:17 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:13:17 INFO - u'common': [u'target.common.tests.zip'], 09:13:17 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:13:17 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:13:17 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:13:17 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:13:17 INFO - u'mozbase': [u'target.common.tests.zip'], 09:13:17 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:13:17 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:13:17 INFO - u'web-platform': [u'target.common.tests.zip', 09:13:17 INFO - u'target.web-platform.tests.zip'], 09:13:17 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:13:17 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:13:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.common.tests.zip 09:13:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:13:17 INFO - Fetch https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.common.tests.zip into memory 09:13:18 INFO - Expected file size: 58245202 09:13:18 INFO - Obtained file size: 58245202 09:13:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:13:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.common.tests.zip 09:13:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:13:29 INFO - Fetch https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.common.tests.zip into memory 09:13:30 INFO - Expected file size: 58245202 09:13:30 INFO - Obtained file size: 58245202 09:13:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.talos.tests.zip 09:13:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:13:41 INFO - Fetch https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.talos.tests.zip into memory 09:13:42 INFO - Expected file size: 14404129 09:13:42 INFO - Obtained file size: 14404129 09:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:42 INFO - trying https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.tar.bz2 09:13:42 INFO - Downloading https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:13:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:13:43 INFO - Downloaded 57731336 bytes. 09:13:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.tar.bz2 09:13:43 INFO - mkdir: /builds/slave/test/properties 09:13:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:13:43 INFO - Writing to file /builds/slave/test/properties/build_url 09:13:43 INFO - Contents: 09:13:43 INFO - build_url:https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.tar.bz2 09:13:43 INFO - Running post-action listener: _resource_record_post_action 09:13:43 INFO - Running post-action listener: set_extra_try_arguments 09:13:43 INFO - [mozharness: 2017-04-09 16:13:43.905480Z] Finished download-and-extract step (success) 09:13:43 INFO - [mozharness: 2017-04-09 16:13:43.905576Z] Running populate-webroot step. 09:13:43 INFO - Running pre-action listener: _resource_record_pre_action 09:13:43 INFO - Running main action method: populate_webroot 09:13:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:13:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:13:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:13:43 INFO - '--tppagecycles', 09:13:43 INFO - '7'], 09:13:43 INFO - 'tests': ['tsvgm']}}, 09:13:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:13:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:13:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:13:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:13:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:13:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:13:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:13:43 INFO - 'talos_options': ['--disable-e10s'], 09:13:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:13:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:13:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:13:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:13:43 INFO - 'talos_options': ['--disable-e10s'], 09:13:43 INFO - 'tests': ['damp', 'tps']}, 09:13:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:13:43 INFO - 'tests': ['damp', 'tps']}, 09:13:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:13:43 INFO - 'tests': ['dromaeo_dom']}, 09:13:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:13:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:13:43 INFO - 'tests': ['basic_compositor_video']}, 09:13:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:13:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:13:43 INFO - 'tests': ['a11yr', 09:13:43 INFO - 'ts_paint', 09:13:43 INFO - 'tpaint', 09:13:43 INFO - 'sessionrestore', 09:13:43 INFO - 'sessionrestore_no_auto_restore', 09:13:43 INFO - 'tabpaint']}, 09:13:43 INFO - 'other-e10s': {'tests': ['a11yr', 09:13:43 INFO - 'ts_paint', 09:13:43 INFO - 'tpaint', 09:13:43 INFO - 'sessionrestore', 09:13:43 INFO - 'sessionrestore_no_auto_restore', 09:13:43 INFO - 'tabpaint']}, 09:13:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:13:43 INFO - 'ts_paint', 09:13:43 INFO - 'tpaint', 09:13:43 INFO - 'sessionrestore', 09:13:43 INFO - 'sessionrestore_no_auto_restore', 09:13:43 INFO - 'tabpaint']}, 09:13:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:13:43 INFO - 'ts_paint', 09:13:43 INFO - 'tpaint', 09:13:43 INFO - 'sessionrestore', 09:13:43 INFO - 'sessionrestore_no_auto_restore', 09:13:43 INFO - 'tabpaint']}, 09:13:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:13:43 INFO - 'tests': ['a11yr', 09:13:43 INFO - 'ts_paint', 09:13:43 INFO - 'tpaint', 09:13:43 INFO - 'sessionrestore', 09:13:43 INFO - 'sessionrestore_no_auto_restore', 09:13:43 INFO - 'tabpaint']}, 09:13:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:13:43 INFO - 'tests': ['a11yr', 09:13:43 INFO - 'ts_paint', 09:13:43 INFO - 'tpaint', 09:13:43 INFO - 'sessionrestore', 09:13:43 INFO - 'sessionrestore_no_auto_restore', 09:13:43 INFO - 'tabpaint']}, 09:13:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:13:43 INFO - 'tests': ['tsvgx', 09:13:43 INFO - 'tsvgr_opacity', 09:13:43 INFO - 'tart', 09:13:43 INFO - 'tscrollx', 09:13:43 INFO - 'cart', 09:13:43 INFO - 'tsvg_static']}, 09:13:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:13:43 INFO - 'tsvgr_opacity', 09:13:43 INFO - 'tart', 09:13:43 INFO - 'tscrollx', 09:13:43 INFO - 'cart', 09:13:43 INFO - 'tsvg_static']}, 09:13:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:13:43 INFO - 'talos_options': ['--disable-e10s'], 09:13:43 INFO - 'tests': ['tp5o']}, 09:13:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:13:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:13:43 INFO - 'talos_options': ['--disable-e10s', 09:13:43 INFO - '--xperf_path', 09:13:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:13:43 INFO - 'tests': ['tp5n']}, 09:13:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:13:43 INFO - 'talos_options': ['--xperf_path', 09:13:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:13:43 INFO - 'tests': ['tp5n']}}, 09:13:43 INFO - 'talos.zip': {'path': '', 09:13:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:13:43 INFO - Running post-action listener: _resource_record_post_action 09:13:43 INFO - [mozharness: 2017-04-09 16:13:43.918698Z] Finished populate-webroot step (success) 09:13:43 INFO - [mozharness: 2017-04-09 16:13:43.918787Z] Running create-virtualenv step. 09:13:43 INFO - Running pre-action listener: _resource_record_pre_action 09:13:43 INFO - Running main action method: create_virtualenv 09:13:43 INFO - Creating virtualenv /builds/slave/test/build/venv 09:13:43 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 09:13:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:13:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:13:44 INFO - Using real prefix '/usr' 09:13:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:13:44 INFO - Installing distribute.............................................................................................................................................................................................done. 09:13:46 INFO - Installing pip.................done. 09:13:46 INFO - Return code: 0 09:13:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:13:47 INFO - Reading from file tmpfile_stdout 09:13:47 INFO - Output received: 09:13:47 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:13:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:47 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 0xf8b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1226290>, '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 0x1226b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:13:47 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 09:13:47 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 09:13:47 INFO - Using env: {'DISPLAY': ':0', 09:13:47 INFO - 'HOME': '/home/cltbld', 09:13:47 INFO - 'LANG': 'en_US.UTF-8', 09:13:47 INFO - 'LANGUAGE': 'en_US:en', 09:13:47 INFO - 'LOGNAME': 'cltbld', 09:13:47 INFO - 'MAIL': '/var/mail/cltbld', 09:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:47 INFO - 'MOZ_NO_REMOTE': '1', 09:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:47 INFO - 'NO_EM_RESTART': '1', 09:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:47 INFO - 'PWD': '/builds/slave/test', 09:13:47 INFO - 'SHELL': '/bin/bash', 09:13:47 INFO - 'SHLVL': '1', 09:13:47 INFO - 'TERM': 'linux', 09:13:47 INFO - 'TMOUT': '86400', 09:13:47 INFO - 'USER': 'cltbld', 09:13:47 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 09:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:47 INFO - '_': '/tools/buildbot/bin/python'} 09:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:47 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 09:13:47 INFO - Cleaning up... 09:13:47 INFO - Return code: 0 09:13:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:47 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 0xf8b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1226290>, '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 0x1226b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:13:47 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 09:13:47 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 09:13:47 INFO - Using env: {'DISPLAY': ':0', 09:13:47 INFO - 'HOME': '/home/cltbld', 09:13:47 INFO - 'LANG': 'en_US.UTF-8', 09:13:47 INFO - 'LANGUAGE': 'en_US:en', 09:13:47 INFO - 'LOGNAME': 'cltbld', 09:13:47 INFO - 'MAIL': '/var/mail/cltbld', 09:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:47 INFO - 'MOZ_NO_REMOTE': '1', 09:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:47 INFO - 'NO_EM_RESTART': '1', 09:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:47 INFO - 'PWD': '/builds/slave/test', 09:13:47 INFO - 'SHELL': '/bin/bash', 09:13:47 INFO - 'SHLVL': '1', 09:13:47 INFO - 'TERM': 'linux', 09:13:47 INFO - 'TMOUT': '86400', 09:13:47 INFO - 'USER': 'cltbld', 09:13:47 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 09:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:47 INFO - '_': '/tools/buildbot/bin/python'} 09:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:47 INFO - Downloading/unpacking psutil>=3.1.1 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:13:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:13:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:13:49 INFO - Installing collected packages: psutil 09:13:49 INFO - Running setup.py install for psutil 09:13:49 INFO - building 'psutil._psutil_linux' extension 09:13:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:13:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:13:50 INFO - building 'psutil._psutil_posix' extension 09:13:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:13:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:13:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:13:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:13:51 INFO - Successfully installed psutil 09:13:51 INFO - Cleaning up... 09:13:51 INFO - Return code: 0 09:13:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:13:51 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')]} 09:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:51 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')]} 09:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:51 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 0xf8b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1226290>, '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 0x1226b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:13:51 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 09:13:51 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 09:13:51 INFO - Using env: {'DISPLAY': ':0', 09:13:51 INFO - 'HOME': '/home/cltbld', 09:13:51 INFO - 'LANG': 'en_US.UTF-8', 09:13:51 INFO - 'LANGUAGE': 'en_US:en', 09:13:51 INFO - 'LOGNAME': 'cltbld', 09:13:51 INFO - 'MAIL': '/var/mail/cltbld', 09:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:51 INFO - 'MOZ_NO_REMOTE': '1', 09:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:51 INFO - 'NO_EM_RESTART': '1', 09:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:51 INFO - 'PWD': '/builds/slave/test', 09:13:51 INFO - 'SHELL': '/bin/bash', 09:13:51 INFO - 'SHLVL': '1', 09:13:51 INFO - 'TERM': 'linux', 09:13:51 INFO - 'TMOUT': '86400', 09:13:51 INFO - 'USER': 'cltbld', 09:13:51 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 09:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:51 INFO - '_': '/tools/buildbot/bin/python'} 09:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13: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 09:13:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:13:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:13:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:13:53 INFO - Installing collected packages: mozsystemmonitor 09:13:53 INFO - Running setup.py install for mozsystemmonitor 09:13:53 INFO - Successfully installed mozsystemmonitor 09:13:53 INFO - Cleaning up... 09:13:53 INFO - Return code: 0 09:13:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xf8b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1226290>, '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 0x1226b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:13:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:13:53 INFO - Using env: {'DISPLAY': ':0', 09:13:53 INFO - 'HOME': '/home/cltbld', 09:13:53 INFO - 'LANG': 'en_US.UTF-8', 09:13:53 INFO - 'LANGUAGE': 'en_US:en', 09:13:53 INFO - 'LOGNAME': 'cltbld', 09:13:53 INFO - 'MAIL': '/var/mail/cltbld', 09:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:53 INFO - 'MOZ_NO_REMOTE': '1', 09:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:53 INFO - 'NO_EM_RESTART': '1', 09:13:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:53 INFO - 'PWD': '/builds/slave/test', 09:13:53 INFO - 'SHELL': '/bin/bash', 09:13:53 INFO - 'SHLVL': '1', 09:13:53 INFO - 'TERM': 'linux', 09:13:53 INFO - 'TMOUT': '86400', 09:13:53 INFO - 'USER': 'cltbld', 09:13:53 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 09:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:53 INFO - '_': '/tools/buildbot/bin/python'} 09:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:53 INFO - Downloading/unpacking jsonschema==2.5.1 09:13:53 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 09:13:53 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 09:13:53 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 09:13:53 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 09:13:53 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 09:13:53 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 09:13:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:13:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:13:55 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 09:13:55 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 09:13:55 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 09:13:55 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 09:13:55 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 09:13:55 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 09:13:55 INFO - Downloading functools32-3.2.3-2.tar.gz 09:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:13:56 INFO - warning: no files found matching '*.txt' 09:13:56 INFO - no previously-included directories found matching 'build' 09:13:56 INFO - no previously-included directories found matching 'dist' 09:13:56 INFO - no previously-included directories found matching '.git*' 09:13:56 INFO - Installing collected packages: jsonschema, functools32 09:13:56 INFO - Running setup.py install for functools32 09:13:56 INFO - warning: no files found matching '*.txt' 09:13:56 INFO - no previously-included directories found matching 'build' 09:13:56 INFO - no previously-included directories found matching 'dist' 09:13:56 INFO - no previously-included directories found matching '.git*' 09:13:56 INFO - Successfully installed jsonschema functools32 09:13:56 INFO - Cleaning up... 09:13:56 INFO - Return code: 0 09:13:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:13:56 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')]} 09:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:56 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')]} 09:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:56 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 0xf8b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1226290>, '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 0x1226b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:13:56 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 09:13:56 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 09:13:56 INFO - Using env: {'DISPLAY': ':0', 09:13:56 INFO - 'HOME': '/home/cltbld', 09:13:56 INFO - 'LANG': 'en_US.UTF-8', 09:13:56 INFO - 'LANGUAGE': 'en_US:en', 09:13:56 INFO - 'LOGNAME': 'cltbld', 09:13:56 INFO - 'MAIL': '/var/mail/cltbld', 09:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:56 INFO - 'MOZ_NO_REMOTE': '1', 09:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:56 INFO - 'NO_EM_RESTART': '1', 09:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:56 INFO - 'PWD': '/builds/slave/test', 09:13:56 INFO - 'SHELL': '/bin/bash', 09:13:56 INFO - 'SHLVL': '1', 09:13:56 INFO - 'TERM': 'linux', 09:13:56 INFO - 'TMOUT': '86400', 09:13:56 INFO - 'USER': 'cltbld', 09:13:56 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 09:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:56 INFO - '_': '/tools/buildbot/bin/python'} 09:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:13:56 INFO - Cleaning up... 09:13:56 INFO - Return code: 0 09:13:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:13:56 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')]} 09:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:56 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')]} 09:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:56 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 0xf8b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1226290>, '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 0x1226b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:13:56 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 09:13:56 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 09:13:56 INFO - Using env: {'DISPLAY': ':0', 09:13:56 INFO - 'HOME': '/home/cltbld', 09:13:56 INFO - 'LANG': 'en_US.UTF-8', 09:13:56 INFO - 'LANGUAGE': 'en_US:en', 09:13:56 INFO - 'LOGNAME': 'cltbld', 09:13:56 INFO - 'MAIL': '/var/mail/cltbld', 09:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:56 INFO - 'MOZ_NO_REMOTE': '1', 09:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:56 INFO - 'NO_EM_RESTART': '1', 09:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:56 INFO - 'PWD': '/builds/slave/test', 09:13:56 INFO - 'SHELL': '/bin/bash', 09:13:56 INFO - 'SHLVL': '1', 09:13:56 INFO - 'TERM': 'linux', 09:13:56 INFO - 'TMOUT': '86400', 09:13:56 INFO - 'USER': 'cltbld', 09:13:56 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 09:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:56 INFO - '_': '/tools/buildbot/bin/python'} 09:13:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:56 INFO - Downloading/unpacking blobuploader==1.2.4 09:13:56 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 09:13:56 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 09:13:56 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 09:13:56 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 09:13:56 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 09:13:56 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 09:13:58 INFO - Downloading blobuploader-1.2.4.tar.gz 09:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:13:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:13:58 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 09:13:58 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 09:13:58 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 09:13:58 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 09:13:58 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 09:13:58 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 09:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:13:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:13:59 INFO - Downloading docopt-0.6.1.tar.gz 09:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:13:59 INFO - Installing collected packages: blobuploader, requests, docopt 09:13:59 INFO - Running setup.py install for blobuploader 09:13:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:13:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:13:59 INFO - Running setup.py install for requests 09:13:59 INFO - Running setup.py install for docopt 09:14:00 INFO - Successfully installed blobuploader requests docopt 09:14:00 INFO - Cleaning up... 09:14:00 INFO - Return code: 0 09:14:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:00 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 0xf8b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1226290>, '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 0x1226b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:14:00 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 09:14:00 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 09:14:00 INFO - Using env: {'DISPLAY': ':0', 09:14:00 INFO - 'HOME': '/home/cltbld', 09:14:00 INFO - 'LANG': 'en_US.UTF-8', 09:14:00 INFO - 'LANGUAGE': 'en_US:en', 09:14:00 INFO - 'LOGNAME': 'cltbld', 09:14:00 INFO - 'MAIL': '/var/mail/cltbld', 09:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:00 INFO - 'MOZ_NO_REMOTE': '1', 09:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:00 INFO - 'NO_EM_RESTART': '1', 09:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:00 INFO - 'PWD': '/builds/slave/test', 09:14:00 INFO - 'SHELL': '/bin/bash', 09:14:00 INFO - 'SHLVL': '1', 09:14:00 INFO - 'TERM': 'linux', 09:14:00 INFO - 'TMOUT': '86400', 09:14:00 INFO - 'USER': 'cltbld', 09:14:00 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 09:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:00 INFO - '_': '/tools/buildbot/bin/python'} 09:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:00 INFO - Running setup.py (path:/tmp/pip-5c0hon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:00 INFO - Running setup.py (path:/tmp/pip-lBmXYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:00 INFO - Running setup.py (path:/tmp/pip-eTRery-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:00 INFO - Running setup.py (path:/tmp/pip-zDb2dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:00 INFO - Running setup.py (path:/tmp/pip-P4xg7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:00 INFO - Running setup.py (path:/tmp/pip-Y_Vg98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:00 INFO - Running setup.py (path:/tmp/pip-yOfk7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:00 INFO - Running setup.py (path:/tmp/pip-EMg_SY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:00 INFO - Running setup.py (path:/tmp/pip-rQCUmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:00 INFO - Running setup.py (path:/tmp/pip-rz8LSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:01 INFO - Running setup.py (path:/tmp/pip-XM2AaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:01 INFO - Running setup.py (path:/tmp/pip-dYGZTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:01 INFO - Running setup.py (path:/tmp/pip-nes7yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:01 INFO - Running setup.py (path:/tmp/pip-EiTJya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:01 INFO - Running setup.py (path:/tmp/pip-nU8CIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:01 INFO - Running setup.py (path:/tmp/pip-3CvI0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:01 INFO - Running setup.py (path:/tmp/pip-E46C8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:14:01 INFO - Running setup.py install for manifestparser 09:14:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:14:01 INFO - Running setup.py install for mozcrash 09:14:01 INFO - Running setup.py install for mozdebug 09:14:01 INFO - Running setup.py install for mozdevice 09:14:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:14:01 INFO - Running setup.py install for mozfile 09:14:02 INFO - Running setup.py install for mozhttpd 09:14:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:14:02 INFO - Running setup.py install for mozinfo 09:14:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:14:02 INFO - Running setup.py install for mozInstall 09:14:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:14:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:14:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:14:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:14:02 INFO - Running setup.py install for mozleak 09:14:02 INFO - Running setup.py install for mozlog 09:14:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:14:02 INFO - Running setup.py install for moznetwork 09:14:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:14:02 INFO - Running setup.py install for mozprocess 09:14:02 INFO - Running setup.py install for mozprofile 09:14:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:14:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:14:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:14:02 INFO - Running setup.py install for mozrunner 09:14:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:14:02 INFO - Running setup.py install for mozscreenshot 09:14:03 INFO - Running setup.py install for moztest 09:14:03 INFO - Running setup.py install for mozversion 09:14:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:14:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:14:03 INFO - Cleaning up... 09:14:03 INFO - Return code: 0 09:14:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14: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')]} 09:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14: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')]} 09:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:03 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 0xf8b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1226290>, '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 0x1226b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:14:03 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 09:14:03 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 09:14:03 INFO - Using env: {'DISPLAY': ':0', 09:14:03 INFO - 'HOME': '/home/cltbld', 09:14:03 INFO - 'LANG': 'en_US.UTF-8', 09:14:03 INFO - 'LANGUAGE': 'en_US:en', 09:14:03 INFO - 'LOGNAME': 'cltbld', 09:14:03 INFO - 'MAIL': '/var/mail/cltbld', 09:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:03 INFO - 'MOZ_NO_REMOTE': '1', 09:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:03 INFO - 'NO_EM_RESTART': '1', 09:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:03 INFO - 'PWD': '/builds/slave/test', 09:14:03 INFO - 'SHELL': '/bin/bash', 09:14:03 INFO - 'SHLVL': '1', 09:14:03 INFO - 'TERM': 'linux', 09:14:03 INFO - 'TMOUT': '86400', 09:14:03 INFO - 'USER': 'cltbld', 09:14:03 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 09:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:03 INFO - '_': '/tools/buildbot/bin/python'} 09:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:14:03 INFO - Running setup.py (path:/tmp/pip-FHxBCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:14:03 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)) 09:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:14:03 INFO - Running setup.py (path:/tmp/pip-WBH_JB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:14:03 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)) 09:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:14:03 INFO - Running setup.py (path:/tmp/pip-R_VjkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:14:03 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)) 09:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:14:03 INFO - Running setup.py (path:/tmp/pip-9ZQ3d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 09:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:14:03 INFO - Running setup.py (path:/tmp/pip-mgYBs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:14:03 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)) 09:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:14:03 INFO - Running setup.py (path:/tmp/pip-IYMYXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:14:03 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)) 09:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:14:03 INFO - Running setup.py (path:/tmp/pip-BwEMI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:14:04 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)) 09:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:14:04 INFO - Running setup.py (path:/tmp/pip-k40Nvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:14:04 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)) 09:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:14:04 INFO - Running setup.py (path:/tmp/pip-Fw5mkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:14:04 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)) 09:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:14:04 INFO - Running setup.py (path:/tmp/pip-GYjxGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:14:04 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)) 09:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:14:04 INFO - Running setup.py (path:/tmp/pip-73VPzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:14:04 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)) 09:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:14:04 INFO - Running setup.py (path:/tmp/pip-b8myJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 09:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:14:04 INFO - Running setup.py (path:/tmp/pip-udR5k7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:14:04 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)) 09:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:14:04 INFO - Running setup.py (path:/tmp/pip-a7unMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:14:04 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)) 09:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:04 INFO - Running setup.py (path:/tmp/pip-S1NSe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:14:04 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)) 09:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:14:04 INFO - Running setup.py (path:/tmp/pip-QzFDOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 09:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:14:04 INFO - Running setup.py (path:/tmp/pip-xRKKM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:14:04 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)) 09:14:04 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)) 09:14:04 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)) 09:14:04 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)) 09:14:04 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:14:04 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:14:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:14:04 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 09:14:04 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 09:14:04 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 09:14:04 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 09:14:04 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 09:14:04 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 09:14:06 INFO - Downloading blessings-1.6.tar.gz 09:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:14:06 INFO - Installing collected packages: blessings 09:14:06 INFO - Running setup.py install for blessings 09:14:06 INFO - Successfully installed blessings 09:14:06 INFO - Cleaning up... 09:14:07 INFO - Return code: 0 09:14:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:07 INFO - Reading from file tmpfile_stdout 09:14:07 INFO - Current package versions: 09:14:07 INFO - argparse == 1.2.1 09:14:07 INFO - blessings == 1.6 09:14:07 INFO - blobuploader == 1.2.4 09:14:07 INFO - docopt == 0.6.1 09:14:07 INFO - functools32 == 3.2.3-2 09:14:07 INFO - jsonschema == 2.5.1 09:14:07 INFO - manifestparser == 1.1 09:14:07 INFO - mozInstall == 1.12 09:14:07 INFO - mozcrash == 1.0 09:14:07 INFO - mozdebug == 0.1 09:14:07 INFO - mozdevice == 0.50 09:14:07 INFO - mozfile == 1.2 09:14:07 INFO - mozhttpd == 0.7 09:14:07 INFO - mozinfo == 0.9 09:14:07 INFO - mozleak == 0.1 09:14:07 INFO - mozlog == 3.4 09:14:07 INFO - moznetwork == 0.27 09:14:07 INFO - mozprocess == 0.25 09:14:07 INFO - mozprofile == 0.28 09:14:07 INFO - mozrunner == 6.13 09:14:07 INFO - mozscreenshot == 0.1 09:14:07 INFO - mozsystemmonitor == 0.3 09:14:07 INFO - moztest == 0.8 09:14:07 INFO - mozversion == 1.4 09:14:07 INFO - psutil == 3.1.1 09:14:07 INFO - requests == 1.2.3 09:14:07 INFO - wsgiref == 0.1.2 09:14:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:07 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 0xf8b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1226290>, '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 0x1226b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:14:07 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 09:14:07 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 09:14:07 INFO - Using env: {'DISPLAY': ':0', 09:14:07 INFO - 'HOME': '/home/cltbld', 09:14:07 INFO - 'LANG': 'en_US.UTF-8', 09:14:07 INFO - 'LANGUAGE': 'en_US:en', 09:14:07 INFO - 'LOGNAME': 'cltbld', 09:14:07 INFO - 'MAIL': '/var/mail/cltbld', 09:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:07 INFO - 'MOZ_NO_REMOTE': '1', 09:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:07 INFO - 'NO_EM_RESTART': '1', 09:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:07 INFO - 'PWD': '/builds/slave/test', 09:14:07 INFO - 'SHELL': '/bin/bash', 09:14:07 INFO - 'SHLVL': '1', 09:14:07 INFO - 'TERM': 'linux', 09:14:07 INFO - 'TMOUT': '86400', 09:14:07 INFO - 'USER': 'cltbld', 09:14:07 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 09:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:07 INFO - '_': '/tools/buildbot/bin/python'} 09:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:07 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)) 09:14:07 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)) 09:14:07 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)) 09:14:07 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)) 09:14:07 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)) 09:14:07 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)) 09:14:07 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)) 09:14:07 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)) 09:14:07 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)) 09:14:07 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)) 09:14:07 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)) 09:14:07 INFO - Cleaning up... 09:14:07 INFO - Return code: 0 09:14:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:14:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1228b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1226290>, '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 0x1226b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:14:07 INFO - Using env: {'DISPLAY': ':0', 09:14:07 INFO - 'HOME': '/home/cltbld', 09:14:07 INFO - 'LANG': 'en_US.UTF-8', 09:14:07 INFO - 'LANGUAGE': 'en_US:en', 09:14:07 INFO - 'LOGNAME': 'cltbld', 09:14:07 INFO - 'MAIL': '/var/mail/cltbld', 09:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:07 INFO - 'MOZ_NO_REMOTE': '1', 09:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:07 INFO - 'NO_EM_RESTART': '1', 09:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:07 INFO - 'PWD': '/builds/slave/test', 09:14:07 INFO - 'SHELL': '/bin/bash', 09:14:07 INFO - 'SHLVL': '1', 09:14:07 INFO - 'TERM': 'linux', 09:14:07 INFO - 'TMOUT': '86400', 09:14:07 INFO - 'USER': 'cltbld', 09:14:07 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 09:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:07 INFO - '_': '/tools/buildbot/bin/python'} 09:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:14:07 INFO - Cleaning up... 09:14:07 INFO - Return code: 0 09:14:07 INFO - Running post-action listener: _resource_record_post_action 09:14:07 INFO - Running post-action listener: _start_resource_monitoring 09:14:07 INFO - Starting resource monitoring. 09:14:07 INFO - [mozharness: 2017-04-09 16:14:07.767924Z] Finished create-virtualenv step (success) 09:14:07 INFO - [mozharness: 2017-04-09 16:14:07.768429Z] Running install step. 09:14:07 INFO - Running pre-action listener: _resource_record_pre_action 09:14:07 INFO - Running main action method: install 09:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:14:07 INFO - Reading from file tmpfile_stdout 09:14:07 INFO - Detecting whether we're running mozinstall >=1.0... 09:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:14:08 INFO - Reading from file tmpfile_stdout 09:14:08 INFO - Output received: 09:14:08 INFO - Usage: mozinstall [options] installer 09:14:08 INFO - Options: 09:14:08 INFO - -h, --help show this help message and exit 09:14:08 INFO - -d DEST, --destination=DEST 09:14:08 INFO - Directory to install application into. [default: 09:14:08 INFO - "/builds/slave/test"] 09:14:08 INFO - --app=APP Application being installed. [default: firefox] 09:14:08 INFO - mkdir: /builds/slave/test/build/application 09:14:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:14:22 INFO - Reading from file tmpfile_stdout 09:14:22 INFO - Output received: 09:14:22 INFO - /builds/slave/test/build/application/firefox/firefox 09:14:22 INFO - Running post-action listener: _resource_record_post_action 09:14:22 INFO - [mozharness: 2017-04-09 16:14:22.772723Z] Finished install step (success) 09:14:22 INFO - [mozharness: 2017-04-09 16:14:22.772871Z] Running run-tests step. 09:14:22 INFO - Running pre-action listener: _resource_record_pre_action 09:14:22 INFO - Running main action method: run_tests 09:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:14:22 INFO - Python 2.7.3 09:14:22 INFO - Return code: 0 09:14:22 INFO - grabbing minidump binary from tooltool 09:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:14:22 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/linux64/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 0x1226290>, '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 0x1226b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1227040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:14:22 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:14:22 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/linux64/releng.manifest -o -c /builds/tooltool_cache 09:14:22 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:14:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:14:22 INFO - Return code: 0 09:14:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:14:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:14:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:14:22 INFO - ENV: RUST_BACKTRACE is now 1 09:14:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:14:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 09:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 09:14:22 INFO - Using env: {'DISPLAY': ':0', 09:14:22 INFO - 'HOME': '/home/cltbld', 09:14:22 INFO - 'LANG': 'en_US.UTF-8', 09:14:22 INFO - 'LANGUAGE': 'en_US:en', 09:14:22 INFO - 'LOGNAME': 'cltbld', 09:14:22 INFO - 'MAIL': '/var/mail/cltbld', 09:14:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:14:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:14:22 INFO - 'MOZ_NO_REMOTE': '1', 09:14:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:14:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:14:22 INFO - 'NO_EM_RESTART': '1', 09:14:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:14:22 INFO - 'PWD': '/builds/slave/test', 09:14:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:14:22 INFO - 'RUST_BACKTRACE': '1', 09:14:22 INFO - 'SHELL': '/bin/bash', 09:14:22 INFO - 'SHLVL': '1', 09:14:22 INFO - 'TERM': 'linux', 09:14:22 INFO - 'TMOUT': '86400', 09:14:22 INFO - 'USER': 'cltbld', 09:14:22 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961', 09:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:14:22 INFO - '_': '/tools/buildbot/bin/python'} 09:14:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 09:14:23 INFO - mozversion application_buildid: 20170409154642 09:14:23 INFO - mozversion application_changeset: c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba 09:14:23 INFO - mozversion application_display_name: Nightly 09:14:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:14:23 INFO - mozversion application_name: Firefox 09:14:23 INFO - mozversion application_remotingname: firefox 09:14:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:14:23 INFO - mozversion application_vendor: Mozilla 09:14:23 INFO - mozversion application_version: 55.0a1 09:14:23 INFO - mozversion platform_buildid: 20170409154642 09:14:23 INFO - mozversion platform_changeset: c6dd79ff61be3c1f1e6a8e4811ed5fc1e884feba 09:14:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:14:23 INFO - mozversion platform_version: 55.0a1 09:14:23 INFO - using testdate: 1491754463 09:14:23 INFO - actual date: 1491754463 09:14:23 INFO - starting webserver on 'localhost:35392' 09:14:23 INFO - SUITE-START | Running 2 tests 09:14:23 INFO - TEST-START | dromaeo_css 09:14:23 INFO - operating with platform_type : linux_ 09:14:23 INFO - Initialising browser for dromaeo_css test... 09:14:23 INFO - TEST-INFO | started process 3333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmQRfhD/profile http://localhost:35392/getInfo.html) 09:14:28 INFO - PID 3333 | __metrics Screen width/height:1600/1200 09:14:28 INFO - PID 3333 | colorDepth:24 09:14:28 INFO - PID 3333 | Browser inner width/height: 1024/697 09:14:28 INFO - PID 3333 | __metrics 09:14:29 INFO - PID 3333 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:14:29 INFO - PID 3333 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:14:30 INFO - TEST-INFO | 3333: exit 0 09:14:30 INFO - Browser initialized. 09:14:30 INFO - Running cycle 1/1 for dromaeo_css test... 09:14:30 INFO - TEST-INFO | started process 3425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmQRfhD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:14:42 INFO - PID 3425 | RSS: Main: 153305088 09:14:42 INFO - PID 3425 | 09:17:49 INFO - PID 3425 | Cycle 1(1): loaded http://localhost:35392/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35392/tests/dromaeo/cssquery-ext.html) 09:17:51 INFO - PID 3425 | RSS: Main: 311418880 09:17:51 INFO - PID 3425 | 09:19:32 INFO - PID 3425 | ************************* 09:19:32 INFO - PID 3425 | A coding exception was thrown and uncaught in a Task. 09:19:32 INFO - PID 3425 | 09:19:32 ERROR - PID 3425 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:19:32 INFO - PID 3425 | Full stack: 09:19:32 INFO - PID 3425 | ************************* 09:19:32 INFO - PID 3425 | ************************* 09:19:32 INFO - PID 3425 | A coding exception was thrown and uncaught in a Task. 09:19:32 INFO - PID 3425 | 09:19:32 ERROR - PID 3425 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:19:32 INFO - PID 3425 | Full stack: 09:19:32 INFO - PID 3425 | ************************* 09:19:32 INFO - PID 3425 | ************************* 09:19:32 INFO - PID 3425 | A coding exception was thrown and uncaught in a Task. 09:19:32 INFO - PID 3425 | 09:19:32 ERROR - PID 3425 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:19:32 INFO - PID 3425 | Full stack: 09:19:32 INFO - PID 3425 | ************************* 09:19:32 INFO - PID 3425 | ************************* 09:19:32 INFO - PID 3425 | A coding exception was thrown and uncaught in a Task. 09:19:32 INFO - PID 3425 | 09:19:32 ERROR - PID 3425 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:19:32 INFO - PID 3425 | Full stack: 09:19:32 INFO - PID 3425 | ************************* 09:20:53 INFO - PID 3425 | Cycle 1(1): loaded http://localhost:35392/tests/dromaeo/cssquery-ext.html (next: http://localhost:35392/tests/dromaeo/cssquery-jquery.html) 09:20:54 INFO - PID 3425 | RSS: Main: 229994496 09:20:54 INFO - PID 3425 | 09:23:56 INFO - PID 3425 | Cycle 1(1): loaded http://localhost:35392/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35392/tests/dromaeo/cssquery-mootools.html) 09:23:56 INFO - PID 3425 | RSS: Main: 181411840 09:23:56 INFO - PID 3425 | 09:26:58 INFO - PID 3425 | Cycle 1(1): loaded http://localhost:35392/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35392/tests/dromaeo/cssquery-prototype.html) 09:26:59 INFO - PID 3425 | RSS: Main: 205287424 09:26:59 INFO - PID 3425 | 09:30:02 INFO - PID 3425 | Cycle 1(1): loaded http://localhost:35392/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35392/tests/dromaeo/cssquery-yui.html) 09:30:03 INFO - PID 3425 | RSS: Main: 183435264 09:30:03 INFO - PID 3425 | 09:33:05 INFO - PID 3425 | Cycle 1(1): loaded http://localhost:35392/tests/dromaeo/cssquery-yui.html (next: http://localhost:35392/tests/dromaeo/cssquery-dojo.html) 09:33:05 INFO - PID 3425 | RSS: Main: 271486976 09:33:05 INFO - PID 3425 | 09:33:05 INFO - PID 3425 | __start_tp_report 09:33:05 INFO - PID 3425 | _x_x_mozilla_page_load 09:33:05 INFO - PID 3425 | _x_x_mozilla_page_load_details 09:33:05 INFO - PID 3425 | |i|pagename|runs| 09:33:05 INFO - PID 3425 | |0;dojo.html;2678.178838389895;2708.2281549758322;2739.109789318472;2739.123480486245;2746.491898998685;5103.106956282654;5197.740112994354;5243.501867322608;5259.289995850559;5315;5174.042802081617;5186.611004174692;5215.243789650498;5218.556422704065;5225.346831646044;4621.329907163467;4662;4669.696469729473;4693.601043911254;4718.646101542381;4687.531246875302;4711.929321060187;4724.291356296566;4726.10204061229;4727.432708075019;4705.670603057787;4714.528547145293;4716.811327546911;4718.41019872516;4721.079389519045;4713.198756211418;4717.2924061390895;4740.146773580754;4742.5731684148595;4780.784864681063;4710.3405523226775;4715.528447155291;4715.858524244278;4717.622590192776;4763.071201115784;5090.109230884617;5182.041322355376;5189.40321862983;5220.582353411718;5282.154855223146;5535;5644.6330988485615;5708.1723150143;5711.371749107595;5731.168980497846;5704.515116215127;5716.3426205986425;5718.342390625048;5723.971380143073;5729.885402291972;5260.684358938476;5302.522772950453;5308.124159513637;5313.654612450178;5357.892842143213;5688.374278829326;5760.308762948473;5761.53907687384;5764.077747560454;5817.76728930838;5538.141588053858;5547.944520554743;5559.471850174227;5564.248826408464;5619.185218143346;5648.717564121777;5650.745716442688;5653.236813030188;5653.830385088454;5657.2928383952;5459.099248623933;5484.698341591251;5541.695206763586;5591.888162236733;5597.692126932976;5563.916541251884;5578.135389014628;5657.547396208293;5662;5666;4745.501722319176;4764.356811830427;4764.380630518011;4768.666193366431;4803.615710743132;3997.060690737674;4064.1262128642484;4082.346824508124;4083.693722970789;4101.179764047202;4743.051389722069;4745.549172828576;4785.569298763058;4813.15769740294;4815.253635686474;5613.158026296088;5614.101743721067;5615.606907516435;5618.185363122325;5618.325800903836;4674.766261686902;4718.669693121448;4728.3143944127905;4734.147853386355;4776.307435421844;4898.314236006961;4969.751512424436;5020.47285035066;5084.5932325414615;5090.643654944119;5300.9734951325;5302.602304827076;5304.124819404755;5305.2307415423775;5335.573154147736;5623.606347555632;5680.4319568042865;5699.373068962328;5716.628419152742;5758.856028599151;5185.248139019745;5259.55293800016;5265.1049321614655;5290.735463226746;5316.255724198692;5600.579956503197;5605;5607.43925607436;5622.269105016322;5662.094064949753;5515.172724091419;5629.802956896489;5704.572157088318;5712.285964254468;5715.457031581993;5431.185322201702;5438.918416223839;5504.779808807763;5507.146392309199;5513.724313784375;5467;5476.151196564539;5483.917741233964;5485.862853428696;5487.670739755627;5347.625666203328;5360.517553420211;5370.113931201308;5404.189371594135;5405.78376864921;5351.892962140813;5453.7818487260065;5485.862853428696;5495.120780675073;5570.470805273492;5415.187721841755;5417.539509141767;5422.593305502024;5430.891382172255;5433.212184233343 09:33:05 INFO - PID 3425 | |1;ext.html;654.6595770199497;724.3661795928563;735.1252010107972;1040.2977989856845;1056.857324261225;26409.60385594215;27018.86490567547;27019.189424317254;27081.72918270819;27093.322666933338;32845.178870528245;33383.49924751131;33423.832880835624;33471.49792753105;33471.497927531105;7280.526765760222;7443.925560744377;7445.069366329209;7446.9627651861665;7450;5578.944210557883;5708.372079071299;7315.524490908074;7455.4781165318445;7457.701691932316;7249.238829922861;7379.1145062592295;7406.148292946299;7414;7417.184109747924;7405.148407933076;7466.738664146783;7470.290322419389;7474.364679002291;7479.887801682979;5486.1222204447495;5614.1859430382365;7117.608531530764;7240.601766902818;7340.045794046793;32781.39404665485;33178;33195;33195.33609327824;33230.83384583086;3000.5949196858364;3059.021113243763;3064.908052758421;3065.586145870301;3067.9846600766855;25031.374215644573;25076.749232507806;25186.496270074495;25269.62095568568;25282.494350112895;3229.2411283348392;3231.4021905947475;3249.301400198945;3251.837408129608;3254.6908043735807;137763.31118344344;138113;138197.3090134553;138623;138700;41309.586904131174;41341;41360;41380.1723965525;41391.58608413937;43124;43125.56874431216;43155.568444315155;43282;43284.78357608192;11550.075993920465;11584.36286004261;11590.594329198437;11614.535418583162;11727.706807329714;9195.356325057315;9209.815803684023;9248.30637702175;9263.397879137834;9302.627894884128;10455.111315538112;10588.311759735592;11889.227200231957;11906.583269585522;12196.146269761031;4663.906721865612;4713.905721885543;4742.264948932852;4811.879703007453;4839.41926968766;857.1557016338901;879.7712594725417;888.9555522223862;898.3442087276325;904.882365292521;20425.89787051055;20987.265445709327;21281.78718212798;21467.67798483024;21755.238566650092;960;965.8502932045544;968.0561452583815;970.6117552978724;991.0386924683046;11343.739614798798;11366.374849383197;11387.658370248906;11407.885921140849;11502.48238829238;182947;184026;184326;184522;184630;40766.59233407687;40949.59050409458;40963.7951810245;40991.59008409937;41012.79493602513;1189.1299302225614;1212.4968138222716;1229.20101933742;1232.2729589542214;1238.746057058301;19588.412347629594;19733;20389.79610203879;21080.156793728693;21411.35765927025;30330.696693032787;30330.848345759012;30368.240793979443;30386.69613303927;30389.696103039572;173543;173680;173745;173816.1309193446;173979;29538.704612953596;29688.257793555335;30043.69956300409;30094;30217.244568885955;31395.686043139278;31735.682643173273;37192;37196.25607487889;37442.43836342402;27916.581251281652;28213.57679634766;28490;28619.713802861705;29440.705592943796;28001.299967500974;28213.717862821108;28959.85520072386;29010.709892900803;29235.85382073076;31139.221519461287;31149.377012460078;31165.220869478446;31211.687883120878;31303.686963130076;26617.33456663599;27098.864505677346;27166.1850144496;27292.590611141244;27678.861605691844;20074.18961345442;20617.69073463929;20741.27405540799;20939.685904711747;20977.265795697076 09:33:05 INFO - PID 3425 | |2;jquery.html;400.46737838674545;410.6551590418709;420.6109348852312;421.9029623186667;424.74939785526544;16857.91571042146;17579.38472153475;18256;18350.265989360425;18356.632867342647;15305.311260993254;15516.456924007662;15883.761743573827;17270.309187632512;17635.470935871945;5574.052411090104;5586.10622300432;5685.374608793029;5763.279590051244;5767.855803604902;5546.084895992157;5642.407547207546;5645.040343141676;5645.717714114298;5649.209110724501;5443.755031023594;5607.523360514341;5621.072523033715;5622.662640241578;5661.943380566183;5670.631408958405;5729.914051289234;5732.197492351032;5735.426457354273;5739.598228124012;5022.773975171126;5128.640995130342;5167.354080739908;5171.637985341028;5184.326037615086;22074.22740204085;22401.439964000867;22440.77559224403;22502.54994900109;22532.21137260188;1647.1599484263113;1666.316810107862;1698.79614446266;1700.2773821125973;1704.1053446940455;14688.265586720729;14715.11709297435;14945.40218391263;14980.400783968627;15032.17323047232;2066.245820275604;2145.5195914818723;2153.935381938544;2161.848670593059;2164.632012557869;88075;89333;89726.5513672434;90930.5453472735;91290;10627.52176152075;10726.19553533488;10764.56941722338;10903.727406814893;11109.111271098292;14993.32530036151;15016.924915375572;15038.699226015637;15043.398264069534;15048.699026019418;6967.651617419108;7038.542494737826;7193.784186474414;7245.275472452818;7256.818579535554;6233.937660623335;6239.1577137085915;6391.42477177047;6395.264544577433;6430.646314452656;6783.253842077367;6932.584044957319;6957;6962.2341542430295;6986.615736134459;2016.8386529077638;2031.3702752146883;2037.2258541754038;2048.5185981294385;2152.3758110148196;825.5913322905201;861.6079683743882;870.7083127152475;896.3994123936848;899.2491269789668;16880.155992200587;17131.74302385465;17383.217755201047;17509.737353939447;17959.371422000168;869.7912500999714;872.1278721278721;872.9432586881833;880.2341962492544;899.0445780427674;9473.857892131624;9768.902310976799;9866.260030497742;9871.851922221173;9877.456739879231;454007;471665;473658;485686;487363;88021.9972503437;89457;90642.09357906337;91125.54437227904;92780.53609731908;1043.8382050781988;1056.0653821368144;1093.2565855218368;1121.876593574706;1127.3799410324289;17461.30154793845;17727.202275897875;18167.27330906749;18192.090395479907;18389.17248723784;43115.353269701605;43928.34107488454;44054.55945440633;44111.33832992444;44160;56378.43621563896;57204;57356.71321643365;58241.12638310344;58316;7794.766157015299;7905.367570594453;7991.200879911962;8186.181381861767;8263.95868020656;12650.367481625697;13063.150895191782;13325.66685832862;13560.457581697015;13569.253691047088;10807.72980675458;11011.28426652265;11106.167037472384;11183.888161118284;11528.365939873387;10166.644167454104;10211.387316761018;11087.72280692989;11150.609728659458;11243.775124497628;11168.609098681507;11587;11617.709557261136;11899.762004759683;12182.695432614255;8039.437239393186;8121.472104313437;8141.430099893188;8459.365547584079;8631.784205394664;10577.9471102644;10582.49254928363;10775.461226938778;11650.475728592402;11728.061755059403 09:33:05 INFO - PID 3425 | |3;mootools.html;1110.6001839337832;1180.7284324605341;1244.8879600835924;1254.924704517729;1256.246252248651;8519.53142577158;9852.113309802126;10173.847392289103;10184.898151018479;10187.643432479865;9923.851142232854;10020.69937901864;10030.348027378233;10034.949825250864;10038.397696138218;1910.7516022917002;2172.9674054889188;2216.1689366487567;2217.2128894242555;2219.9556008879813;1951.9902400487977;2195.8572692774997;2275.533515629292;2278.8632682039047;2279.4415368234722;2222.977770222293;2234.497238121418;2244.539869326792;2245.236619549353;2247.1573160064977;2154.859934104286;2160.5030842906062;2162.4593851537115;2167.6856855755987;2167.8590891592;2172.0985790896757;2189.4526368407896;2199.1533259694975;2224;2226.3877433705698;9753.268504862093;9821.607135714634;9829.213662907021;9837.950810245975;9839.409635421825;5400.648957817769;5572.192032155314;5585.106382978704;5585.553155747531;5587.189857470644;3310.6358300586917;3458.8616455342008;3484.982575087108;3516.595591506984;3518.894433167009;1032.0608246495653;1046.3408052926684;1058.1111866032493;1074.8011617850646;1078.1967434261446;14377.64055898611;14393.28033598316;14395.78406323906;14396.568102956928;14412.351444184931;4822.228443449101;4886.364772579613;4958.330625365529;5128.487151284841;5157.63896527247;12002.939985300192;12013.699657508632;12017.939910300393;12044.698882527831;12047.578334758242;5553.750081246354;5553.805616803393;5555.8888822224135;5559.11054231321;5561.165825126263;4909.926351104737;4920.778564964585;4943.530364615356;4945.579625731853;5027.874303142377;3708.7589306694977;3817.034227372905;3830.367989281737;3845.8653947111716;3886.3198940185353;1079.6868908016745;1082.274875833178;1106.2145876427664;1109.0351394287022;1120.7534342444649;677.8440958579554;706.5160365149889;707.1620130145793;721.6103304215769;724.427702115323;5147;5245.396779370345;5267.367915850123;5339.332583427072;5431.8098866539485;818.7953011747063;833.6790335720669;844.6494704697482;852.2968550945495;856.7601071699934;3666.211764470652;3814.1036856338737;3853.5761066282685;3871.922561548753;3915.3735402335487;12447.93776031132;12848.229106253655;12943.805842912363;13063.869361306455;13066.477340906258;12645;12924.095313327976;12961.481540738265;13120.015998800129;13201.339933003312;9301;9351.719448416557;9436.480993545283;9447.905520944703;9455.858162127573;5753.510951569164;5874.353821079763;5893.70531473416;5906.26171728534;6065.302490213682;11413.08695304357;11676.766464670829;11721.765564688829;11882.643520694393;11931.940340298243;11717.707057323634;12039.819402708792;12074.335911524951;12229.93885030569;12245.816312755138;7627.199144090013;7898.3681305496575;7904.446688731734;7917.524948503108;7920.326772224425;9277.118673725985;9359.906400935903;9367.110124538158;9367.250619950251;9367.484788336707;7960.761177164694;8076.555789431402;8099.757007289791;8120.634571444181;8377.623006964579;7892.408069394934;7949.205079492004;7990.760277191694;8031;8046.0747014091785;6754.696038678369;6859.416949559343;6869;6870.038194652652;6873.725050997904;5376.1398176291605;5376.327959005124;5477.178423236546;5529.917051244154;5632.88734225305;5359.088954877758;5418.160185171305;5481.766602514403;5502.064649009758;5579.916301255404 09:33:05 INFO - PID 3425 | |4;prototype.html;364.19331181433137;378.26238834273175;380.0441888650044;381.66032231314125;384.46751249519417;5033.697978121306;5163.612729045318;5264.8157314494;5275.1296036154035;5320.733963301834;4990.825321113762;5077.441481437039;5092.694438333702;5129.204973229146;5154.74226288685;4058.706830640693;4074.592540745924;4078.6125318094732;4079.5920407959115;4085.7957102144924;3994.9600503995025;4069.308217603;4076.9796151019204;4084.244414783275;4088.672906167514;4032.153247817947;4051.858184963527;4052.3111071117983;4060.675145988314;4064.695147863907;4040.1919616076757;4044.716869819114;4055.4930633670792;4057.7768222747736;4066.7966601670096;3665.3402387570227;3676.1728611062563;3681.9631803682155;3683.0055884910926;3685.63143685632;4873.610111191097;5013.097642424362;5029.673071250357;5048.570871475929;5081.729567608098;4800.087983283165;4802.687825291345;4802.807887684488;4804.855854324376;4814.374131362901;5505.3393592768725;5511.944880551223;5513.228148059275;5523;5546.861328466821;4030.717849750519;4120.114175452262;4135.77253251071;4143.3370660694145;4162.958370416287;5718.799052199043;5722.2561067061015;5735.4551317624755;5743.712814359265;5753.942460575383;4244.957550424518;4260.147970405931;4261.126469073833;4266.274733295348;4282.164977829293;4154.688398370074;4301.956980430155;4327.545607711145;4340.913181736348;4349.19539885116;4754.358161648202;4775.235962246094;4777.235642297216;4785.1625965455905;4785.353977213102;5445.50990410865;5451.209574611659;5463.781448742086;5463.808766693226;5489.835304940858;1374.4090041282345;1405.444849284527;1470.1326217531707;1480.452232673896;1501.0768377447791;1026.1841835740604;1061.766411389493;1062.4953147254992;1064.1539975719322;1066.4454483668603;4776.641751868554;4806.735629540339;4808.3989501312335;4809.591184749265;4813.975930120327;5603.551715862721;5618.213450116987;5630.8029218977135;5633.943660563424;5641.5204707600315;4657.813687452464;4773.689710168828;4779.474257831635;4782.163121453732;4810.855674329776;2962.2890506278336;2989.4768415527196;2997.961386257366;2999.5950546675917;3004.173852190665;5308.442613525602;5319.441458646864;5324.0150572144275;5326.6537675050995;5329.973350133225;5560.610757246954;5722.799702010409;5754.4533269339345;5779.901818654443;5822.388649191774;5226.189940559219;5237.6857388556045;5259.184826351921;5265.97206606203;5282.656627319212;5495.972520137374;5629.211910332639;5630.971845140748;5648.971755141362;5658.953093677518;5562.888742225214;5564.554835613222;5571.804986825442;5578.972105139448;5600.691961942132;5271.499207575274;5276.604254680991;5278.498542638443;5281.441974617574;5296.947030529799;4176.561461046668;4265.573442655709;4282.507511636201;4299.333603291495;4299.677524185761;5344.625876188629;5578.856334451509;5587.860303492445;5590.748416321194;5605.794754127719;5321.228421878728;5331.573474121983;5490.780368785204;5494;5495.5878309127775;5422.5119739223655;5469;5478.589105817;5498.890022199454;5510;5183.144781111075;5324.281222034976;5344.198370244494;5363.624546281723;5377.08589539787;5497.422770609029;5518.806841760519;5527.695976721319;5548.389677135431;5562.582806289463;5381.650192737459;5395.541378982831;5396.379416367011;5406.7296635167295;5414.83755487336 09:33:05 INFO - PID 3425 | |5;yui.html;659.9802005939821;661.1702313596436;730.2551397574474;752.65001774175;764.7055883484859;10229.641962531314;12520.24878507289;13020.93489532551;13143.868561314384;13224.7355052899;12599.244045357262;12655.114142010063;13110.21338719675;13186.142900711448;13195.076344655878;874.6151693254964;888.1739981816908;890.4345740454826;891.0154279521133;891.1266958380791;648.4812150279781;659.9868002639944;854.8674955381925;858.5449711652834;860.604122103833;905.3933864310927;907.3875134284365;912.3522299167565;913.0002647101413;921.5898924978387;911.5761171055491;912.5391677203037;912.8037471943564;913.9086091390874;929.6746138851415;492.0478873380021;495.7669895149274;658.8122385120217;663.359857737281;666.8866292730247;11653.41732913351;11674.241174323643;11802.645920622395;11824.467898944482;12235.816462753066;14688.779668304984;14854.257287135708;15666.53000409978;15797.763033554505;15798.736101111883;10928.453577321103;11121.110311175087;11175;11342.432878356049;11390.60132895353;2885.2354126156583;2893.392387598607;2898.376848977459;2903.637045369329;2904.7385735283924;63250;63775.36224637741;63867.36132638661;63883;64498.35501644971;10149.137323327599;10505.159587233004;12400.62798116058;12685.365731713377;12823.871761282455;19748.30880919161;20030.49923751918;20505.89747051255;22198.55602887933;22450.663240051414;7465.2534746526;7601.847963040819;7602.239776022464;7618.352440042659;7642.19756925526;3762.097096696828;3772.6227377262603;3812.6377994090517;3851.017990412483;3856;3510.280392519527;3601.6218297078954;3601.9099522511624;3607.7294202934886;3612.8012959286966;725.2312548698396;730.8501757139774;736.4697417859132;737.0896942276285;737.2259127915667;566.4929887750523;566.8384510414512;574.299354787159;574.9885002299931;577.9104238842986;9437.150656440954;9474.621015159455;9523;9599.184069354043;9843.75390615226;545.7953267524679;563.650536667269;571.08056029792;573.4552175433272;577.4860374266906;4228.099849816154;4243.872683819491;4273.722208056466;4366.19225443294;4371.693981421334;56877;57611.13583296254;58643.70678146582;61800.381996179465;62289.377106229265;51657;51734.48265517372;51855.740721296905;52238;55175.44824551703;46019.30971035437;46321;48360.03279934452;49262.0147597046;49920.750396247786;9525.237980961645;9982.301238913205;10187.13409360183;10433.634822781167;10503.894961050291;25621;25651.486970260863;25732.485350292514;25799.355016124748;25809.741902580732;41725.79137104295;42040.1591968165;43284.35073473837;43841.56158438375;43888;13780.310984450536;14048.157110573398;14084.22536760488;14201.360938757574;14448.277586120863;13672.52146174879;13696.65758356049;13878.514252001132;14690.63273418173;15262.23688815577;13348.733025339245;14099;14195.219262940223;14376.640583985483;14572.417103315749;14358.712825743636;14407.85592144107;14471.059381140612;14617.269136543344;14769.630759231106;13114.73770524565;13176.80234796498;13241.602751917459;13336.733265334446;13414.664633384244;9444.622215111593;9566.61733530651;9841.212702983887;10058.044485774133;10272.075513203847;10207.693769186937;10515.57937682484;10678.412687302272;10785.62250321235;10833.67498975032 09:33:05 INFO - PID 3425 | __end_tp_report 09:33:05 INFO - PID 3425 | __start_cc_report 09:33:05 INFO - PID 3425 | _x_x_mozilla_cycle_collect,1737 09:33:05 INFO - PID 3425 | __end_cc_report 09:33:05 INFO - PID 3425 | __startTimestamp1491755585530__endTimestamp 09:33:05 INFO - PID 3425 | 09:33:05 INFO - PID 3425 | ------- Summary: start ------- 09:33:05 INFO - PID 3425 | Number of tests: 6 09:33:05 INFO - PID 3425 | 09:33:05 INFO - PID 3425 | [#0] dojo.html Cycles:165 Average:5166.28 Median:5316.26 stddev:600.32 (11.3%) stddev-sans-first:569.54 09:33:05 INFO - PID 3425 | Values: 2678.2 2708.2 2739.1 2739.1 2746.5 5103.1 5197.7 5243.5 5259.3 5315.0 5174.0 5186.6 5215.2 5218.6 5225.3 4621.3 4662.0 4669.7 4693.6 4718.6 4687.5 4711.9 4724.3 4726.1 4727.4 4705.7 4714.5 4716.8 4718.4 4721.1 4713.2 4717.3 4740.1 4742.6 4780.8 4710.3 4715.5 4715.9 4717.6 4763.1 5090.1 5182.0 5189.4 5220.6 5282.2 5535.0 5644.6 5708.2 5711.4 5731.2 5704.5 5716.3 5718.3 5724.0 5729.9 5260.7 5302.5 5308.1 5313.7 5357.9 5688.4 5760.3 5761.5 5764.1 5817.8 5538.1 5547.9 5559.5 5564.2 5619.2 5648.7 5650.7 5653.2 5653.8 5657.3 5459.1 5484.7 5541.7 5591.9 5597.7 5563.9 5578.1 5657.5 5662.0 5666.0 4745.5 4764.4 4764.4 4768.7 4803.6 3997.1 4064.1 4082.3 4083.7 4101.2 4743.1 4745.5 4785.6 4813.2 4815.3 5613.2 5614.1 5615.6 5618.2 5618.3 4674.8 4718.7 4728.3 4734.1 4776.3 4898.3 4969.8 5020.5 5084.6 5090.6 5301.0 5302.6 5304.1 5305.2 5335.6 5623.6 5680.4 5699.4 5716.6 5758.9 5185.2 5259.6 5265.1 5290.7 5316.3 5600.6 5605.0 5607.4 5622.3 5662.1 5515.2 5629.8 5704.6 5712.3 5715.5 5431.2 5438.9 5504.8 5507.1 5513.7 5467.0 5476.2 5483.9 5485.9 5487.7 5347.6 5360.5 5370.1 5404.2 5405.8 5351.9 5453.8 5485.9 5495.1 5570.5 5415.2 5417.5 5422.6 5430.9 5433.2 09:33:05 INFO - PID 3425 | 09:33:05 INFO - PID 3425 | [#1] ext.html Cycles:180 Average:30761.99 Median:3066.79 stddev:43075.23 (1404.6%) stddev-sans-first:43136.75 09:33:05 INFO - PID 3425 | Values: 654.7 724.4 735.1 1040.3 1056.9 26409.6 27018.9 27019.2 27081.7 27093.3 32845.2 33383.5 33423.8 33471.5 33471.5 7280.5 7443.9 7445.1 7447.0 7450.0 5578.9 5708.4 7315.5 7455.5 7457.7 7249.2 7379.1 7406.1 7414.0 7417.2 7405.1 7466.7 7470.3 7474.4 7479.9 5486.1 5614.2 7117.6 7240.6 7340.0 32781.4 33178.0 33195.0 33195.3 33230.8 3000.6 3059.0 3064.9 3065.6 3068.0 25031.4 25076.7 25186.5 25269.6 25282.5 3229.2 3231.4 3249.3 3251.8 3254.7 137763.3 138113.0 138197.3 138623.0 138700.0 41309.6 41341.0 41360.0 41380.2 41391.6 43124.0 43125.6 43155.6 43282.0 43284.8 11550.1 11584.4 11590.6 11614.5 11727.7 9195.4 9209.8 9248.3 9263.4 9302.6 10455.1 10588.3 11889.2 11906.6 12196.1 4663.9 4713.9 4742.3 4811.9 4839.4 857.2 879.8 889.0 898.3 904.9 20425.9 20987.3 21281.8 21467.7 21755.2 960.0 965.9 968.1 970.6 991.0 11343.7 11366.4 11387.7 11407.9 11502.5 182947.0 184026.0 184326.0 184522.0 184630.0 40766.6 40949.6 40963.8 40991.6 41012.8 1189.1 1212.5 1229.2 1232.3 1238.7 19588.4 19733.0 20389.8 21080.2 21411.4 30330.7 30330.8 30368.2 30386.7 30389.7 173543.0 173680.0 173745.0 173816.1 173979.0 29538.7 29688.3 30043.7 30094.0 30217.2 31395.7 31735.7 37192.0 37196.3 37442.4 27916.6 28213.6 28490.0 28619.7 29440.7 28001.3 28213.7 28959.9 29010.7 29235.9 31139.2 31149.4 31165.2 31211.7 31303.7 26617.3 27098.9 27166.2 27292.6 27678.9 20074.2 20617.7 20741.3 20939.7 20977.3 09:33:05 INFO - PID 3425 | 09:33:05 INFO - PID 3425 | [#2] jquery.html Cycles:180 Average:28612.65 Median:43521.85 stddev:78529.44 (180.4%) stddev-sans-first:78721.17 09:33:05 INFO - PID 3425 | Values: 400.5 410.7 420.6 421.9 424.7 16857.9 17579.4 18256.0 18350.3 18356.6 15305.3 15516.5 15883.8 17270.3 17635.5 5574.1 5586.1 5685.4 5763.3 5767.9 5546.1 5642.4 5645.0 5645.7 5649.2 5443.8 5607.5 5621.1 5622.7 5661.9 5670.6 5729.9 5732.2 5735.4 5739.6 5022.8 5128.6 5167.4 5171.6 5184.3 22074.2 22401.4 22440.8 22502.5 22532.2 1647.2 1666.3 1698.8 1700.3 1704.1 14688.3 14715.1 14945.4 14980.4 15032.2 2066.2 2145.5 2153.9 2161.8 2164.6 88075.0 89333.0 89726.6 90930.5 91290.0 10627.5 10726.2 10764.6 10903.7 11109.1 14993.3 15016.9 15038.7 15043.4 15048.7 6967.7 7038.5 7193.8 7245.3 7256.8 6233.9 6239.2 6391.4 6395.3 6430.6 6783.3 6932.6 6957.0 6962.2 6986.6 2016.8 2031.4 2037.2 2048.5 2152.4 825.6 861.6 870.7 896.4 899.2 16880.2 17131.7 17383.2 17509.7 17959.4 869.8 872.1 872.9 880.2 899.0 9473.9 9768.9 9866.3 9871.9 9877.5 454007.0 471665.0 473658.0 485686.0 487363.0 88022.0 89457.0 90642.1 91125.5 92780.5 1043.8 1056.1 1093.3 1121.9 1127.4 17461.3 17727.2 18167.3 18192.1 18389.2 43115.4 43928.3 44054.6 44111.3 44160.0 56378.4 57204.0 57356.7 58241.1 58316.0 7794.8 7905.4 7991.2 8186.2 8264.0 12650.4 13063.2 13325.7 13560.5 13569.3 10807.7 11011.3 11106.2 11183.9 11528.4 10166.6 10211.4 11087.7 11150.6 11243.8 11168.6 11587.0 11617.7 11899.8 12182.7 8039.4 8121.5 8141.4 8459.4 8631.8 10577.9 10582.5 10775.5 11650.5 11728.1 09:33:05 INFO - PID 3425 | 09:33:05 INFO - PID 3425 | [#3] mootools.html Cycles:180 Average:6259.81 Median:3900.85 stddev:3986.48 (102.2%) stddev-sans-first:3978.88 09:33:05 INFO - PID 3425 | Values: 1110.6 1180.7 1244.9 1254.9 1256.2 8519.5 9852.1 10173.8 10184.9 10187.6 9923.9 10020.7 10030.3 10034.9 10038.4 1910.8 2173.0 2216.2 2217.2 2220.0 1952.0 2195.9 2275.5 2278.9 2279.4 2223.0 2234.5 2244.5 2245.2 2247.2 2154.9 2160.5 2162.5 2167.7 2167.9 2172.1 2189.5 2199.2 2224.0 2226.4 9753.3 9821.6 9829.2 9838.0 9839.4 5400.6 5572.2 5585.1 5585.6 5587.2 3310.6 3458.9 3485.0 3516.6 3518.9 1032.1 1046.3 1058.1 1074.8 1078.2 14377.6 14393.3 14395.8 14396.6 14412.4 4822.2 4886.4 4958.3 5128.5 5157.6 12002.9 12013.7 12017.9 12044.7 12047.6 5553.8 5553.8 5555.9 5559.1 5561.2 4909.9 4920.8 4943.5 4945.6 5027.9 3708.8 3817.0 3830.4 3845.9 3886.3 1079.7 1082.3 1106.2 1109.0 1120.8 677.8 706.5 707.2 721.6 724.4 5147.0 5245.4 5267.4 5339.3 5431.8 818.8 833.7 844.6 852.3 856.8 3666.2 3814.1 3853.6 3871.9 3915.4 12447.9 12848.2 12943.8 13063.9 13066.5 12645.0 12924.1 12961.5 13120.0 13201.3 9301.0 9351.7 9436.5 9447.9 9455.9 5753.5 5874.4 5893.7 5906.3 6065.3 11413.1 11676.8 11721.8 11882.6 11931.9 11717.7 12039.8 12074.3 12229.9 12245.8 7627.2 7898.4 7904.4 7917.5 7920.3 9277.1 9359.9 9367.1 9367.3 9367.5 7960.8 8076.6 8099.8 8120.6 8377.6 7892.4 7949.2 7990.8 8031.0 8046.1 6754.7 6859.4 6869.0 6870.0 6873.7 5376.1 5376.3 5477.2 5529.9 5632.9 5359.1 5418.2 5481.8 5502.1 5579.9 09:33:05 INFO - PID 3425 | 09:33:05 INFO - PID 3425 | [#4] prototype.html Cycles:180 Average:4583.27 Median:5063.01 stddev:1288.32 (25.4%) stddev-sans-first:1252.41 09:33:05 INFO - PID 3425 | Values: 364.2 378.3 380.0 381.7 384.5 5033.7 5163.6 5264.8 5275.1 5320.7 4990.8 5077.4 5092.7 5129.2 5154.7 4058.7 4074.6 4078.6 4079.6 4085.8 3995.0 4069.3 4077.0 4084.2 4088.7 4032.2 4051.9 4052.3 4060.7 4064.7 4040.2 4044.7 4055.5 4057.8 4066.8 3665.3 3676.2 3682.0 3683.0 3685.6 4873.6 5013.1 5029.7 5048.6 5081.7 4800.1 4802.7 4802.8 4804.9 4814.4 5505.3 5511.9 5513.2 5523.0 5546.9 4030.7 4120.1 4135.8 4143.3 4163.0 5718.8 5722.3 5735.5 5743.7 5753.9 4245.0 4260.1 4261.1 4266.3 4282.2 4154.7 4302.0 4327.5 4340.9 4349.2 4754.4 4775.2 4777.2 4785.2 4785.4 5445.5 5451.2 5463.8 5463.8 5489.8 1374.4 1405.4 1470.1 1480.5 1501.1 1026.2 1061.8 1062.5 1064.2 1066.4 4776.6 4806.7 4808.4 4809.6 4814.0 5603.6 5618.2 5630.8 5633.9 5641.5 4657.8 4773.7 4779.5 4782.2 4810.9 2962.3 2989.5 2998.0 2999.6 3004.2 5308.4 5319.4 5324.0 5326.7 5330.0 5560.6 5722.8 5754.5 5779.9 5822.4 5226.2 5237.7 5259.2 5266.0 5282.7 5496.0 5629.2 5631.0 5649.0 5659.0 5562.9 5564.6 5571.8 5579.0 5600.7 5271.5 5276.6 5278.5 5281.4 5296.9 4176.6 4265.6 4282.5 4299.3 4299.7 5344.6 5578.9 5587.9 5590.7 5605.8 5321.2 5331.6 5490.8 5494.0 5495.6 5422.5 5469.0 5478.6 5498.9 5510.0 5183.1 5324.3 5344.2 5363.6 5377.1 5497.4 5518.8 5527.7 5548.4 5562.6 5381.7 5395.5 5396.4 5406.7 5414.8 09:33:05 INFO - PID 3425 | 09:33:05 INFO - PID 3425 | [#5] yui.html Cycles:180 Average:14672.21 Median:41882.98 stddev:17006.54 (40.6%) stddev-sans-first:17021.70 09:33:05 INFO - PID 3425 | Values: 660.0 661.2 730.3 752.7 764.7 10229.6 12520.2 13020.9 13143.9 13224.7 12599.2 12655.1 13110.2 13186.1 13195.1 874.6 888.2 890.4 891.0 891.1 648.5 660.0 854.9 858.5 860.6 905.4 907.4 912.4 913.0 921.6 911.6 912.5 912.8 913.9 929.7 492.0 495.8 658.8 663.4 666.9 11653.4 11674.2 11802.6 11824.5 12235.8 14688.8 14854.3 15666.5 15797.8 15798.7 10928.5 11121.1 11175.0 11342.4 11390.6 2885.2 2893.4 2898.4 2903.6 2904.7 63250.0 63775.4 63867.4 63883.0 64498.4 10149.1 10505.2 12400.6 12685.4 12823.9 19748.3 20030.5 20505.9 22198.6 22450.7 7465.3 7601.8 7602.2 7618.4 7642.2 3762.1 3772.6 3812.6 3851.0 3856.0 3510.3 3601.6 3601.9 3607.7 3612.8 725.2 730.9 736.5 737.1 737.2 566.5 566.8 574.3 575.0 577.9 9437.2 9474.6 9523.0 9599.2 9843.8 545.8 563.7 571.1 573.5 577.5 4228.1 4243.9 4273.7 4366.2 4371.7 56877.0 57611.1 58643.7 61800.4 62289.4 51657.0 51734.5 51855.7 52238.0 55175.4 46019.3 46321.0 48360.0 49262.0 49920.8 9525.2 9982.3 10187.1 10433.6 10503.9 25621.0 25651.5 25732.5 25799.4 25809.7 41725.8 42040.2 43284.4 43841.6 43888.0 13780.3 14048.2 14084.2 14201.4 14448.3 13672.5 13696.7 13878.5 14690.6 15262.2 13348.7 14099.0 14195.2 14376.6 14572.4 14358.7 14407.9 14471.1 14617.3 14769.6 13114.7 13176.8 13241.6 13336.7 13414.7 9444.6 9566.6 9841.2 10058.0 10272.1 10207.7 10515.6 10678.4 10785.6 10833.7 09:33:05 INFO - PID 3425 | -------- Summary: end -------- 09:33:05 INFO - PID 3425 | 09:33:06 INFO - TEST-INFO | 3425: exit 0 09:33:06 INFO - TEST-OK | dromaeo_css | took 1123195ms 09:33:06 INFO - TEST-START | kraken 09:33:06 INFO - operating with platform_type : linux_ 09:33:06 INFO - Initialising browser for kraken test... 09:33:06 INFO - TEST-INFO | started process 3748 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd4rjc1/profile http://localhost:35392/getInfo.html) 09:33:10 INFO - PID 3748 | __metrics Screen width/height:1600/1200 09:33:10 INFO - PID 3748 | colorDepth:24 09:33:10 INFO - PID 3748 | Browser inner width/height: 1024/697 09:33:10 INFO - PID 3748 | __metrics 09:33:11 INFO - PID 3748 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:33:11 INFO - PID 3748 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:33:12 INFO - TEST-INFO | 3748: exit 0 09:33:12 INFO - Browser initialized. 09:33:12 INFO - Running cycle 1/1 for kraken test... 09:33:12 INFO - TEST-INFO | started process 3840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd4rjc1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:25 INFO - PID 3840 | RSS: Main: 154611712 09:33:25 INFO - PID 3840 | 09:33:27 INFO - PID 3840 | Cycle 1(1): loaded http://localhost:35392/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35392/tests/kraken/driver.html?testName=audio-beat-detection) 09:33:28 INFO - PID 3840 | RSS: Main: 208760832 09:33:28 INFO - PID 3840 | 09:33:31 INFO - PID 3840 | Cycle 1(1): loaded http://localhost:35392/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35392/tests/kraken/driver.html?testName=audio-dft) 09:33:32 INFO - PID 3840 | RSS: Main: 188190720 09:33:32 INFO - PID 3840 | 09:33:35 INFO - PID 3840 | Cycle 1(1): loaded http://localhost:35392/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35392/tests/kraken/driver.html?testName=audio-fft) 09:33:35 INFO - PID 3840 | RSS: Main: 270671872 09:33:35 INFO - PID 3840 | 09:33:38 INFO - PID 3840 | Cycle 1(1): loaded http://localhost:35392/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35392/tests/kraken/driver.html?testName=audio-oscillator) 09:33:38 INFO - PID 3840 | RSS: Main: 180432896 09:33:38 INFO - PID 3840 | 09:33:40 INFO - PID 3840 | Cycle 1(1): loaded http://localhost:35392/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35392/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:33:41 INFO - PID 3840 | RSS: Main: 184664064 09:33:41 INFO - PID 3840 | 09:33:44 INFO - PID 3840 | Cycle 1(1): loaded http://localhost:35392/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35392/tests/kraken/driver.html?testName=imaging-darkroom) 09:33:45 INFO - PID 3840 | RSS: Main: 224657408 09:33:45 INFO - PID 3840 | 09:33:48 INFO - PID 3840 | Cycle 1(1): loaded http://localhost:35392/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35392/tests/kraken/driver.html?testName=imaging-desaturate) 09:33:49 INFO - PID 3840 | RSS: Main: 218537984 09:33:49 INFO - PID 3840 | 09:33:52 INFO - PID 3840 | Cycle 1(1): loaded http://localhost:35392/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35392/tests/kraken/driver.html?testName=json-parse-financial) 09:33:53 INFO - PID 3840 | RSS: Main: 221237248 09:33:53 INFO - PID 3840 | 09:33:54 INFO - PID 3840 | Cycle 1(1): loaded http://localhost:35392/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35392/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:33:55 INFO - PID 3840 | RSS: Main: 184639488 09:33:55 INFO - PID 3840 | 09:33:57 INFO - PID 3840 | Cycle 1(1): loaded http://localhost:35392/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35392/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:33:57 INFO - PID 3840 | RSS: Main: 192020480 09:33:57 INFO - PID 3840 | 09:33:59 INFO - PID 3840 | Cycle 1(1): loaded http://localhost:35392/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35392/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:34:00 INFO - PID 3840 | RSS: Main: 201244672 09:34:00 INFO - PID 3840 | 09:34:03 INFO - PID 3840 | Cycle 1(1): loaded http://localhost:35392/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:34:04 INFO - PID 3840 | RSS: Main: 209371136 09:34:04 INFO - PID 3840 | 09:34:07 INFO - PID 3840 | Cycle 1(1): loaded http://localhost:35392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:34:07 INFO - PID 3840 | RSS: Main: 206569472 09:34:07 INFO - PID 3840 | 09:34:09 INFO - PID 3840 | Cycle 1(1): loaded http://localhost:35392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35392/tests/kraken/driver.html?testName=ai-astar) 09:34:10 INFO - PID 3840 | RSS: Main: 275607552 09:34:10 INFO - PID 3840 | 09:34:10 INFO - PID 3840 | __start_tp_report 09:34:10 INFO - PID 3840 | _x_x_mozilla_page_load 09:34:10 INFO - PID 3840 | _x_x_mozilla_page_load_details 09:34:10 INFO - PID 3840 | |i|pagename|runs| 09:34:10 INFO - PID 3840 | |0;ai-astar;108;114;113;112;111;113;111;112;112;112 09:34:10 INFO - PID 3840 | |1;audio-beat-detection;152;126;126;168;130;126;130;125;162;125 09:34:10 INFO - PID 3840 | |2;audio-dft;163;163;163;163;164;164;164;165;165;164 09:34:10 INFO - PID 3840 | |3;audio-fft;74;75;75;119;83;75;75;75;95;76 09:34:10 INFO - PID 3840 | |4;audio-oscillator;84;84;114;84;84;86;102;89;91;109 09:34:10 INFO - PID 3840 | |5;imaging-gaussian-blur;114;114;114;114;114;114;113;114;114;113 09:34:10 INFO - PID 3840 | |6;imaging-darkroom;150;151;150;150;150;151;149;151;149;150 09:34:10 INFO - PID 3840 | |7;imaging-desaturate;96;104;94;105;94;94;95;94;94;94 09:34:10 INFO - PID 3840 | |8;json-parse-financial;55;55;54;54;56;54;54;54;58;55 09:34:10 INFO - PID 3840 | |9;json-stringify-tinderbox;57;58;57;57;57;57;57;57;57;57 09:34:10 INFO - PID 3840 | |10;stanford-crypto-aes;83;83;83;84;84;84;83;83;83;83 09:34:10 INFO - PID 3840 | |11;stanford-crypto-ccm;138;147;135;138;133;143;134;141;183;134 09:34:10 INFO - PID 3840 | |12;stanford-crypto-pbkdf2;198;198;202;195;193;197;194;193;195;196 09:34:10 INFO - PID 3840 | |13;stanford-crypto-sha256-iterative;71;71;71;72;74;71;73;74;72;70 09:34:10 INFO - PID 3840 | __end_tp_report 09:34:10 INFO - PID 3840 | __start_cc_report 09:34:10 INFO - PID 3840 | _x_x_mozilla_cycle_collect,1993 09:34:10 INFO - PID 3840 | __end_cc_report 09:34:10 INFO - PID 3840 | __startTimestamp1491755650043__endTimestamp 09:34:10 INFO - PID 3840 | 09:34:10 INFO - PID 3840 | ------- Summary: start ------- 09:34:10 INFO - PID 3840 | Number of tests: 14 09:34:10 INFO - PID 3840 | 09:34:10 INFO - PID 3840 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:1.62 (1.4%) stddev-sans-first:0.97 09:34:10 INFO - PID 3840 | Values: 108.0 114.0 113.0 112.0 111.0 113.0 111.0 112.0 112.0 112.0 09:34:10 INFO - PID 3840 | 09:34:10 INFO - PID 3840 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:130.00 stddev:16.87 (13.0%) stddev-sans-first:16.99 09:34:10 INFO - PID 3840 | Values: 152.0 126.0 126.0 168.0 130.0 126.0 130.0 125.0 162.0 125.0 09:34:10 INFO - PID 3840 | 09:34:10 INFO - PID 3840 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 09:34:10 INFO - PID 3840 | Values: 163.0 163.0 163.0 163.0 164.0 164.0 164.0 165.0 165.0 164.0 09:34:10 INFO - PID 3840 | 09:34:10 INFO - PID 3840 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.00 stddev:14.47 (19.3%) stddev-sans-first:15.04 09:34:10 INFO - PID 3840 | Values: 74.0 75.0 75.0 119.0 83.0 75.0 75.0 75.0 95.0 76.0 09:34:10 INFO - PID 3840 | 09:34:10 INFO - PID 3840 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:84.00 stddev:11.40 (13.6%) stddev-sans-first:11.65 09:34:10 INFO - PID 3840 | Values: 84.0 84.0 114.0 84.0 84.0 86.0 102.0 89.0 91.0 109.0 09:34:10 INFO - PID 3840 | 09:34:10 INFO - PID 3840 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:34:10 INFO - PID 3840 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 113.0 114.0 114.0 113.0 09:34:10 INFO - PID 3840 | 09:34:10 INFO - PID 3840 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 09:34:10 INFO - PID 3840 | Values: 150.0 151.0 150.0 150.0 150.0 151.0 149.0 151.0 149.0 150.0 09:34:10 INFO - PID 3840 | 09:34:10 INFO - PID 3840 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:94.00 stddev:4.33 (4.6%) stddev-sans-first:4.59 09:34:10 INFO - PID 3840 | Values: 96.0 104.0 94.0 105.0 94.0 94.0 95.0 94.0 94.0 94.0 09:34:10 INFO - PID 3840 | 09:34:10 INFO - PID 3840 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.29 (2.3%) stddev-sans-first:1.36 09:34:10 INFO - PID 3840 | Values: 55.0 55.0 54.0 54.0 56.0 54.0 54.0 54.0 58.0 55.0 09:34:10 INFO - PID 3840 | 09:34:10 INFO - PID 3840 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 09:34:10 INFO - PID 3840 | Values: 57.0 58.0 57.0 57.0 57.0 57.0 57.0 57.0 57.0 57.0 09:34:10 INFO - PID 3840 | 09:34:10 INFO - PID 3840 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 09:34:10 INFO - PID 3840 | Values: 83.0 83.0 83.0 84.0 84.0 84.0 83.0 83.0 83.0 83.0 09:34:10 INFO - PID 3840 | 09:34:10 INFO - PID 3840 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:139.50 stddev:14.89 (10.7%) stddev-sans-first:15.70 09:34:10 INFO - PID 3840 | Values: 138.0 147.0 135.0 138.0 133.0 143.0 134.0 141.0 183.0 134.0 09:34:10 INFO - PID 3840 | 09:34:10 INFO - PID 3840 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.10 Median:196.50 stddev:2.77 (1.4%) stddev-sans-first:2.85 09:34:10 INFO - PID 3840 | Values: 198.0 198.0 202.0 195.0 193.0 197.0 194.0 193.0 195.0 196.0 09:34:10 INFO - PID 3840 | 09:34:10 INFO - PID 3840 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.00 stddev:1.37 (1.9%) stddev-sans-first:1.41 09:34:10 INFO - PID 3840 | Values: 71.0 71.0 71.0 72.0 74.0 71.0 73.0 74.0 72.0 70.0 09:34:10 INFO - PID 3840 | -------- Summary: end -------- 09:34:10 INFO - PID 3840 | 09:34:11 INFO - TEST-INFO | 3840: exit 0 09:34:11 INFO - TEST-OK | kraken | took 65071ms 09:34:11 INFO - SUITE-END | took 1188s 09:34:11 INFO - Completed test suite (00:19:48) 09:34:11 INFO - javascript benchmark 09:34:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6662.532259073364, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2678.178838389895, 2708.2281549758322, 2739.109789318472, 2739.123480486245, 2746.491898998685, 5103.106956282654, 5197.740112994354, 5243.501867322608, 5259.289995850559, 5315.0, 5174.042802081617, 5186.611004174692, 5215.243789650498, 5218.556422704065, 5225.346831646044, 4621.329907163467, 4662.0, 4669.696469729473, 4693.601043911254, 4718.646101542381, 4687.531246875302, 4711.929321060187, 4724.291356296566, 4726.10204061229, 4727.432708075019, 4705.670603057787, 4714.528547145293, 4716.811327546911, 4718.41019872516, 4721.079389519045, 4713.198756211418, 4717.2924061390895, 4740.146773580754, 4742.5731684148595, 4780.784864681063, 4710.3405523226775, 4715.528447155291, 4715.858524244278, 4717.622590192776, 4763.071201115784, 5090.109230884617, 5182.041322355376, 5189.40321862983, 5220.582353411718, 5282.154855223146, 5535.0, 5644.6330988485615, 5708.1723150143, 5711.371749107595, 5731.168980497846, 5704.515116215127, 5716.3426205986425, 5718.342390625048, 5723.971380143073, 5729.885402291972, 5260.684358938476, 5302.522772950453, 5308.124159513637, 5313.654612450178, 5357.892842143213, 5688.374278829326, 5760.308762948473, 5761.53907687384, 5764.077747560454, 5817.76728930838, 5538.141588053858, 5547.944520554743, 5559.471850174227, 5564.248826408464, 5619.185218143346, 5648.717564121777, 5650.745716442688, 5653.236813030188, 5653.830385088454, 5657.2928383952, 5459.099248623933, 5484.698341591251, 5541.695206763586, 5591.888162236733, 5597.692126932976, 5563.916541251884, 5578.135389014628, 5657.547396208293, 5662.0, 5666.0, 4745.501722319176, 4764.356811830427, 4764.380630518011, 4768.666193366431, 4803.615710743132, 3997.060690737674, 4064.1262128642484, 4082.346824508124, 4083.693722970789, 4101.179764047202, 4743.051389722069, 4745.549172828576, 4785.569298763058, 4813.15769740294, 4815.253635686474, 5613.158026296088, 5614.101743721067, 5615.606907516435, 5618.185363122325, 5618.325800903836, 4674.766261686902, 4718.669693121448, 4728.3143944127905, 4734.147853386355, 4776.307435421844, 4898.314236006961, 4969.751512424436, 5020.47285035066, 5084.5932325414615, 5090.643654944119, 5300.9734951325, 5302.602304827076, 5304.124819404755, 5305.2307415423775, 5335.573154147736, 5623.606347555632, 5680.4319568042865, 5699.373068962328, 5716.628419152742, 5758.856028599151, 5185.248139019745, 5259.55293800016, 5265.1049321614655, 5290.735463226746, 5316.255724198692, 5600.579956503197, 5605.0, 5607.43925607436, 5622.269105016322, 5662.094064949753, 5515.172724091419, 5629.802956896489, 5704.572157088318, 5712.285964254468, 5715.457031581993, 5431.185322201702, 5438.918416223839, 5504.779808807763, 5507.146392309199, 5513.724313784375, 5467.0, 5476.151196564539, 5483.917741233964, 5485.862853428696, 5487.670739755627, 5347.625666203328, 5360.517553420211, 5370.113931201308, 5404.189371594135, 5405.78376864921, 5351.892962140813, 5453.7818487260065, 5485.862853428696, 5495.120780675073, 5570.470805273492, 5415.187721841755, 5417.539509141767, 5422.593305502024, 5430.891382172255, 5433.212184233343], "value": 5122.857709929251, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.6595770199497, 724.3661795928563, 735.1252010107972, 1040.2977989856845, 1056.857324261225, 26409.60385594215, 27018.86490567547, 27019.189424317254, 27081.72918270819, 27093.322666933338, 32845.178870528245, 33383.49924751131, 33423.832880835624, 33471.49792753105, 33471.497927531105, 7280.526765760222, 7443.925560744377, 7445.069366329209, 7446.9627651861665, 7450.0, 5578.944210557883, 5708.372079071299, 7315.524490908074, 7455.4781165318445, 7457.701691932316, 7249.238829922861, 7379.1145062592295, 7406.148292946299, 7414.0, 7417.184109747924, 7405.148407933076, 7466.738664146783, 7470.290322419389, 7474.364679002291, 7479.887801682979, 5486.1222204447495, 5614.1859430382365, 7117.608531530764, 7240.601766902818, 7340.045794046793, 32781.39404665485, 33178.0, 33195.0, 33195.33609327824, 33230.83384583086, 3000.5949196858364, 3059.021113243763, 3064.908052758421, 3065.586145870301, 3067.9846600766855, 25031.374215644573, 25076.749232507806, 25186.496270074495, 25269.62095568568, 25282.494350112895, 3229.2411283348392, 3231.4021905947475, 3249.301400198945, 3251.837408129608, 3254.6908043735807, 137763.31118344344, 138113.0, 138197.3090134553, 138623.0, 138700.0, 41309.586904131174, 41341.0, 41360.0, 41380.1723965525, 41391.58608413937, 43124.0, 43125.56874431216, 43155.568444315155, 43282.0, 43284.78357608192, 11550.075993920465, 11584.36286004261, 11590.594329198437, 11614.535418583162, 11727.706807329714, 9195.356325057315, 9209.815803684023, 9248.30637702175, 9263.397879137834, 9302.627894884128, 10455.111315538112, 10588.311759735592, 11889.227200231957, 11906.583269585522, 12196.146269761031, 4663.906721865612, 4713.905721885543, 4742.264948932852, 4811.879703007453, 4839.41926968766, 857.1557016338901, 879.7712594725417, 888.9555522223862, 898.3442087276325, 904.882365292521, 20425.89787051055, 20987.265445709327, 21281.78718212798, 21467.67798483024, 21755.238566650092, 960.0, 965.8502932045544, 968.0561452583815, 970.6117552978724, 991.0386924683046, 11343.739614798798, 11366.374849383197, 11387.658370248906, 11407.885921140849, 11502.48238829238, 182947.0, 184026.0, 184326.0, 184522.0, 184630.0, 40766.59233407687, 40949.59050409458, 40963.7951810245, 40991.59008409937, 41012.79493602513, 1189.1299302225614, 1212.4968138222716, 1229.20101933742, 1232.2729589542214, 1238.746057058301, 19588.412347629594, 19733.0, 20389.79610203879, 21080.156793728693, 21411.35765927025, 30330.696693032787, 30330.848345759012, 30368.240793979443, 30386.69613303927, 30389.696103039572, 173543.0, 173680.0, 173745.0, 173816.1309193446, 173979.0, 29538.704612953596, 29688.257793555335, 30043.69956300409, 30094.0, 30217.244568885955, 31395.686043139278, 31735.682643173273, 37192.0, 37196.25607487889, 37442.43836342402, 27916.581251281652, 28213.57679634766, 28490.0, 28619.713802861705, 29440.705592943796, 28001.299967500974, 28213.717862821108, 28959.85520072386, 29010.709892900803, 29235.85382073076, 31139.221519461287, 31149.377012460078, 31165.220869478446, 31211.687883120878, 31303.686963130076, 26617.33456663599, 27098.864505677346, 27166.1850144496, 27292.590611141244, 27678.861605691844, 20074.18961345442, 20617.69073463929, 20741.27405540799, 20939.685904711747, 20977.265795697076], "value": 14397.433355551892, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.46737838674545, 410.6551590418709, 420.6109348852312, 421.9029623186667, 424.74939785526544, 16857.91571042146, 17579.38472153475, 18256.0, 18350.265989360425, 18356.632867342647, 15305.311260993254, 15516.456924007662, 15883.761743573827, 17270.309187632512, 17635.470935871945, 5574.052411090104, 5586.10622300432, 5685.374608793029, 5763.279590051244, 5767.855803604902, 5546.084895992157, 5642.407547207546, 5645.040343141676, 5645.717714114298, 5649.209110724501, 5443.755031023594, 5607.523360514341, 5621.072523033715, 5622.662640241578, 5661.943380566183, 5670.631408958405, 5729.914051289234, 5732.197492351032, 5735.426457354273, 5739.598228124012, 5022.773975171126, 5128.640995130342, 5167.354080739908, 5171.637985341028, 5184.326037615086, 22074.22740204085, 22401.439964000867, 22440.77559224403, 22502.54994900109, 22532.21137260188, 1647.1599484263113, 1666.316810107862, 1698.79614446266, 1700.2773821125973, 1704.1053446940455, 14688.265586720729, 14715.11709297435, 14945.40218391263, 14980.400783968627, 15032.17323047232, 2066.245820275604, 2145.5195914818723, 2153.935381938544, 2161.848670593059, 2164.632012557869, 88075.0, 89333.0, 89726.5513672434, 90930.5453472735, 91290.0, 10627.52176152075, 10726.19553533488, 10764.56941722338, 10903.727406814893, 11109.111271098292, 14993.32530036151, 15016.924915375572, 15038.699226015637, 15043.398264069534, 15048.699026019418, 6967.651617419108, 7038.542494737826, 7193.784186474414, 7245.275472452818, 7256.818579535554, 6233.937660623335, 6239.1577137085915, 6391.42477177047, 6395.264544577433, 6430.646314452656, 6783.253842077367, 6932.584044957319, 6957.0, 6962.2341542430295, 6986.615736134459, 2016.8386529077638, 2031.3702752146883, 2037.2258541754038, 2048.5185981294385, 2152.3758110148196, 825.5913322905201, 861.6079683743882, 870.7083127152475, 896.3994123936848, 899.2491269789668, 16880.155992200587, 17131.74302385465, 17383.217755201047, 17509.737353939447, 17959.371422000168, 869.7912500999714, 872.1278721278721, 872.9432586881833, 880.2341962492544, 899.0445780427674, 9473.857892131624, 9768.902310976799, 9866.260030497742, 9871.851922221173, 9877.456739879231, 454007.0, 471665.0, 473658.0, 485686.0, 487363.0, 88021.9972503437, 89457.0, 90642.09357906337, 91125.54437227904, 92780.53609731908, 1043.8382050781988, 1056.0653821368144, 1093.2565855218368, 1121.876593574706, 1127.3799410324289, 17461.30154793845, 17727.202275897875, 18167.27330906749, 18192.090395479907, 18389.17248723784, 43115.353269701605, 43928.34107488454, 44054.55945440633, 44111.33832992444, 44160.0, 56378.43621563896, 57204.0, 57356.71321643365, 58241.12638310344, 58316.0, 7794.766157015299, 7905.367570594453, 7991.200879911962, 8186.181381861767, 8263.95868020656, 12650.367481625697, 13063.150895191782, 13325.66685832862, 13560.457581697015, 13569.253691047088, 10807.72980675458, 11011.28426652265, 11106.167037472384, 11183.888161118284, 11528.365939873387, 10166.644167454104, 10211.387316761018, 11087.72280692989, 11150.609728659458, 11243.775124497628, 11168.609098681507, 11587.0, 11617.709557261136, 11899.762004759683, 12182.695432614255, 8039.437239393186, 8121.472104313437, 8141.430099893188, 8459.365547584079, 8631.784205394664, 10577.9471102644, 10582.49254928363, 10775.461226938778, 11650.475728592402, 11728.061755059403], "value": 9046.685078716604, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1110.6001839337832, 1180.7284324605341, 1244.8879600835924, 1254.924704517729, 1256.246252248651, 8519.53142577158, 9852.113309802126, 10173.847392289103, 10184.898151018479, 10187.643432479865, 9923.851142232854, 10020.69937901864, 10030.348027378233, 10034.949825250864, 10038.397696138218, 1910.7516022917002, 2172.9674054889188, 2216.1689366487567, 2217.2128894242555, 2219.9556008879813, 1951.9902400487977, 2195.8572692774997, 2275.533515629292, 2278.8632682039047, 2279.4415368234722, 2222.977770222293, 2234.497238121418, 2244.539869326792, 2245.236619549353, 2247.1573160064977, 2154.859934104286, 2160.5030842906062, 2162.4593851537115, 2167.6856855755987, 2167.8590891592, 2172.0985790896757, 2189.4526368407896, 2199.1533259694975, 2224.0, 2226.3877433705698, 9753.268504862093, 9821.607135714634, 9829.213662907021, 9837.950810245975, 9839.409635421825, 5400.648957817769, 5572.192032155314, 5585.106382978704, 5585.553155747531, 5587.189857470644, 3310.6358300586917, 3458.8616455342008, 3484.982575087108, 3516.595591506984, 3518.894433167009, 1032.0608246495653, 1046.3408052926684, 1058.1111866032493, 1074.8011617850646, 1078.1967434261446, 14377.64055898611, 14393.28033598316, 14395.78406323906, 14396.568102956928, 14412.351444184931, 4822.228443449101, 4886.364772579613, 4958.330625365529, 5128.487151284841, 5157.63896527247, 12002.939985300192, 12013.699657508632, 12017.939910300393, 12044.698882527831, 12047.578334758242, 5553.750081246354, 5553.805616803393, 5555.8888822224135, 5559.11054231321, 5561.165825126263, 4909.926351104737, 4920.778564964585, 4943.530364615356, 4945.579625731853, 5027.874303142377, 3708.7589306694977, 3817.034227372905, 3830.367989281737, 3845.8653947111716, 3886.3198940185353, 1079.6868908016745, 1082.274875833178, 1106.2145876427664, 1109.0351394287022, 1120.7534342444649, 677.8440958579554, 706.5160365149889, 707.1620130145793, 721.6103304215769, 724.427702115323, 5147.0, 5245.396779370345, 5267.367915850123, 5339.332583427072, 5431.8098866539485, 818.7953011747063, 833.6790335720669, 844.6494704697482, 852.2968550945495, 856.7601071699934, 3666.211764470652, 3814.1036856338737, 3853.5761066282685, 3871.922561548753, 3915.3735402335487, 12447.93776031132, 12848.229106253655, 12943.805842912363, 13063.869361306455, 13066.477340906258, 12645.0, 12924.095313327976, 12961.481540738265, 13120.015998800129, 13201.339933003312, 9301.0, 9351.719448416557, 9436.480993545283, 9447.905520944703, 9455.858162127573, 5753.510951569164, 5874.353821079763, 5893.70531473416, 5906.26171728534, 6065.302490213682, 11413.08695304357, 11676.766464670829, 11721.765564688829, 11882.643520694393, 11931.940340298243, 11717.707057323634, 12039.819402708792, 12074.335911524951, 12229.93885030569, 12245.816312755138, 7627.199144090013, 7898.3681305496575, 7904.446688731734, 7917.524948503108, 7920.326772224425, 9277.118673725985, 9359.906400935903, 9367.110124538158, 9367.250619950251, 9367.484788336707, 7960.761177164694, 8076.555789431402, 8099.757007289791, 8120.634571444181, 8377.623006964579, 7892.408069394934, 7949.205079492004, 7990.760277191694, 8031.0, 8046.0747014091785, 6754.696038678369, 6859.416949559343, 6869.0, 6870.038194652652, 6873.725050997904, 5376.1398176291605, 5376.327959005124, 5477.178423236546, 5529.917051244154, 5632.88734225305, 5359.088954877758, 5418.160185171305, 5481.766602514403, 5502.064649009758, 5579.916301255404], "value": 4719.964654460468, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.19331181433137, 378.26238834273175, 380.0441888650044, 381.66032231314125, 384.46751249519417, 5033.697978121306, 5163.612729045318, 5264.8157314494, 5275.1296036154035, 5320.733963301834, 4990.825321113762, 5077.441481437039, 5092.694438333702, 5129.204973229146, 5154.74226288685, 4058.706830640693, 4074.592540745924, 4078.6125318094732, 4079.5920407959115, 4085.7957102144924, 3994.9600503995025, 4069.308217603, 4076.9796151019204, 4084.244414783275, 4088.672906167514, 4032.153247817947, 4051.858184963527, 4052.3111071117983, 4060.675145988314, 4064.695147863907, 4040.1919616076757, 4044.716869819114, 4055.4930633670792, 4057.7768222747736, 4066.7966601670096, 3665.3402387570227, 3676.1728611062563, 3681.9631803682155, 3683.0055884910926, 3685.63143685632, 4873.610111191097, 5013.097642424362, 5029.673071250357, 5048.570871475929, 5081.729567608098, 4800.087983283165, 4802.687825291345, 4802.807887684488, 4804.855854324376, 4814.374131362901, 5505.3393592768725, 5511.944880551223, 5513.228148059275, 5523.0, 5546.861328466821, 4030.717849750519, 4120.114175452262, 4135.77253251071, 4143.3370660694145, 4162.958370416287, 5718.799052199043, 5722.2561067061015, 5735.4551317624755, 5743.712814359265, 5753.942460575383, 4244.957550424518, 4260.147970405931, 4261.126469073833, 4266.274733295348, 4282.164977829293, 4154.688398370074, 4301.956980430155, 4327.545607711145, 4340.913181736348, 4349.19539885116, 4754.358161648202, 4775.235962246094, 4777.235642297216, 4785.1625965455905, 4785.353977213102, 5445.50990410865, 5451.209574611659, 5463.781448742086, 5463.808766693226, 5489.835304940858, 1374.4090041282345, 1405.444849284527, 1470.1326217531707, 1480.452232673896, 1501.0768377447791, 1026.1841835740604, 1061.766411389493, 1062.4953147254992, 1064.1539975719322, 1066.4454483668603, 4776.641751868554, 4806.735629540339, 4808.3989501312335, 4809.591184749265, 4813.975930120327, 5603.551715862721, 5618.213450116987, 5630.8029218977135, 5633.943660563424, 5641.5204707600315, 4657.813687452464, 4773.689710168828, 4779.474257831635, 4782.163121453732, 4810.855674329776, 2962.2890506278336, 2989.4768415527196, 2997.961386257366, 2999.5950546675917, 3004.173852190665, 5308.442613525602, 5319.441458646864, 5324.0150572144275, 5326.6537675050995, 5329.973350133225, 5560.610757246954, 5722.799702010409, 5754.4533269339345, 5779.901818654443, 5822.388649191774, 5226.189940559219, 5237.6857388556045, 5259.184826351921, 5265.97206606203, 5282.656627319212, 5495.972520137374, 5629.211910332639, 5630.971845140748, 5648.971755141362, 5658.953093677518, 5562.888742225214, 5564.554835613222, 5571.804986825442, 5578.972105139448, 5600.691961942132, 5271.499207575274, 5276.604254680991, 5278.498542638443, 5281.441974617574, 5296.947030529799, 4176.561461046668, 4265.573442655709, 4282.507511636201, 4299.333603291495, 4299.677524185761, 5344.625876188629, 5578.856334451509, 5587.860303492445, 5590.748416321194, 5605.794754127719, 5321.228421878728, 5331.573474121983, 5490.780368785204, 5494.0, 5495.5878309127775, 5422.5119739223655, 5469.0, 5478.589105817, 5498.890022199454, 5510.0, 5183.144781111075, 5324.281222034976, 5344.198370244494, 5363.624546281723, 5377.08589539787, 5497.422770609029, 5518.806841760519, 5527.695976721319, 5548.389677135431, 5562.582806289463, 5381.650192737459, 5395.541378982831, 5396.379416367011, 5406.7296635167295, 5414.83755487336], "value": 4194.679113868493, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.9802005939821, 661.1702313596436, 730.2551397574474, 752.65001774175, 764.7055883484859, 10229.641962531314, 12520.24878507289, 13020.93489532551, 13143.868561314384, 13224.7355052899, 12599.244045357262, 12655.114142010063, 13110.21338719675, 13186.142900711448, 13195.076344655878, 874.6151693254964, 888.1739981816908, 890.4345740454826, 891.0154279521133, 891.1266958380791, 648.4812150279781, 659.9868002639944, 854.8674955381925, 858.5449711652834, 860.604122103833, 905.3933864310927, 907.3875134284365, 912.3522299167565, 913.0002647101413, 921.5898924978387, 911.5761171055491, 912.5391677203037, 912.8037471943564, 913.9086091390874, 929.6746138851415, 492.0478873380021, 495.7669895149274, 658.8122385120217, 663.359857737281, 666.8866292730247, 11653.41732913351, 11674.241174323643, 11802.645920622395, 11824.467898944482, 12235.816462753066, 14688.779668304984, 14854.257287135708, 15666.53000409978, 15797.763033554505, 15798.736101111883, 10928.453577321103, 11121.110311175087, 11175.0, 11342.432878356049, 11390.60132895353, 2885.2354126156583, 2893.392387598607, 2898.376848977459, 2903.637045369329, 2904.7385735283924, 63250.0, 63775.36224637741, 63867.36132638661, 63883.0, 64498.35501644971, 10149.137323327599, 10505.159587233004, 12400.62798116058, 12685.365731713377, 12823.871761282455, 19748.30880919161, 20030.49923751918, 20505.89747051255, 22198.55602887933, 22450.663240051414, 7465.2534746526, 7601.847963040819, 7602.239776022464, 7618.352440042659, 7642.19756925526, 3762.097096696828, 3772.6227377262603, 3812.6377994090517, 3851.017990412483, 3856.0, 3510.280392519527, 3601.6218297078954, 3601.9099522511624, 3607.7294202934886, 3612.8012959286966, 725.2312548698396, 730.8501757139774, 736.4697417859132, 737.0896942276285, 737.2259127915667, 566.4929887750523, 566.8384510414512, 574.299354787159, 574.9885002299931, 577.9104238842986, 9437.150656440954, 9474.621015159455, 9523.0, 9599.184069354043, 9843.75390615226, 545.7953267524679, 563.650536667269, 571.08056029792, 573.4552175433272, 577.4860374266906, 4228.099849816154, 4243.872683819491, 4273.722208056466, 4366.19225443294, 4371.693981421334, 56877.0, 57611.13583296254, 58643.70678146582, 61800.381996179465, 62289.377106229265, 51657.0, 51734.48265517372, 51855.740721296905, 52238.0, 55175.44824551703, 46019.30971035437, 46321.0, 48360.03279934452, 49262.0147597046, 49920.750396247786, 9525.237980961645, 9982.301238913205, 10187.13409360183, 10433.634822781167, 10503.894961050291, 25621.0, 25651.486970260863, 25732.485350292514, 25799.355016124748, 25809.741902580732, 41725.79137104295, 42040.1591968165, 43284.35073473837, 43841.56158438375, 43888.0, 13780.310984450536, 14048.157110573398, 14084.22536760488, 14201.360938757574, 14448.277586120863, 13672.52146174879, 13696.65758356049, 13878.514252001132, 14690.63273418173, 15262.23688815577, 13348.733025339245, 14099.0, 14195.219262940223, 14376.640583985483, 14572.417103315749, 14358.712825743636, 14407.85592144107, 14471.059381140612, 14617.269136543344, 14769.630759231106, 13114.73770524565, 13176.80234796498, 13241.602751917459, 13336.733265334446, 13414.664633384244, 9444.622215111593, 9566.61733530651, 9841.212702983887, 10058.044485774133, 10272.075513203847, 10207.693769186937, 10515.57937682484, 10678.412687302272, 10785.62250321235, 10833.67498975032], "value": 6620.314785645313, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 113.0, 112.0, 111.0, 113.0, 111.0, 112.0, 112.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 126.0, 168.0, 130.0, 126.0, 130.0, 125.0, 162.0, 125.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 164.0, 164.0, 164.0, 165.0, 165.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 119.0, 83.0, 75.0, 75.0, 75.0, 95.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 84.0, 84.0, 86.0, 102.0, 89.0, 91.0, 109.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 150.0, 150.0, 151.0, 149.0, 151.0, 149.0, 150.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 104.0, 94.0, 105.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 56.0, 54.0, 54.0, 54.0, 58.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 84.0, 84.0, 84.0, 83.0, 83.0, 83.0, 83.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 147.0, 135.0, 138.0, 133.0, 143.0, 134.0, 141.0, 183.0, 134.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 198.0, 202.0, 195.0, 193.0, 197.0, 194.0, 193.0, 195.0, 196.0], "value": 196.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 71.0, 72.0, 74.0, 71.0, 73.0, 74.0, 72.0, 70.0], "value": 71.9, "unit": "score"}]}]} 09:34:11 INFO - Return code: 0 09:34:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:34:11 ERROR - # TBPL SUCCESS # 09:34:11 INFO - Running post-action listener: _resource_record_post_action 09:34:11 INFO - [mozharness: 2017-04-09 16:34:11.860541Z] Finished run-tests step (success) 09:34:11 INFO - Running post-run listener: _resource_record_post_run 09:34:11 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 7323648; Write bytes: 365248512; Read time: 1132; Write time: 239776 09:34:11 INFO - TinderboxPrint: CPU usage
13.0% 09:34:11 INFO - TinderboxPrint: I/O read bytes / time
7,323,648 / 1,132 09:34:11 INFO - TinderboxPrint: I/O write bytes / time
365,248,512 / 239,776 09:34:11 INFO - TinderboxPrint: CPU idle
8,359.8 (87.0%) 09:34:11 INFO - TinderboxPrint: CPU user
1,202.5 (12.5%) 09:34:11 INFO - TinderboxPrint: Swap in / out
0 / 0 09:34:11 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 109826048; Read time: 0; Write time: 106804 09:34:11 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 7323648; Write bytes: 255422464; Read time: 1132; Write time: 132972 09:34:12 INFO - Running post-run listener: _upload_blobber_files 09:34:12 INFO - Blob upload gear active. 09:34:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:34:12 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 09:34:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:34:13 INFO - (blobuploader) - INFO - Open directory for files ... 09:34:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:34:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:34:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:17 INFO - (blobuploader) - INFO - Done attempting. 09:34:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:34:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:34:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:18 INFO - (blobuploader) - INFO - Done attempting. 09:34:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:34:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:34:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:19 INFO - (blobuploader) - INFO - Done attempting. 09:34:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:34:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:34:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:34:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:34:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:34:20 INFO - (blobuploader) - INFO - Done attempting. 09:34:20 INFO - (blobuploader) - INFO - Iteration through files over. 09:34:20 INFO - Return code: 0 09:34:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:34:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:34:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/045cb29800fa4e5a0edff2051f4014393b7369e3632283fe6a395e6d9b9b925374add651823b27f430e64701435af4ae57b8564b70c5ac67570a78fe2f0abd99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d89627e5bf47b05e24c06b62df6828b5306b1ee6fc71a77168154eb37a448ab1543cb9ed5be79c6a71595a7de6999f0d595c7841b7b401e1f3c8aaca4c703408", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7dff321b26961aa8ab2f7e6c6b7395deadb1177656dd7b68545376e1babdad6c2107ab331a73800ed5fedcc7da496ad2efc81a089364c2ba511eaaefeb5cf6b8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e4ecb1c1c053d4cc0fe7789a86bf85da5181a171a2ebf3e06369222f26317600c0e908b787b435605c8791e9c1bb0ccf8d29c4ef5fc57f291d02c41b4f44f03"} 09:34:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:34:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:34:20 INFO - Contents: 09:34:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/045cb29800fa4e5a0edff2051f4014393b7369e3632283fe6a395e6d9b9b925374add651823b27f430e64701435af4ae57b8564b70c5ac67570a78fe2f0abd99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d89627e5bf47b05e24c06b62df6828b5306b1ee6fc71a77168154eb37a448ab1543cb9ed5be79c6a71595a7de6999f0d595c7841b7b401e1f3c8aaca4c703408", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7dff321b26961aa8ab2f7e6c6b7395deadb1177656dd7b68545376e1babdad6c2107ab331a73800ed5fedcc7da496ad2efc81a089364c2ba511eaaefeb5cf6b8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e4ecb1c1c053d4cc0fe7789a86bf85da5181a171a2ebf3e06369222f26317600c0e908b787b435605c8791e9c1bb0ccf8d29c4ef5fc57f291d02c41b4f44f03"} 09:34:20 INFO - Running post-run listener: copy_logs_to_upload_dir 09:34:20 INFO - Copying logs to upload dir... 09:34:20 INFO - mkdir: /builds/slave/test/build/upload/logs 09:34:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.978686 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-04-09 09:34:20.352376) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 09:34:20.356661) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/045cb29800fa4e5a0edff2051f4014393b7369e3632283fe6a395e6d9b9b925374add651823b27f430e64701435af4ae57b8564b70c5ac67570a78fe2f0abd99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d89627e5bf47b05e24c06b62df6828b5306b1ee6fc71a77168154eb37a448ab1543cb9ed5be79c6a71595a7de6999f0d595c7841b7b401e1f3c8aaca4c703408", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7dff321b26961aa8ab2f7e6c6b7395deadb1177656dd7b68545376e1babdad6c2107ab331a73800ed5fedcc7da496ad2efc81a089364c2ba511eaaefeb5cf6b8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e4ecb1c1c053d4cc0fe7789a86bf85da5181a171a2ebf3e06369222f26317600c0e908b787b435605c8791e9c1bb0ccf8d29c4ef5fc57f291d02c41b4f44f03"} build_url:https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/B5pZDEnNSu-Yffq7bio7WQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/045cb29800fa4e5a0edff2051f4014393b7369e3632283fe6a395e6d9b9b925374add651823b27f430e64701435af4ae57b8564b70c5ac67570a78fe2f0abd99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d89627e5bf47b05e24c06b62df6828b5306b1ee6fc71a77168154eb37a448ab1543cb9ed5be79c6a71595a7de6999f0d595c7841b7b401e1f3c8aaca4c703408", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7dff321b26961aa8ab2f7e6c6b7395deadb1177656dd7b68545376e1babdad6c2107ab331a73800ed5fedcc7da496ad2efc81a089364c2ba511eaaefeb5cf6b8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e4ecb1c1c053d4cc0fe7789a86bf85da5181a171a2ebf3e06369222f26317600c0e908b787b435605c8791e9c1bb0ccf8d29c4ef5fc57f291d02c41b4f44f03"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 09:34:20.387964) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 09:34:20.394321) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1491750726.766054-1593795961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004316 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 09:34:20.472236) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 09:34:20.472579) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 09:34:20.472880) ========= ========= Total master_lag: 0.28 =========