builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1474568589.41 results: success (0) buildid: 20160922103000 builduid: de2a861d9b864c779dceccffa2978081 revision: 46645a6bb7dc88603beb3ce3e55fd63a1d2fc75b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 11:23:09.408505) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 11:23:09.409085) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 11:23:09.409403) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 11:23:09.444895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 11:23:09.445193) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 11:23: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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2016-09-22 11:23:10 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137158 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 11:23:09.598648) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 11:23:09.598976) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019580 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 11:23:09.648378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 11:23:09.648739) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 46645a6bb7dc88603beb3ce3e55fd63a1d2fc75b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 46645a6bb7dc88603beb3ce3e55fd63a1d2fc75b --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=e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 11:23:10,184 truncating revision to first 12 chars 2016-09-22 11:23:10,184 Setting DEBUG logging. 2016-09-22 11:23:10,184 attempt 1/10 2016-09-22 11:23:10,184 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/46645a6bb7dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 11:23:11,437 unpacking tar archive at: fx-team-46645a6bb7dc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.644196 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 11:23:11.307282) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 11:23:11.307626) ========= script_repo_revision: 46645a6bb7dc88603beb3ce3e55fd63a1d2fc75b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 11:23:11.308410) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 11:23:11.308783) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 11:23:11.319655) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-22 11:23:11.320093) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:23:11 INFO - MultiFileLogger online at 20160922 11:23:11 in /builds/slave/test 11:23:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:23:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:23:11 INFO - {'append_to_log': False, 11:23:11 INFO - 'base_work_dir': '/builds/slave/test', 11:23:11 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:23:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:23:11 INFO - 'branch': 'Fx-Team-Non-PGO', 11:23:11 INFO - 'buildbot_json_path': 'buildprops.json', 11:23:11 INFO - 'config_files': ('talos/linux_config.py',), 11:23:11 INFO - 'default_actions': ('clobber', 11:23:11 INFO - 'read-buildbot-config', 11:23:11 INFO - 'download-and-extract', 11:23:11 INFO - 'populate-webroot', 11:23:11 INFO - 'create-virtualenv', 11:23:11 INFO - 'install', 11:23:11 INFO - 'run-tests'), 11:23:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:23:11 INFO - 'download_minidump_stackwalk': True, 11:23:11 INFO - 'download_symbols': 'ondemand', 11:23:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:23:11 INFO - 'tooltool.py': '/tools/tooltool.py', 11:23:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:23:11 INFO - '/tools/misc-python/virtualenv.py')}, 11:23:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:23:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:23:11 INFO - 'installer_path': 'installer.exe', 11:23:11 INFO - 'log_level': 'info', 11:23:11 INFO - 'log_name': 'talos', 11:23:11 INFO - 'log_to_console': True, 11:23:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:23:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:23:11 INFO - 'opt_config_files': (), 11:23:11 INFO - 'pip_index': False, 11:23:11 INFO - 'sps_profile': False, 11:23:11 INFO - 'sps_profile_interval': 0, 11:23:11 INFO - 'suite': 'dromaeojs', 11:23:11 INFO - 'system_bits': '32', 11:23:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:23:11 INFO - 'title': 'talos-linux64-ix-006', 11:23:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:23:11 INFO - 'use_talos_json': True, 11:23:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:23:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:23:11 INFO - 'work_dir': 'build'} 11:23:11 INFO - [mozharness: 2016-09-22 18:23:11.951094Z] Running clobber step. 11:23:11 INFO - Running pre-action listener: _resource_record_pre_action 11:23:11 INFO - Running main action method: clobber 11:23:11 INFO - rmtree: /builds/slave/test/build 11:23:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:23:12 INFO - Running post-action listener: _resource_record_post_action 11:23:12 INFO - [mozharness: 2016-09-22 18:23:12.912549Z] Finished clobber step (success) 11:23:12 INFO - [mozharness: 2016-09-22 18:23:12.912650Z] Running read-buildbot-config step. 11:23:12 INFO - Running pre-action listener: _resource_record_pre_action 11:23:12 INFO - Running main action method: read_buildbot_config 11:23:12 INFO - Using buildbot properties: 11:23:12 INFO - { 11:23:12 INFO - "project": "", 11:23:12 INFO - "product": "firefox", 11:23:12 INFO - "script_repo_revision": "production", 11:23:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:23:12 INFO - "repository": "", 11:23:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:23:12 INFO - "buildid": "20160922103000", 11:23:12 INFO - "pgo_build": "False", 11:23:12 INFO - "basedir": "/builds/slave/test", 11:23:12 INFO - "buildnumber": 3345, 11:23:12 INFO - "slavename": "talos-linux64-ix-006", 11:23:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:23:12 INFO - "platform": "ubuntu64_hw", 11:23:12 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:23:12 INFO - "branch": "fx-team", 11:23:12 INFO - "repo_path": "integration/fx-team", 11:23:12 INFO - "revision": "46645a6bb7dc88603beb3ce3e55fd63a1d2fc75b", 11:23:12 INFO - "stage_platform": "linux64", 11:23:12 INFO - "builduid": "de2a861d9b864c779dceccffa2978081", 11:23:12 INFO - "slavebuilddir": "test" 11:23:12 INFO - } 11:23:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 11:23:12 INFO - Running post-action listener: _resource_record_post_action 11:23:12 INFO - [mozharness: 2016-09-22 18:23:12.915177Z] Finished read-buildbot-config step (success) 11:23:12 INFO - [mozharness: 2016-09-22 18:23:12.915266Z] Running download-and-extract step. 11:23:12 INFO - Running pre-action listener: _resource_record_pre_action 11:23:12 INFO - Running main action method: download_and_extract 11:23:12 INFO - mkdir: /builds/slave/test/build/tests 11:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:12 INFO - trying https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:23:12 INFO - Downloading https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:23:13 INFO - Downloaded 1361 bytes. 11:23:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:23:13 INFO - Using the following test package requirements: 11:23:13 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:23:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:23:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:23:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:13 INFO - u'jsshell-linux-x86_64.zip'], 11:23:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:23:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:23:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:23:13 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:23:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:23:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:23:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:23:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:23:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:23:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:23:13 INFO - Fetch https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:23:14 INFO - Expected file size: 20373210 11:23:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:23:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:23:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:23:18 INFO - Fetch https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:23:18 INFO - Expected file size: 20373210 11:23:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 11:23:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:23:23 INFO - Fetch https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:23:24 INFO - Expected file size: 14414059 11:23:25 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')]} 11:23:25 INFO - trying https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:23:25 INFO - Downloading https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:23:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:23:28 INFO - Downloaded 55708676 bytes. 11:23:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:23:28 INFO - mkdir: /builds/slave/test/properties 11:23:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:23:28 INFO - Writing to file /builds/slave/test/properties/build_url 11:23:28 INFO - Contents: 11:23:28 INFO - build_url:https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:23:28 INFO - Running post-action listener: _resource_record_post_action 11:23:28 INFO - Running post-action listener: set_extra_try_arguments 11:23:28 INFO - [mozharness: 2016-09-22 18:23:28.731163Z] Finished download-and-extract step (success) 11:23:28 INFO - [mozharness: 2016-09-22 18:23:28.731392Z] Running populate-webroot step. 11:23:28 INFO - Running pre-action listener: _resource_record_pre_action 11:23:28 INFO - Running main action method: populate_webroot 11:23:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:23:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:23:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:23:28 INFO - '--tppagecycles', 11:23:28 INFO - '7'], 11:23:28 INFO - 'tests': ['tsvgm']}}, 11:23:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:23:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:23:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:23:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:23:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:23:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:23:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:28 INFO - 'talos_options': ['--disable-e10s'], 11:23:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:23:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:23:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:28 INFO - 'talos_options': ['--disable-e10s'], 11:23:28 INFO - 'tests': ['damp', 'tps']}, 11:23:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:28 INFO - 'tests': ['damp', 'tps']}, 11:23:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:23:28 INFO - 'tests': ['dromaeo_dom']}, 11:23:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:23:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:23:28 INFO - 'tests': ['basic_compositor_video']}, 11:23:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:23:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:23:28 INFO - 'tests': ['a11yr', 11:23:28 INFO - 'ts_paint', 11:23:28 INFO - 'tpaint', 11:23:28 INFO - 'sessionrestore', 11:23:28 INFO - 'sessionrestore_no_auto_restore', 11:23:28 INFO - 'tabpaint']}, 11:23:28 INFO - 'other-e10s': {'tests': ['a11yr', 11:23:28 INFO - 'ts_paint', 11:23:28 INFO - 'tpaint', 11:23:28 INFO - 'sessionrestore', 11:23:28 INFO - 'sessionrestore_no_auto_restore', 11:23:28 INFO - 'tabpaint']}, 11:23:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:23:28 INFO - 'ts_paint', 11:23:28 INFO - 'tpaint', 11:23:28 INFO - 'sessionrestore', 11:23:28 INFO - 'sessionrestore_no_auto_restore', 11:23:28 INFO - 'tabpaint']}, 11:23:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:23:28 INFO - 'ts_paint', 11:23:28 INFO - 'tpaint', 11:23:28 INFO - 'sessionrestore', 11:23:28 INFO - 'sessionrestore_no_auto_restore', 11:23:28 INFO - 'tabpaint']}, 11:23:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:23:28 INFO - 'tests': ['a11yr', 11:23:28 INFO - 'ts_paint', 11:23:28 INFO - 'tpaint', 11:23:28 INFO - 'sessionrestore', 11:23:28 INFO - 'sessionrestore_no_auto_restore', 11:23:28 INFO - 'tabpaint']}, 11:23:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:23:28 INFO - 'tests': ['a11yr', 11:23:28 INFO - 'ts_paint', 11:23:28 INFO - 'tpaint', 11:23:28 INFO - 'sessionrestore', 11:23:28 INFO - 'sessionrestore_no_auto_restore', 11:23:28 INFO - 'tabpaint']}, 11:23:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:23:28 INFO - 'tests': ['tsvgx', 11:23:28 INFO - 'tsvgr_opacity', 11:23:28 INFO - 'tart', 11:23:28 INFO - 'tscrollx', 11:23:28 INFO - 'cart']}, 11:23:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:23:28 INFO - 'tsvgr_opacity', 11:23:28 INFO - 'tart', 11:23:28 INFO - 'tscrollx', 11:23:28 INFO - 'cart']}, 11:23:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:28 INFO - 'talos_options': ['--disable-e10s'], 11:23:28 INFO - 'tests': ['tp5o']}, 11:23:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:28 INFO - 'tests': ['tp5o']}, 11:23:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:28 INFO - 'talos_options': ['--disable-e10s', 11:23:28 INFO - '--xperf_path', 11:23:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:23:28 INFO - 'tests': ['tp5n']}, 11:23:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:23:28 INFO - 'talos_options': ['--xperf_path', 11:23:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:23:28 INFO - 'tests': ['tp5n']}}, 11:23:28 INFO - 'talos.zip': {'path': '', 11:23:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:23:28 INFO - Running post-action listener: _resource_record_post_action 11:23:28 INFO - [mozharness: 2016-09-22 18:23:28.748174Z] Finished populate-webroot step (success) 11:23:28 INFO - [mozharness: 2016-09-22 18:23:28.748264Z] Running create-virtualenv step. 11:23:28 INFO - Running pre-action listener: _resource_record_pre_action 11:23:28 INFO - Running main action method: create_virtualenv 11:23:28 INFO - Creating virtualenv /builds/slave/test/build/venv 11:23:28 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 11:23:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:23:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:23:28 INFO - Using real prefix '/usr' 11:23:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:23:29 INFO - Installing distribute.............................................................................................................................................................................................done. 11:23:31 INFO - Installing pip.................done. 11:23:31 INFO - Return code: 0 11:23:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:31 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 0x7f4725c16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8af60>, '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 0xd8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', '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 11:23:31 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 11:23:31 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 11:23:31 INFO - Using env: {'DISPLAY': ':0', 11:23:31 INFO - 'HOME': '/home/cltbld', 11:23:31 INFO - 'LANG': 'en_US.UTF-8', 11:23:31 INFO - 'LANGUAGE': 'en_US:en', 11:23:31 INFO - 'LOGNAME': 'cltbld', 11:23:31 INFO - 'MAIL': '/var/mail/cltbld', 11:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:31 INFO - 'MOZ_NO_REMOTE': '1', 11:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:31 INFO - 'NO_EM_RESTART': '1', 11:23:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:31 INFO - 'PWD': '/builds/slave/test', 11:23:31 INFO - 'SHELL': '/bin/bash', 11:23:31 INFO - 'SHLVL': '1', 11:23:31 INFO - 'TERM': 'linux', 11:23:31 INFO - 'TMOUT': '86400', 11:23:31 INFO - 'USER': 'cltbld', 11:23:31 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', 11:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:31 INFO - '_': '/tools/buildbot/bin/python'} 11:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:31 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 11:23:31 INFO - Cleaning up... 11:23:31 INFO - Return code: 0 11:23:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:31 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 0x7f4725c16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8af60>, '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 0xd8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', '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 11:23:31 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 11:23:31 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 11:23:31 INFO - Using env: {'DISPLAY': ':0', 11:23:31 INFO - 'HOME': '/home/cltbld', 11:23:31 INFO - 'LANG': 'en_US.UTF-8', 11:23:31 INFO - 'LANGUAGE': 'en_US:en', 11:23:31 INFO - 'LOGNAME': 'cltbld', 11:23:31 INFO - 'MAIL': '/var/mail/cltbld', 11:23:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:31 INFO - 'MOZ_NO_REMOTE': '1', 11:23:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:31 INFO - 'NO_EM_RESTART': '1', 11:23:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:31 INFO - 'PWD': '/builds/slave/test', 11:23:31 INFO - 'SHELL': '/bin/bash', 11:23:31 INFO - 'SHLVL': '1', 11:23:31 INFO - 'TERM': 'linux', 11:23:31 INFO - 'TMOUT': '86400', 11:23:31 INFO - 'USER': 'cltbld', 11:23:31 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', 11:23:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:31 INFO - '_': '/tools/buildbot/bin/python'} 11:23:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:31 INFO - Downloading/unpacking psutil>=3.1.1 11:23:31 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 11:23:31 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 11:23:31 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 11:23:31 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 11:23:31 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 11:23:31 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 11:23:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:23:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:23:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:23:33 INFO - Installing collected packages: psutil 11:23:33 INFO - Running setup.py install for psutil 11:23:33 INFO - building 'psutil._psutil_linux' extension 11:23:33 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 11:23:34 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 11:23:34 INFO - building 'psutil._psutil_posix' extension 11:23:34 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 11:23:34 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 11:23:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:23:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:23:34 INFO - Successfully installed psutil 11:23:34 INFO - Cleaning up... 11:23:34 INFO - Return code: 0 11:23:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:34 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 0x7f4725c16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8af60>, '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 0xd8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', '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 11:23:34 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 11:23:34 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 11:23:34 INFO - Using env: {'DISPLAY': ':0', 11:23:34 INFO - 'HOME': '/home/cltbld', 11:23:34 INFO - 'LANG': 'en_US.UTF-8', 11:23:34 INFO - 'LANGUAGE': 'en_US:en', 11:23:34 INFO - 'LOGNAME': 'cltbld', 11:23:34 INFO - 'MAIL': '/var/mail/cltbld', 11:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:34 INFO - 'MOZ_NO_REMOTE': '1', 11:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:34 INFO - 'NO_EM_RESTART': '1', 11:23:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:34 INFO - 'PWD': '/builds/slave/test', 11:23:34 INFO - 'SHELL': '/bin/bash', 11:23:34 INFO - 'SHLVL': '1', 11:23:34 INFO - 'TERM': 'linux', 11:23:34 INFO - 'TMOUT': '86400', 11:23:34 INFO - 'USER': 'cltbld', 11:23:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', 11:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:34 INFO - '_': '/tools/buildbot/bin/python'} 11:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:23:34 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 11:23:34 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 11:23:34 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 11:23:34 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 11:23:34 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 11:23:34 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 11:23:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:23:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:23:36 INFO - Installing collected packages: mozsystemmonitor 11:23:36 INFO - Running setup.py install for mozsystemmonitor 11:23:36 INFO - Successfully installed mozsystemmonitor 11:23:36 INFO - Cleaning up... 11:23:36 INFO - Return code: 0 11:23:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4725c16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8af60>, '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 0xd8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', '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 11:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:23:36 INFO - Using env: {'DISPLAY': ':0', 11:23:36 INFO - 'HOME': '/home/cltbld', 11:23:36 INFO - 'LANG': 'en_US.UTF-8', 11:23:36 INFO - 'LANGUAGE': 'en_US:en', 11:23:36 INFO - 'LOGNAME': 'cltbld', 11:23:36 INFO - 'MAIL': '/var/mail/cltbld', 11:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:36 INFO - 'MOZ_NO_REMOTE': '1', 11:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:36 INFO - 'NO_EM_RESTART': '1', 11:23:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:36 INFO - 'PWD': '/builds/slave/test', 11:23:36 INFO - 'SHELL': '/bin/bash', 11:23:36 INFO - 'SHLVL': '1', 11:23:36 INFO - 'TERM': 'linux', 11:23:36 INFO - 'TMOUT': '86400', 11:23:36 INFO - 'USER': 'cltbld', 11:23:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', 11:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:36 INFO - '_': '/tools/buildbot/bin/python'} 11:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:36 INFO - Downloading/unpacking jsonschema==2.5.1 11:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:23:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:38 INFO - Downloading functools32-3.2.3-2.tar.gz 11:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:23:39 INFO - warning: no files found matching '*.txt' 11:23:39 INFO - no previously-included directories found matching 'build' 11:23:39 INFO - no previously-included directories found matching 'dist' 11:23:39 INFO - no previously-included directories found matching '.git*' 11:23:39 INFO - Installing collected packages: jsonschema, functools32 11:23:39 INFO - Running setup.py install for functools32 11:23:39 INFO - warning: no files found matching '*.txt' 11:23:39 INFO - no previously-included directories found matching 'build' 11:23:39 INFO - no previously-included directories found matching 'dist' 11:23:39 INFO - no previously-included directories found matching '.git*' 11:23:39 INFO - Successfully installed jsonschema functools32 11:23:39 INFO - Cleaning up... 11:23:39 INFO - Return code: 0 11:23:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:39 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 0x7f4725c16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8af60>, '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 0xd8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', '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 11:23:39 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 11:23:39 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 11:23:39 INFO - Using env: {'DISPLAY': ':0', 11:23:39 INFO - 'HOME': '/home/cltbld', 11:23:39 INFO - 'LANG': 'en_US.UTF-8', 11:23:39 INFO - 'LANGUAGE': 'en_US:en', 11:23:39 INFO - 'LOGNAME': 'cltbld', 11:23:39 INFO - 'MAIL': '/var/mail/cltbld', 11:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:39 INFO - 'MOZ_NO_REMOTE': '1', 11:23:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:39 INFO - 'NO_EM_RESTART': '1', 11:23:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:39 INFO - 'PWD': '/builds/slave/test', 11:23:39 INFO - 'SHELL': '/bin/bash', 11:23:39 INFO - 'SHLVL': '1', 11:23:39 INFO - 'TERM': 'linux', 11:23:39 INFO - 'TMOUT': '86400', 11:23:39 INFO - 'USER': 'cltbld', 11:23:39 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', 11:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:39 INFO - '_': '/tools/buildbot/bin/python'} 11:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:23:39 INFO - Cleaning up... 11:23:39 INFO - Return code: 0 11:23:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:39 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 0x7f4725c16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8af60>, '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 0xd8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', '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 11:23:39 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 11:23:39 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 11:23:39 INFO - Using env: {'DISPLAY': ':0', 11:23:39 INFO - 'HOME': '/home/cltbld', 11:23:39 INFO - 'LANG': 'en_US.UTF-8', 11:23:39 INFO - 'LANGUAGE': 'en_US:en', 11:23:39 INFO - 'LOGNAME': 'cltbld', 11:23:39 INFO - 'MAIL': '/var/mail/cltbld', 11:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:39 INFO - 'MOZ_NO_REMOTE': '1', 11:23:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:39 INFO - 'NO_EM_RESTART': '1', 11:23:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:39 INFO - 'PWD': '/builds/slave/test', 11:23:39 INFO - 'SHELL': '/bin/bash', 11:23:39 INFO - 'SHLVL': '1', 11:23:39 INFO - 'TERM': 'linux', 11:23:39 INFO - 'TMOUT': '86400', 11:23:39 INFO - 'USER': 'cltbld', 11:23:39 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', 11:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:39 INFO - '_': '/tools/buildbot/bin/python'} 11:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:39 INFO - Downloading/unpacking blobuploader==1.2.4 11:23:39 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 11:23:39 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 11:23:39 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 11:23:39 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 11:23:39 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 11:23:39 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 11:23:41 INFO - Downloading blobuploader-1.2.4.tar.gz 11:23:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:23:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:23:41 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 11:23:41 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 11:23:41 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 11:23:41 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 11:23:41 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 11:23:41 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 11:23:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:23:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:23:42 INFO - Downloading docopt-0.6.1.tar.gz 11:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:23:42 INFO - Installing collected packages: blobuploader, requests, docopt 11:23:42 INFO - Running setup.py install for blobuploader 11:23:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:23:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:23:42 INFO - Running setup.py install for requests 11:23:42 INFO - Running setup.py install for docopt 11:23:42 INFO - Successfully installed blobuploader requests docopt 11:23:42 INFO - Cleaning up... 11:23:42 INFO - Return code: 0 11:23:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23: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')]} 11:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23: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')]} 11:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:42 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 0x7f4725c16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8af60>, '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 0xd8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', '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 11:23:42 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 11:23:42 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 11:23:42 INFO - Using env: {'DISPLAY': ':0', 11:23:42 INFO - 'HOME': '/home/cltbld', 11:23:42 INFO - 'LANG': 'en_US.UTF-8', 11:23:42 INFO - 'LANGUAGE': 'en_US:en', 11:23:42 INFO - 'LOGNAME': 'cltbld', 11:23:42 INFO - 'MAIL': '/var/mail/cltbld', 11:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:42 INFO - 'MOZ_NO_REMOTE': '1', 11:23:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:42 INFO - 'NO_EM_RESTART': '1', 11:23:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:42 INFO - 'PWD': '/builds/slave/test', 11:23:42 INFO - 'SHELL': '/bin/bash', 11:23:42 INFO - 'SHLVL': '1', 11:23:42 INFO - 'TERM': 'linux', 11:23:42 INFO - 'TMOUT': '86400', 11:23:42 INFO - 'USER': 'cltbld', 11:23:42 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', 11:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:42 INFO - '_': '/tools/buildbot/bin/python'} 11:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:23:43 INFO - Running setup.py (path:/tmp/pip-vFhoWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:23:43 INFO - Running setup.py (path:/tmp/pip-ZpuV2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:23:43 INFO - Running setup.py (path:/tmp/pip-0ZWjra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:23:43 INFO - Running setup.py (path:/tmp/pip-Fn5x1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:23:43 INFO - Running setup.py (path:/tmp/pip-urmfBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:23:43 INFO - Running setup.py (path:/tmp/pip-oXIBxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:23:43 INFO - Running setup.py (path:/tmp/pip-JSKrkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:23:43 INFO - Running setup.py (path:/tmp/pip-VofqM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:23:43 INFO - Running setup.py (path:/tmp/pip-_iafGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:23:43 INFO - Running setup.py (path:/tmp/pip-Obj2QB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:23:43 INFO - Running setup.py (path:/tmp/pip-Z2Jgtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:23:43 INFO - Running setup.py (path:/tmp/pip-__Pcu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:23:44 INFO - Running setup.py (path:/tmp/pip-uazaNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:23:44 INFO - Running setup.py (path:/tmp/pip-3dJ5ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:44 INFO - Running setup.py (path:/tmp/pip-dCS8vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:23:44 INFO - Running setup.py (path:/tmp/pip-0CjEJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:23:44 INFO - Running setup.py (path:/tmp/pip-SEiZTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:23:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:23:44 INFO - Running setup.py install for manifestparser 11:23:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:23:44 INFO - Running setup.py install for mozcrash 11:23:44 INFO - Running setup.py install for mozdebug 11:23:44 INFO - Running setup.py install for mozdevice 11:23:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:23:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:23:44 INFO - Running setup.py install for mozfile 11:23:44 INFO - Running setup.py install for mozhttpd 11:23:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:23:44 INFO - Running setup.py install for mozinfo 11:23:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:23:45 INFO - Running setup.py install for mozInstall 11:23:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:23:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:23:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:23:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:23:45 INFO - Running setup.py install for mozleak 11:23:45 INFO - Running setup.py install for mozlog 11:23:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:23:45 INFO - Running setup.py install for moznetwork 11:23:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:23:45 INFO - Running setup.py install for mozprocess 11:23:45 INFO - Running setup.py install for mozprofile 11:23:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:23:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:23:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:23:45 INFO - Running setup.py install for mozrunner 11:23:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:23:45 INFO - Running setup.py install for mozscreenshot 11:23:45 INFO - Running setup.py install for moztest 11:23:46 INFO - Running setup.py install for mozversion 11:23:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:23:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:23:46 INFO - Cleaning up... 11:23:46 INFO - Return code: 0 11:23:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:46 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 0x7f4725c16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8af60>, '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 0xd8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', '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 11:23:46 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 11:23:46 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 11:23:46 INFO - Using env: {'DISPLAY': ':0', 11:23:46 INFO - 'HOME': '/home/cltbld', 11:23:46 INFO - 'LANG': 'en_US.UTF-8', 11:23:46 INFO - 'LANGUAGE': 'en_US:en', 11:23:46 INFO - 'LOGNAME': 'cltbld', 11:23:46 INFO - 'MAIL': '/var/mail/cltbld', 11:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:46 INFO - 'MOZ_NO_REMOTE': '1', 11:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:46 INFO - 'NO_EM_RESTART': '1', 11:23:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:46 INFO - 'PWD': '/builds/slave/test', 11:23:46 INFO - 'SHELL': '/bin/bash', 11:23:46 INFO - 'SHLVL': '1', 11:23:46 INFO - 'TERM': 'linux', 11:23:46 INFO - 'TMOUT': '86400', 11:23:46 INFO - 'USER': 'cltbld', 11:23:46 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', 11:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:46 INFO - '_': '/tools/buildbot/bin/python'} 11:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:23:46 INFO - Running setup.py (path:/tmp/pip-slHmhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:23:46 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)) 11:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:23:46 INFO - Running setup.py (path:/tmp/pip-PvY6Sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:23:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:23:46 INFO - Running setup.py (path:/tmp/pip-oJWOjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:23:46 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)) 11:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:23:46 INFO - Running setup.py (path:/tmp/pip-i3adcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:23:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:23:46 INFO - Running setup.py (path:/tmp/pip-vESxkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:23:46 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)) 11:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:23:46 INFO - Running setup.py (path:/tmp/pip-kWE2hU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:23:46 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)) 11:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:23:46 INFO - Running setup.py (path:/tmp/pip-vwhLmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:23:46 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)) 11:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:23:46 INFO - Running setup.py (path:/tmp/pip-eVMl2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:23:46 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)) 11:23:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:23:46 INFO - Running setup.py (path:/tmp/pip-7I4NFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:23:47 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)) 11:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:23:47 INFO - Running setup.py (path:/tmp/pip-RfjDkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:23:47 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)) 11:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:23:47 INFO - Running setup.py (path:/tmp/pip-MqNtHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:23:47 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)) 11:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:23:47 INFO - Running setup.py (path:/tmp/pip-4QZCLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:23:47 INFO - Running setup.py (path:/tmp/pip-yy3TTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:23:47 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)) 11:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:23:47 INFO - Running setup.py (path:/tmp/pip-tKYjJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:47 INFO - Running setup.py (path:/tmp/pip-7c0XmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:23:47 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)) 11:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:23:47 INFO - Running setup.py (path:/tmp/pip-Q7g7f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:23:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:23:47 INFO - Running setup.py (path:/tmp/pip-_YcM0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:23:47 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)) 11:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:23:47 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)) 11:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:23:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23: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 11:23:49 INFO - Downloading blessings-1.6.tar.gz 11:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:23:49 INFO - Installing collected packages: blessings 11:23:49 INFO - Running setup.py install for blessings 11:23:49 INFO - Successfully installed blessings 11:23:49 INFO - Cleaning up... 11:23:49 INFO - Return code: 0 11:23:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:23:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:23:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:23:49 INFO - Reading from file tmpfile_stdout 11:23:49 INFO - Current package versions: 11:23:49 INFO - argparse == 1.2.1 11:23:49 INFO - blessings == 1.6 11:23:49 INFO - blobuploader == 1.2.4 11:23:49 INFO - docopt == 0.6.1 11:23:49 INFO - functools32 == 3.2.3-2 11:23:49 INFO - jsonschema == 2.5.1 11:23:49 INFO - manifestparser == 1.1 11:23:49 INFO - mozInstall == 1.12 11:23:49 INFO - mozcrash == 0.17 11:23:49 INFO - mozdebug == 0.1 11:23:49 INFO - mozdevice == 0.48 11:23:49 INFO - mozfile == 1.2 11:23:49 INFO - mozhttpd == 0.7 11:23:49 INFO - mozinfo == 0.9 11:23:49 INFO - mozleak == 0.1 11:23:49 INFO - mozlog == 3.4 11:23:49 INFO - moznetwork == 0.27 11:23:49 INFO - mozprocess == 0.23 11:23:49 INFO - mozprofile == 0.28 11:23:49 INFO - mozrunner == 6.12 11:23:49 INFO - mozscreenshot == 0.1 11:23:49 INFO - mozsystemmonitor == 0.3 11:23:49 INFO - moztest == 0.7 11:23:49 INFO - mozversion == 1.4 11:23:49 INFO - psutil == 3.1.1 11:23:49 INFO - requests == 1.2.3 11:23:49 INFO - wsgiref == 0.1.2 11:23:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:49 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')]} 11:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:49 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')]} 11:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:49 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 0x7f4725c16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8af60>, '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 0xd8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', '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 11:23:49 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 11:23:49 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 11:23:49 INFO - Using env: {'DISPLAY': ':0', 11:23:49 INFO - 'HOME': '/home/cltbld', 11:23:49 INFO - 'LANG': 'en_US.UTF-8', 11:23:49 INFO - 'LANGUAGE': 'en_US:en', 11:23:49 INFO - 'LOGNAME': 'cltbld', 11:23:49 INFO - 'MAIL': '/var/mail/cltbld', 11:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:49 INFO - 'MOZ_NO_REMOTE': '1', 11:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:49 INFO - 'NO_EM_RESTART': '1', 11:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:49 INFO - 'PWD': '/builds/slave/test', 11:23:49 INFO - 'SHELL': '/bin/bash', 11:23:49 INFO - 'SHLVL': '1', 11:23:49 INFO - 'TERM': 'linux', 11:23:49 INFO - 'TMOUT': '86400', 11:23:49 INFO - 'USER': 'cltbld', 11:23:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', 11:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:49 INFO - '_': '/tools/buildbot/bin/python'} 11:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:50 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)) 11:23:50 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)) 11:23:50 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)) 11:23:50 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)) 11:23:50 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)) 11:23:50 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)) 11:23:50 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)) 11:23:50 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)) 11:23:50 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)) 11:23:50 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)) 11:23:50 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)) 11:23:50 INFO - Cleaning up... 11:23:50 INFO - Return code: 0 11:23:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:23:50 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')]} 11:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:50 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')]} 11:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:50 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 0x7f4725c16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcc08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd8dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd8af60>, '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 0xd8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8c1d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', '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 11:23:50 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 11:23:50 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 11:23:50 INFO - Using env: {'DISPLAY': ':0', 11:23:50 INFO - 'HOME': '/home/cltbld', 11:23:50 INFO - 'LANG': 'en_US.UTF-8', 11:23:50 INFO - 'LANGUAGE': 'en_US:en', 11:23:50 INFO - 'LOGNAME': 'cltbld', 11:23:50 INFO - 'MAIL': '/var/mail/cltbld', 11:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:50 INFO - 'MOZ_NO_REMOTE': '1', 11:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:50 INFO - 'NO_EM_RESTART': '1', 11:23:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:50 INFO - 'PWD': '/builds/slave/test', 11:23:50 INFO - 'SHELL': '/bin/bash', 11:23:50 INFO - 'SHLVL': '1', 11:23:50 INFO - 'TERM': 'linux', 11:23:50 INFO - 'TMOUT': '86400', 11:23:50 INFO - 'USER': 'cltbld', 11:23:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', 11:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:50 INFO - '_': '/tools/buildbot/bin/python'} 11:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:23:50 INFO - Cleaning up... 11:23:50 INFO - Return code: 0 11:23:50 INFO - Running post-action listener: _resource_record_post_action 11:23:50 INFO - Running post-action listener: _start_resource_monitoring 11:23:50 INFO - Starting resource monitoring. 11:23:50 INFO - [mozharness: 2016-09-22 18:23:50.458916Z] Finished create-virtualenv step (success) 11:23:50 INFO - [mozharness: 2016-09-22 18:23:50.459362Z] Running install step. 11:23:50 INFO - Running pre-action listener: _resource_record_pre_action 11:23:50 INFO - Running main action method: install 11:23:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:23:50 INFO - Reading from file tmpfile_stdout 11:23:50 INFO - Detecting whether we're running mozinstall >=1.0... 11:23:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:23:50 INFO - Reading from file tmpfile_stdout 11:23:50 INFO - Output received: 11:23:50 INFO - Usage: mozinstall [options] installer 11:23:50 INFO - Options: 11:23:50 INFO - -h, --help show this help message and exit 11:23:50 INFO - -d DEST, --destination=DEST 11:23:50 INFO - Directory to install application into. [default: 11:23:50 INFO - "/builds/slave/test"] 11:23:50 INFO - --app=APP Application being installed. [default: firefox] 11:23:50 INFO - mkdir: /builds/slave/test/build/application 11:23:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:23:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:24:06 INFO - Reading from file tmpfile_stdout 11:24:06 INFO - Output received: 11:24:06 INFO - /builds/slave/test/build/application/firefox/firefox 11:24:06 INFO - Running post-action listener: _resource_record_post_action 11:24:06 INFO - [mozharness: 2016-09-22 18:24:06.830591Z] Finished install step (success) 11:24:06 INFO - [mozharness: 2016-09-22 18:24:06.830837Z] Running run-tests step. 11:24:06 INFO - Running pre-action listener: _resource_record_pre_action 11:24:06 INFO - Running main action method: run_tests 11:24:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:24:06 INFO - Python 2.7.3 11:24:06 INFO - Return code: 0 11:24:06 INFO - grabbing minidump binary from tooltool 11:24:06 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')]} 11:24:06 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 0xd8af60>, '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 0xd8bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd8c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:24:06 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 11:24:06 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 11:24:06 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 11:24:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:24:06 INFO - Return code: 0 11:24:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:24:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:24:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:24:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:24:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:24:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 11:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 11:24:06 INFO - Using env: {'DISPLAY': ':0', 11:24:06 INFO - 'HOME': '/home/cltbld', 11:24:06 INFO - 'LANG': 'en_US.UTF-8', 11:24:06 INFO - 'LANGUAGE': 'en_US:en', 11:24:06 INFO - 'LOGNAME': 'cltbld', 11:24:06 INFO - 'MAIL': '/var/mail/cltbld', 11:24:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:24:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:06 INFO - 'MOZ_NO_REMOTE': '1', 11:24:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:06 INFO - 'NO_EM_RESTART': '1', 11:24:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:06 INFO - 'PWD': '/builds/slave/test', 11:24:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:24:06 INFO - 'SHELL': '/bin/bash', 11:24:06 INFO - 'SHLVL': '1', 11:24:06 INFO - 'TERM': 'linux', 11:24:06 INFO - 'TMOUT': '86400', 11:24:06 INFO - 'USER': 'cltbld', 11:24:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599', 11:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:06 INFO - '_': '/tools/buildbot/bin/python'} 11:24:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 11:24:07 INFO - mozversion application_buildid: 20160922103000 11:24:07 INFO - mozversion application_changeset: 46645a6bb7dc88603beb3ce3e55fd63a1d2fc75b 11:24:07 INFO - mozversion application_display_name: Nightly 11:24:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:24:07 INFO - mozversion application_name: Firefox 11:24:07 INFO - mozversion application_remotingname: firefox 11:24:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:24:07 INFO - mozversion application_vendor: Mozilla 11:24:07 INFO - mozversion application_version: 52.0a1 11:24:07 INFO - mozversion platform_buildid: 20160922103000 11:24:07 INFO - mozversion platform_changeset: 46645a6bb7dc88603beb3ce3e55fd63a1d2fc75b 11:24:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:24:07 INFO - mozversion platform_version: 52.0a1 11:24:07 INFO - using testdate: 1474568647 11:24:07 INFO - actual date: 1474568647 11:24:07 INFO - starting webserver on 'localhost:38831' 11:24:07 INFO - SUITE-START | Running 2 tests 11:24:07 INFO - TEST-START | dromaeo_css 11:24:07 INFO - operating with platform_type : linux_ 11:24:07 INFO - Initialising browser for dromaeo_css test... 11:24:07 INFO - TEST-INFO | started process 29404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcRu3Nl/profile http://localhost:38831/getInfo.html) 11:24:11 INFO - PROCESS | 29404 | __metrics Screen width/height:1600/1200 11:24:11 INFO - PROCESS | 29404 | colorDepth:24 11:24:11 INFO - PROCESS | 29404 | Browser inner width/height: 1024/697 11:24:11 INFO - PROCESS | 29404 | __metrics 11:24:12 INFO - PROCESS | 29404 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:24:12 INFO - PROCESS | 29404 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:24:12 INFO - PROCESS | 29404 | console.error: PushService: 11:24:12 INFO - PROCESS | 29404 | stateChangeProcessEnqueue: Error transitioning state 11:24:12 INFO - PROCESS | 29404 | UnknownError 11:24:13 INFO - TEST-INFO | 29404: exit 0 11:24:13 INFO - Browser initialized. 11:24:13 INFO - Running cycle 1/1 for dromaeo_css test... 11:24:13 INFO - TEST-INFO | started process 29483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcRu3Nl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:24:25 INFO - PROCESS | 29483 | RSS: Main: 175222784 11:24:25 INFO - PROCESS | 29483 | 11:25:16 INFO - PROCESS | 29483 | 1474568716656 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:27:29 INFO - PROCESS | 29483 | Cycle 1(1): loaded http://localhost:38831/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38831/tests/dromaeo/cssquery-ext.html) 11:27:30 INFO - PROCESS | 29483 | RSS: Main: 315490304 11:27:30 INFO - PROCESS | 29483 | 11:30:33 INFO - PROCESS | 29483 | Cycle 1(1): loaded http://localhost:38831/tests/dromaeo/cssquery-ext.html (next: http://localhost:38831/tests/dromaeo/cssquery-jquery.html) 11:30:34 INFO - PROCESS | 29483 | RSS: Main: 280559616 11:30:34 INFO - PROCESS | 29483 | 11:33:36 INFO - PROCESS | 29483 | Cycle 1(1): loaded http://localhost:38831/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38831/tests/dromaeo/cssquery-mootools.html) 11:33:37 INFO - PROCESS | 29483 | RSS: Main: 262586368 11:33:37 INFO - PROCESS | 29483 | 11:36:39 INFO - PROCESS | 29483 | Cycle 1(1): loaded http://localhost:38831/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38831/tests/dromaeo/cssquery-prototype.html) 11:36:40 INFO - PROCESS | 29483 | RSS: Main: 221417472 11:36:40 INFO - PROCESS | 29483 | 11:39:43 INFO - PROCESS | 29483 | Cycle 1(1): loaded http://localhost:38831/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38831/tests/dromaeo/cssquery-yui.html) 11:39:43 INFO - PROCESS | 29483 | RSS: Main: 221360128 11:39:43 INFO - PROCESS | 29483 | 11:42:46 INFO - PROCESS | 29483 | Cycle 1(1): loaded http://localhost:38831/tests/dromaeo/cssquery-yui.html (next: http://localhost:38831/tests/dromaeo/cssquery-dojo.html) 11:42:46 INFO - PROCESS | 29483 | RSS: Main: 314499072 11:42:46 INFO - PROCESS | 29483 | 11:42:46 INFO - PROCESS | 29483 | __start_tp_report 11:42:46 INFO - PROCESS | 29483 | _x_x_mozilla_page_load 11:42:46 INFO - PROCESS | 29483 | _x_x_mozilla_page_load_details 11:42:46 INFO - PROCESS | 29483 | |i|pagename|runs| 11:42:46 INFO - PROCESS | 29483 | |0;dojo.html;2589.870506474676;2626.6979297380785;2646.7750241229496;2655.322892662371;2666.3067602423375;4494.887627809307;4556.749378784166;4684.203685373486;4711.693739906904;4723.40957380327;4584.541545845414;4596.241620132674;4598.609118224955;4609;4612.21592329304;4175.4363160973335;4236.533981262074;4236.978815105936;4294.355846623001;4316.136772645467;4191.308434108369;4248.362745588156;4264.808083636229;4344.913101737963;4373.343998400233;4221.78891055446;4274.914501709964;4285.635720963722;4289.764062976535;4343.305071188611;4254.149170165948;4259.7231179973205;4272.380504826782;4316.633086187678;4323.913521729579;4147.834086636531;4189.392538081992;4192.287311157111;4228.4080228768;4253.213155566199;4541.772911354419;4552.271636538138;4559.612432943204;4647.465541462741;4727.57451829337;4918.827841025547;4926.729029903354;4927.704337739747;4933.7286449245275;4998.775055122528;4818.759062046884;4918.606511479073;4931.235658472942;4961.627877909171;5014.749262536859;4607.470140933769;4653.185692503798;4653.627709783277;4655.650826188049;4658.627309815207;5063.569596584258;5098.59211263098;5100.1074811907765;5103.795848166106;5169.302144210558;4724.456687480915;4754.215554433549;4885.340479035356;4894.535019173173;4944.777485013183;4898.608111351084;4972.005598880239;5002.574781143643;5012.122878496249;5075.923861142086;4976.0794253063295;4986.650934434555;4989.25161225819;4989.775460104304;5052.368453943257;4944.505549445027;4948.282499037619;4952;4960.578350840219;5021.849344519597;4143.6685065194715;4168.374743788456;4170.7706076166105;4175.707700460999;4193.874183774492;3683.1528748388023;3689.151495156129;3733.4773131761576;3737.850485980585;3747.1006958329804;4252.170826688828;4263.531011588722;4273.209456250542;4318.093200427883;4322.438083049246;4813.229883218668;4837.588804951619;4875.902481950341;4909.214525675875;4913.705177689279;4272;4278.465191851019;4287.764172970454;4293.012607100322;4303.376010478463;4461.843835465808;4471.23988921884;4482.977585112054;4534.7052441591195;4537.115262523776;4680.882977925579;4683.648726345469;4684.1568517666465;4686.5782079613;4735.952640473552;4849.903001940012;4901.975490122527;4903.509649035068;4905.730184839868;4962.975185124052;4648.790804413742;4703.811847526061;4704;4723.4331880174595;4777.665563410528;4839.41926968766;4843.2250839865455;4851.56335929768;4852.587530059985;4908.582770464551;4879.95120048795;4925.778339974781;4935.75321233944;4943.925841112315;4997.5002499749735;4752;4827.324174615486;4846;4856.125897338513;4867.3915760529935;4881.755912204447;4887.828925987574;4890.657653964188;4923.6307276955085;4939.333190019302;4788.856334309976;4800.73595952226;4807.663463557517;4818.638602104927;4825.131476334293;4682.461516925461;4769;4797.112534181188;4838.564529192389;4847.345608342828;4757;4809.78355973975;4837.419509658864;4848.636352273523;4868.683535570177 11:42:46 INFO - PROCESS | 29483 | |1;ext.html;559.3958524793223;571.7598608584397;574.405490317521;575.94816466518;579.753604717995;27269.863650681742;27890.163295101127;29817.552736708913;29874.850625746894;29901.102966910974;29979.550306745416;38221.23557528855;39649.40525892114;39739.403908941385;42575.57424425755;7100.076989991307;7232.276772322778;7243.130824301065;7245.347918687317;7248.782536523912;7623.504472209316;7712.113106992683;7715.884261736079;7716.305532502074;7721.961390193069;7750.302472777449;7775.922240777605;7777.18339574345;7787.065552133724;7797.961010194941;7640.083190017206;7701.730439434593;7702.037245344332;7716.228377162295;7727.884081738778;7628.580428076453;7700.768976930701;7701.383889288843;7706.845863082707;7709.036370453693;35881.82059089714;36088.278234435165;36418.27163456716;36443.4533481998;36517;2868.211241908471;2886.321714397115;2892.3802670504583;2899.839175298934;3231.0145405651265;26286.73713262862;28799.424011519863;28843.717896290666;28881.133565993056;31631.20921976946;3457.9308413831836;3465.5148279240925;3475.8549561923205;3514.4201206801104;3530.3115892400992;243393;246606;246827;246915;247065;54572;55704.72147639236;55740.72129639326;56073;56121;32310.35379292448;33492;58423;58878.705606471696;58911.41088589059;13299.268540230187;13547.525836595672;13550.728985420237;13554.051216414953;13556.525521606696;9909;10013.64952226683;10038.096571308617;10086.445245511568;10092.14216791581;18033.18850651724;18042.548936276697;18091;18222.17556278779;18466;7101.538400003983;7240.855182896418;7272.454565907578;7278.199398066208;7288.161861385903;719.5466855880761;785.3324674027032;811.6063709101081;909.0182602788972;950.5009869818263;26870.32824179372;27241.641337386318;27836.443271134867;30071.849640752094;30323.393532129234;771.0222486497178;889.666375109334;899.4153800030033;912.8219997100501;921.3504479342048;13589;14458.20479873596;14463.566093017227;14615.26923653813;14717.779233311509;367132;370102;371595;371849;371909;45667.314990275176;46202.306965395546;46330.76834615873;46331.76834115808;46413.53586464092;1053.4837929414532;1091.8471414002047;1115.1469126118689;1122;1139.0830381542937;25743.485130297664;27890.86054569714;28281.43437131287;28502.85748571244;28841.278968025967;39597.80201099091;40228.77597852184;40243;40248.597514025656;40377;251866;253780;253932;254143;254175;24058.63912041286;25162.874185628956;25206.49587008286;26054.60918086268;26217.475650486504;39137.80431097826;40017.1996560073;40140.79929600333;40230.798846005586;40863;34115.82942085274;34420.311593768485;34486.31027379489;34554.82722586371;35016.474752879236;34252.65747342594;34826;35098.473522897686;35369.64630353663;35398.29203415969;33847.66152338445;34306.48540271848;34679.47980780341;34783;35104.12239694028;30074.849625751733;31949.840250798596;32081.518777217894;32502.512462313556;32710.182245444055;24258.63612045856;24395.094795966128;24631;24737.257882263562;25048.248552543453 11:42:46 INFO - PROCESS | 29483 | |2;jquery.html;341.8068791133008;359.2402069622747;365.1364522903334;373.91026153723107;385.4622801192337;12200.877991220097;15689.686206275883;16020.279087441064;16204.35182592695;17032.148392580384;16062.75905861413;16414.7537786933;16578.253978570963;16658.250378732955;16773;4839.854804355875;4845.927311090337;4988.575971042465;5011.574016208627;5029.4216165141115;3556.6621170988715;3752.4558938953837;4913.041956818422;4988.825391111312;4989.2017277235645;3712.05342637627;3767.2842159989514;3772.0758414188563;3776.603456637055;5209.802013622737;3739.2895349883433;5820.301563812327;5826.970865145647;5835.679037652927;5859.3554708981765;4552.772361381918;4827.155247831651;5152.690838549662;5157.974210128926;5161.612879034087;10735.677929662123;10961.780764384668;10962.725931851688;10968.835467467994;10969.780604387948;1804.593966357572;1813.8095499972576;1966.3216190414284;2136.9679454808193;2170.967435488469;8533.573321333908;8552.61513231906;8665.696700615448;8832.602532886036;9013.639454421815;1641.351666091899;1674.6985542602326;1680.915954202285;1705.1474262868567;1717.3731587970426;65125.348746512405;65277.67361163164;65722.34277657258;66087;67295;9370.437773733598;9407.482588457564;9541.332106752461;9577.90422095784;9658.32391732586;12973;12980.480780768852;12985.610431687064;12991.740165196832;13031.869681303066;6425.1968503937005;6549.6070235785055;6559.311272316433;6732.764353247613;6782.898256526156;6139.508839292936;6195.411435913581;6313.810585682437;6341.904871426932;6358.1416508771645;3913.4325522799604;4036.9394459083137;4048.4939382577177;4055.9391609125887;4062.6343629073526;1617.781599484078;1633.1670847867672;1702.7190513565124;1706.9489404802137;1778.2264714848823;846.289117141604;848.1179573243758;894;895.3553441522093;902.634433054614;15458.304376303093;16063.277152527931;16083.919580402024;16107.516774496784;16812.915935420246;780.7033327335577;795.8050277682005;809.4212637963766;823.9176082391833;876.4171825735814;8388.622511986976;8878.245349145265;9289.303302252358;9328.533573321307;9401.815447683079;358150;363689;364089;368857.0485836824;369971;38756.80621596874;57702;58103.70948145232;67829;69453.65273173703;854.1842540373804;861.6553378648465;881.7927786970057;892.5581836990731;892.9196372326522;13939.372728227458;14544.563663090124;15149.394024238907;15957.7492182709;16200.837991619934;37198;37285.81357093197;37802.43296350612;38071.428928566645;38401;47010;47043.76478117587;47648.28527572159;49357.25964110469;49745;6298.779542715983;6430.906745853123;6652.966735166487;6679.098321726505;6773.221079575912;11244.66266012021;11572.685462907284;11652.592159274385;11757.353345566076;12216.45025973851;9696.95151524238;9777.217822574035;9891.653792117242;10027.29808913369;11041.613543525938;10177.185825133824;10270.43512606784;10295.53670084863;10560.84158737635;10670.8399374011;9921.355111917703;10626.096781773636;10643.361398316125;11049;11102.222844400814;6518.282988871126;7337.59643219628;7339.926600733925;7461.589612571361;7777.066751989797;8664.696735614476;10359.430231337348;10373;10427.843582346119;10705.732356691145 11:42:46 INFO - PROCESS | 29483 | |3;mootools.html;1309.6202101390595;1338.5315139701106;1342.4361768057415;1561.461295852931;1581.3200323860735;7133.393661538769;7513.2862378074;7520.097588289399;7520.360769334613;7578.848423031536;6408.551401401904;6626.304238054995;7150.070490836197;7366.152892417374;7543.509671871325;2102.3692892132376;2143.356992902131;2147.7530084040377;2149.0651566568513;2149.408912549046;1997.9700304495443;2018.8183063524352;2041.4079916824103;2059.5983783162287;2060.330392622396;2079.5217100066993;2122.246602456129;2123.4266747978036;2125.0543508138885;2134.253011445989;2079.9688004679865;2081.4276074079676;2084.801943815335;2085.979140208594;2090.9895450522804;1943.620993906189;1952.375239923225;1966.410076976901;1969.2319995201883;1972.615340008699;7440.107187137578;7619.352355049828;7623.466357354987;7628.0846298443985;7630.7329243476215;4305.13897220554;4424.513303536608;4455.487618923833;4456.376107344942;4462.040661257845;2677.3574342157935;2677.651905252324;2738.2880451082665;2809.466201421744;2834.985825070882;837.6440012994453;851.221132663612;862.7066797288952;874.2481465939287;886.0474989386436;10229.079382855505;10275.640352587698;10280.640177593748;10280.794384112276;10283.228757843117;3795.525559305087;3812.866549670748;3964.306246406867;3992.121733218687;4069.1251380953236;8763.298936085226;8779.956100219586;8805.295576353876;8805.339599530062;8815.955920220485;4448.377227188196;4453.3320001999955;4454.799534020977;4459.219636563588;4461.063176732858;3396.575428071491;3512.806795626214;3874.7868867212574;4116.300228961084;4116.938245926313;3397.6602339765827;3541.982290088533;3547.875824346187;3551.964480355215;3661.5423072115987;1106.8727096383857;1156.6125348008343;1160.1067178272683;1163.4706208675032;1163.8241354484812;695.3255342317943;798.9201079892081;808.2402541610867;809.0251247247053;820.9819823419036;4962.280469331927;4972.776225069808;5011.599072074226;5013.172826483589;5244.501772331622;382.5868062492501;383.2430948876003;385.44303481469007;390.04050036908956;853.1852081262504;3581.3016461789703;3623.510826038451;3659.4876717259604;3702.241040586673;3797.145642230476;8605.698800541952;8986.32602554798;9013.77465563353;9024.819503609891;9044;8968.596413161424;8988.146126118008;8995.28037756978;9030.142136497023;9043.547822608974;7002.579845209304;7186.065811444583;7206.459515536356;7206.603636799921;7229.638518074181;5012.8496145115705;5136.640435169502;5142.6914385137015;5150.639455238097;5169.405518365436;8471.152884711479;8642.870356944524;8643.56782160902;8648;8734.694285700225;8588.65645374178;8602.139786021347;8746.868796968178;8810.471371717718;8821.823563528566;5986.9401305986385;6023.247094113236;6024.548158888013;6057;6075.787347442818;6969.54697944632;7027.367536921702;7029.613371264425;7030.472714546532;7034.929650703632;6351.396617321347;6381.266154392119;6432.807015789534;6583.572067815577;6613.801585952429;6193.628382297076;6238.469730072813;6385.29761726219;6400.903986440114;6418.903716444163;5950.821475355746;6033.456988871023;6049.546284028627;6051.969740151271;6055.515558755377;4471.3740076388685;4553.157665831832;4606.930896036495;4615.79228934692;4685.508021657677;4407.669424793217;4444.200043992112;4486.932696009497;4528.252838281646;4631.560001799824 11:42:46 INFO - PROCESS | 29483 | |4;prototype.html;266.40325670498083;268.1205645482817;279.75661174777946;281.1032805350929;285.21565694340563;4603.217453032984;4741.8814529636775;4799.808007679693;4811.989482208736;4817.445993710724;4568.634509239261;4687.632745463545;4707.152712511746;4724.31497432872;4727.8818029549275;3526.365254254233;3713.814309284525;3715.1640880801874;3724.4413337999245;3738.9904725724036;3530.8411121499594;3617.7027587481875;3662.157703728131;3673.669369756721;3687.1703866630064;3646;3651.4522821576843;3652.589291067896;3656.305301992626;3659.8719044833438;3643.0892276930767;3645.2162785001087;3654;3673.2653469306247;3673.302072606223;3174;3230.628477725068;3235.223546348883;3241.1086951088405;3251.235959549504;4530.660200484944;4563.110193512266;4567.2920697291975;4598.632109431271;4600.239856086355;4212.094399704079;4218.641415479688;4220.6412454941365;4222.9577704222875;4242.681798865066;4775.594074503671;4952.133376659106;4954.87612809679;4968.701877887338;4992.126377883892;3481.2863363010774;3483.1988642612087;3484.686378225972;3487.5989261235027;3488.337215928965;5231.659942103751;5247.291615631917;5263.815766448156;5267.710275934784;5267.9736601316745;3465.2722928184858;3564.2515071835205;3574.6595026864925;3577.5528058992627;3581.94627080594;3602.0994751312173;3604.387254166798;3608.404613238839;3608.6210947850623;3642.2351306225987;4174.102567947845;4180.561041090642;4199.286121359315;4207.915841683211;4210.221109094828;4692.53074692528;4827.865451618867;4840.75796210188;4969.2546118081855;4985;1211.9760000798688;1226.693326668333;1231.2427856867962;1232.9938350308191;1233.210745123122;754.0649594502777;787.9448438609357;799.7084708196221;801.5431204213543;804.5816175588778;4005.679545636342;4007.757595145514;4009.3184158693093;4011.6389524942897;4020.9195816084098;4556.585009944734;4560.651264598734;4574.722634336839;4588.242939914877;4606.631469482433;3974.5627980922077;3993.7004724645767;4005.35914253718;4008.719389642697;4012.538558065801;2307.042577330423;2388.5103553771437;2394.245812569035;2405.3883897788523;2469.2221950085664;4268.509121451073;4274.914501709948;4309.633681137076;4338;4356.978215108904;4555.2711566149255;4585.770711464414;4593.793279302439;4630.143423466669;4649.721016739007;4134.772587507656;4231.449911511484;4279.422277992493;4326.44248070688;4347.608715215646;4523.547645235451;4526.298423744325;4527.1931402530645;4543.727756228262;4549.45406551216;4394.813400381943;4441.733495990251;4456.796664900394;4471.977640111779;4481.327800829901;4288.292431748727;4351.8694439166875;4359.760213188305;4393.956060439355;4530.252508336088;3598.208394153282;3600.6219346969237;3618.6743193112748;3620.7465477416326;3631.8728844490315;4940.604751619933;5163.4578369270685;5178.792848286026;5219.347581552306;5229.790808367623;4803.183458811941;4926.433460152129;4986.601071914166;5002.924956125588;5002.949970500248;4988.625853060962;5006.724630145377;5028.120078986236;5036.874078148076;5040.319556859777;4859.8579333855805;4927.507249275044;5001.474845141208;5003.899922001612;5022.171341728574;4990.675606085593;5048.167052436307;5050.570701490415;5064.215046667772;5064.468230835857;4937.0372777308085;4960.461178022214;4963.528464795839;5000.499950004971;5003.498950314964 11:42:46 INFO - PROCESS | 29483 | |5;yui.html;600.5316999935158;607.3076692570473;620.1380081686453;634.7936920500837;734.9448791340648;12199.634010979673;12953.35233238339;12958.805617915727;12963.416646250918;12964.74070518589;12012.399380031007;12097.576584819533;12107.636770896886;12114.575989840358;12123.636290911287;714.3891972363646;729.7445893937106;730.9561426314411;731.1737736357908;731.5574077683005;732.3226015935265;737.0823324960431;739.3419856327846;742.0205328965767;742.1279996004699;774.6707649249047;775.1163673412315;775.8099265679916;776.1501156233915;776.54572075336;769.7536788227769;770.3067239484453;770.452978385347;771.0824119298045;771.4522688890894;572.1846368924266;572.3503823160701;572.7222297185862;572.7623036439873;572.8338781753287;10521.947390263076;10577.36535807854;10578.947105264502;10600.363978161335;10691.518881650345;10936.125109991182;10937;11111.499982500807;11240.49417776202;11311.604093856758;8699.130086991314;8818.735437936872;8847.955760221223;9253.814923701555;9256.166944974984;3116.9688303116905;3158.3525377297597;3182.9363412731846;3211.2935154266024;3230.111719277194;63757.36242637561;64614.353856461305;64729;65713;66660.3333966659;8551.059383467813;8691.956540217385;8693.304535637133;8719.65121395137;8784.824303513893;17071.146442678066;17177.570560735832;17199.91400042992;17236;17249.741253881202;6592.901106483407;6674.599524028574;6749.190097188271;6810.740013097593;7043.718251269995;3581.265840502743;3684.1158122050515;3720.8511659533856;3825.2923209206388;3853.2293541291856;2808.606795048695;2827.717228277197;2831.801773875809;2839.7870159738104;2886.682464928856;456.3998342180089;457.6316065567184;464.45426623717674;467.0961689131473;471.3118846484103;484.3678998906461;512.9307543481582;517.93047357208;519.9454057324002;523.2595876834237;7779.788058929938;7788.221177882167;7960.323372513401;8047.637856296481;8464.280536154372;468.8968426946066;497.5795452842415;547.6905548365161;565.2482198675751;580.7880123754884;3773;3813.542374915028;3853.6917046636204;3877.3408520551575;3919.9608003919598;102261;104513.47743261234;106513.46743266234;107224.46387768011;109993.45003274933;77733;91460;91637.54181229051;91997.5400122995;92776.53611731899;45968;70055;79883;79902.6004869972;80818.19181808224;7373.63131843395;7392.630368481447;7567.205443428361;7772.154155482665;7795.727149549739;41916.371254430596;47117.764411177726;47693.28460073171;48303.75848120737;48783.75608121937;64185.35814641981;64261.35738642554;69616.6519167401;70875.64562177156;71398.64300678464;8532.488050716976;8711.564421779012;8817.426867253607;9230.984591694774;9678.612855485984;10436.843447348145;10729.103142151731;10947.178961577754;11599.362035088152;11660.825087623523;9762.75593110178;9940.6580111684;10129.64546240878;10227.590896364061;10271.640492583023;9659.46872921968;9712.70861874145;9827.11555959967;9993.150582200595;10050.748731281776;11018.393988330397;11770.176087674123;11772.941135294268;12089.093318001362;13085.672858178621;9682.951585242028;9775.511224438607;9921.00789921002;9959.502024898871;10399.064084232456;10200.693979180636;10231.43727095017;10515.421651809223;10580.735481612714;10592.470376480991 11:42:46 INFO - PROCESS | 29483 | __end_tp_report 11:42:46 INFO - PROCESS | 29483 | __start_cc_report 11:42:46 INFO - PROCESS | 29483 | _x_x_mozilla_cycle_collect,1174 11:42:46 INFO - PROCESS | 29483 | __end_cc_report 11:42:46 INFO - PROCESS | 29483 | __startTimestamp1474569766855__endTimestamp 11:42:46 INFO - PROCESS | 29483 | 11:42:46 INFO - PROCESS | 29483 | ------- Summary: start ------- 11:42:46 INFO - PROCESS | 29483 | Number of tests: 6 11:42:46 INFO - PROCESS | 29483 | 11:42:46 INFO - PROCESS | 29483 | [#0] dojo.html Cycles:165 Average:4584.64 Median:4723.43 stddev:471.29 (10.0%) stddev-sans-first:446.00 11:42:46 INFO - PROCESS | 29483 | Values: 2589.9 2626.7 2646.8 2655.3 2666.3 4494.9 4556.7 4684.2 4711.7 4723.4 4584.5 4596.2 4598.6 4609.0 4612.2 4175.4 4236.5 4237.0 4294.4 4316.1 4191.3 4248.4 4264.8 4344.9 4373.3 4221.8 4274.9 4285.6 4289.8 4343.3 4254.1 4259.7 4272.4 4316.6 4323.9 4147.8 4189.4 4192.3 4228.4 4253.2 4541.8 4552.3 4559.6 4647.5 4727.6 4918.8 4926.7 4927.7 4933.7 4998.8 4818.8 4918.6 4931.2 4961.6 5014.7 4607.5 4653.2 4653.6 4655.7 4658.6 5063.6 5098.6 5100.1 5103.8 5169.3 4724.5 4754.2 4885.3 4894.5 4944.8 4898.6 4972.0 5002.6 5012.1 5075.9 4976.1 4986.7 4989.3 4989.8 5052.4 4944.5 4948.3 4952.0 4960.6 5021.8 4143.7 4168.4 4170.8 4175.7 4193.9 3683.2 3689.2 3733.5 3737.9 3747.1 4252.2 4263.5 4273.2 4318.1 4322.4 4813.2 4837.6 4875.9 4909.2 4913.7 4272.0 4278.5 4287.8 4293.0 4303.4 4461.8 4471.2 4483.0 4534.7 4537.1 4680.9 4683.6 4684.2 4686.6 4736.0 4849.9 4902.0 4903.5 4905.7 4963.0 4648.8 4703.8 4704.0 4723.4 4777.7 4839.4 4843.2 4851.6 4852.6 4908.6 4880.0 4925.8 4935.8 4943.9 4997.5 4752.0 4827.3 4846.0 4856.1 4867.4 4881.8 4887.8 4890.7 4923.6 4939.3 4788.9 4800.7 4807.7 4818.6 4825.1 4682.5 4769.0 4797.1 4838.6 4847.3 4757.0 4809.8 4837.4 4848.6 4868.7 11:42:46 INFO - PROCESS | 29483 | 11:42:46 INFO - PROCESS | 29483 | [#1] ext.html Cycles:180 Average:44062.74 Median:35057.47 stddev:77738.64 (221.7%) stddev-sans-first:77888.10 11:42:46 INFO - PROCESS | 29483 | Values: 559.4 571.8 574.4 575.9 579.8 27269.9 27890.2 29817.6 29874.9 29901.1 29979.6 38221.2 39649.4 39739.4 42575.6 7100.1 7232.3 7243.1 7245.3 7248.8 7623.5 7712.1 7715.9 7716.3 7722.0 7750.3 7775.9 7777.2 7787.1 7798.0 7640.1 7701.7 7702.0 7716.2 7727.9 7628.6 7700.8 7701.4 7706.8 7709.0 35881.8 36088.3 36418.3 36443.5 36517.0 2868.2 2886.3 2892.4 2899.8 3231.0 26286.7 28799.4 28843.7 28881.1 31631.2 3457.9 3465.5 3475.9 3514.4 3530.3 243393.0 246606.0 246827.0 246915.0 247065.0 54572.0 55704.7 55740.7 56073.0 56121.0 32310.4 33492.0 58423.0 58878.7 58911.4 13299.3 13547.5 13550.7 13554.1 13556.5 9909.0 10013.6 10038.1 10086.4 10092.1 18033.2 18042.5 18091.0 18222.2 18466.0 7101.5 7240.9 7272.5 7278.2 7288.2 719.5 785.3 811.6 909.0 950.5 26870.3 27241.6 27836.4 30071.8 30323.4 771.0 889.7 899.4 912.8 921.4 13589.0 14458.2 14463.6 14615.3 14717.8 367132.0 370102.0 371595.0 371849.0 371909.0 45667.3 46202.3 46330.8 46331.8 46413.5 1053.5 1091.8 1115.1 1122.0 1139.1 25743.5 27890.9 28281.4 28502.9 28841.3 39597.8 40228.8 40243.0 40248.6 40377.0 251866.0 253780.0 253932.0 254143.0 254175.0 24058.6 25162.9 25206.5 26054.6 26217.5 39137.8 40017.2 40140.8 40230.8 40863.0 34115.8 34420.3 34486.3 34554.8 35016.5 34252.7 34826.0 35098.5 35369.6 35398.3 33847.7 34306.5 34679.5 34783.0 35104.1 30074.8 31949.8 32081.5 32502.5 32710.2 24258.6 24395.1 24631.0 24737.3 25048.2 11:42:46 INFO - PROCESS | 29483 | 11:42:46 INFO - PROCESS | 29483 | [#2] jquery.html Cycles:180 Average:22370.31 Median:4052.22 stddev:60082.59 (1482.7%) stddev-sans-first:60228.37 11:42:46 INFO - PROCESS | 29483 | Values: 341.8 359.2 365.1 373.9 385.5 12200.9 15689.7 16020.3 16204.4 17032.1 16062.8 16414.8 16578.3 16658.3 16773.0 4839.9 4845.9 4988.6 5011.6 5029.4 3556.7 3752.5 4913.0 4988.8 4989.2 3712.1 3767.3 3772.1 3776.6 5209.8 3739.3 5820.3 5827.0 5835.7 5859.4 4552.8 4827.2 5152.7 5158.0 5161.6 10735.7 10961.8 10962.7 10968.8 10969.8 1804.6 1813.8 1966.3 2137.0 2171.0 8533.6 8552.6 8665.7 8832.6 9013.6 1641.4 1674.7 1680.9 1705.1 1717.4 65125.3 65277.7 65722.3 66087.0 67295.0 9370.4 9407.5 9541.3 9577.9 9658.3 12973.0 12980.5 12985.6 12991.7 13031.9 6425.2 6549.6 6559.3 6732.8 6782.9 6139.5 6195.4 6313.8 6341.9 6358.1 3913.4 4036.9 4048.5 4055.9 4062.6 1617.8 1633.2 1702.7 1706.9 1778.2 846.3 848.1 894.0 895.4 902.6 15458.3 16063.3 16083.9 16107.5 16812.9 780.7 795.8 809.4 823.9 876.4 8388.6 8878.2 9289.3 9328.5 9401.8 358150.0 363689.0 364089.0 368857.0 369971.0 38756.8 57702.0 58103.7 67829.0 69453.7 854.2 861.7 881.8 892.6 892.9 13939.4 14544.6 15149.4 15957.7 16200.8 37198.0 37285.8 37802.4 38071.4 38401.0 47010.0 47043.8 47648.3 49357.3 49745.0 6298.8 6430.9 6653.0 6679.1 6773.2 11244.7 11572.7 11652.6 11757.4 12216.5 9697.0 9777.2 9891.7 10027.3 11041.6 10177.2 10270.4 10295.5 10560.8 10670.8 9921.4 10626.1 10643.4 11049.0 11102.2 6518.3 7337.6 7339.9 7461.6 7777.1 8664.7 10359.4 10373.0 10427.8 10705.7 11:42:46 INFO - PROCESS | 29483 | 11:42:46 INFO - PROCESS | 29483 | [#3] mootools.html Cycles:180 Average:4897.51 Median:4992.19 stddev:2750.97 (55.1%) stddev-sans-first:2745.48 11:42:46 INFO - PROCESS | 29483 | Values: 1309.6 1338.5 1342.4 1561.5 1581.3 7133.4 7513.3 7520.1 7520.4 7578.8 6408.6 6626.3 7150.1 7366.2 7543.5 2102.4 2143.4 2147.8 2149.1 2149.4 1998.0 2018.8 2041.4 2059.6 2060.3 2079.5 2122.2 2123.4 2125.1 2134.3 2080.0 2081.4 2084.8 2086.0 2091.0 1943.6 1952.4 1966.4 1969.2 1972.6 7440.1 7619.4 7623.5 7628.1 7630.7 4305.1 4424.5 4455.5 4456.4 4462.0 2677.4 2677.7 2738.3 2809.5 2835.0 837.6 851.2 862.7 874.2 886.0 10229.1 10275.6 10280.6 10280.8 10283.2 3795.5 3812.9 3964.3 3992.1 4069.1 8763.3 8780.0 8805.3 8805.3 8816.0 4448.4 4453.3 4454.8 4459.2 4461.1 3396.6 3512.8 3874.8 4116.3 4116.9 3397.7 3542.0 3547.9 3552.0 3661.5 1106.9 1156.6 1160.1 1163.5 1163.8 695.3 798.9 808.2 809.0 821.0 4962.3 4972.8 5011.6 5013.2 5244.5 382.6 383.2 385.4 390.0 853.2 3581.3 3623.5 3659.5 3702.2 3797.1 8605.7 8986.3 9013.8 9024.8 9044.0 8968.6 8988.1 8995.3 9030.1 9043.5 7002.6 7186.1 7206.5 7206.6 7229.6 5012.8 5136.6 5142.7 5150.6 5169.4 8471.2 8642.9 8643.6 8648.0 8734.7 8588.7 8602.1 8746.9 8810.5 8821.8 5986.9 6023.2 6024.5 6057.0 6075.8 6969.5 7027.4 7029.6 7030.5 7034.9 6351.4 6381.3 6432.8 6583.6 6613.8 6193.6 6238.5 6385.3 6400.9 6418.9 5950.8 6033.5 6049.5 6052.0 6055.5 4471.4 4553.2 4606.9 4615.8 4685.5 4407.7 4444.2 4486.9 4528.3 4631.6 11:42:46 INFO - PROCESS | 29483 | 11:42:46 INFO - PROCESS | 29483 | [#4] prototype.html Cycles:180 Average:3986.23 Median:4354.42 stddev:1166.31 (26.8%) stddev-sans-first:1135.67 11:42:46 INFO - PROCESS | 29483 | Values: 266.4 268.1 279.8 281.1 285.2 4603.2 4741.9 4799.8 4812.0 4817.4 4568.6 4687.6 4707.2 4724.3 4727.9 3526.4 3713.8 3715.2 3724.4 3739.0 3530.8 3617.7 3662.2 3673.7 3687.2 3646.0 3651.5 3652.6 3656.3 3659.9 3643.1 3645.2 3654.0 3673.3 3673.3 3174.0 3230.6 3235.2 3241.1 3251.2 4530.7 4563.1 4567.3 4598.6 4600.2 4212.1 4218.6 4220.6 4223.0 4242.7 4775.6 4952.1 4954.9 4968.7 4992.1 3481.3 3483.2 3484.7 3487.6 3488.3 5231.7 5247.3 5263.8 5267.7 5268.0 3465.3 3564.3 3574.7 3577.6 3581.9 3602.1 3604.4 3608.4 3608.6 3642.2 4174.1 4180.6 4199.3 4207.9 4210.2 4692.5 4827.9 4840.8 4969.3 4985.0 1212.0 1226.7 1231.2 1233.0 1233.2 754.1 787.9 799.7 801.5 804.6 4005.7 4007.8 4009.3 4011.6 4020.9 4556.6 4560.7 4574.7 4588.2 4606.6 3974.6 3993.7 4005.4 4008.7 4012.5 2307.0 2388.5 2394.2 2405.4 2469.2 4268.5 4274.9 4309.6 4338.0 4357.0 4555.3 4585.8 4593.8 4630.1 4649.7 4134.8 4231.4 4279.4 4326.4 4347.6 4523.5 4526.3 4527.2 4543.7 4549.5 4394.8 4441.7 4456.8 4472.0 4481.3 4288.3 4351.9 4359.8 4394.0 4530.3 3598.2 3600.6 3618.7 3620.7 3631.9 4940.6 5163.5 5178.8 5219.3 5229.8 4803.2 4926.4 4986.6 5002.9 5002.9 4988.6 5006.7 5028.1 5036.9 5040.3 4859.9 4927.5 5001.5 5003.9 5022.2 4990.7 5048.2 5050.6 5064.2 5064.5 4937.0 4960.5 4963.5 5000.5 5003.5 11:42:46 INFO - PROCESS | 29483 | 11:42:46 INFO - PROCESS | 29483 | [#5] yui.html Cycles:180 Average:17831.11 Median:572.27 stddev:27001.20 (4718.3%) stddev-sans-first:27045.95 11:42:46 INFO - PROCESS | 29483 | Values: 600.5 607.3 620.1 634.8 734.9 12199.6 12953.4 12958.8 12963.4 12964.7 12012.4 12097.6 12107.6 12114.6 12123.6 714.4 729.7 731.0 731.2 731.6 732.3 737.1 739.3 742.0 742.1 774.7 775.1 775.8 776.2 776.5 769.8 770.3 770.5 771.1 771.5 572.2 572.4 572.7 572.8 572.8 10521.9 10577.4 10578.9 10600.4 10691.5 10936.1 10937.0 11111.5 11240.5 11311.6 8699.1 8818.7 8848.0 9253.8 9256.2 3117.0 3158.4 3182.9 3211.3 3230.1 63757.4 64614.4 64729.0 65713.0 66660.3 8551.1 8692.0 8693.3 8719.7 8784.8 17071.1 17177.6 17199.9 17236.0 17249.7 6592.9 6674.6 6749.2 6810.7 7043.7 3581.3 3684.1 3720.9 3825.3 3853.2 2808.6 2827.7 2831.8 2839.8 2886.7 456.4 457.6 464.5 467.1 471.3 484.4 512.9 517.9 519.9 523.3 7779.8 7788.2 7960.3 8047.6 8464.3 468.9 497.6 547.7 565.2 580.8 3773.0 3813.5 3853.7 3877.3 3920.0 102261.0 104513.5 106513.5 107224.5 109993.5 77733.0 91460.0 91637.5 91997.5 92776.5 45968.0 70055.0 79883.0 79902.6 80818.2 7373.6 7392.6 7567.2 7772.2 7795.7 41916.4 47117.8 47693.3 48303.8 48783.8 64185.4 64261.4 69616.7 70875.6 71398.6 8532.5 8711.6 8817.4 9231.0 9678.6 10436.8 10729.1 10947.2 11599.4 11660.8 9762.8 9940.7 10129.6 10227.6 10271.6 9659.5 9712.7 9827.1 9993.2 10050.7 11018.4 11770.2 11772.9 12089.1 13085.7 9683.0 9775.5 9921.0 9959.5 10399.1 10200.7 10231.4 10515.4 10580.7 10592.5 11:42:46 INFO - PROCESS | 29483 | -------- Summary: end -------- 11:42:46 INFO - PROCESS | 29483 | 11:42:47 INFO - TEST-INFO | 29483: exit 0 11:42:47 INFO - TEST-OK | dromaeo_css | took 1120700ms 11:42:47 INFO - TEST-START | kraken 11:42:47 INFO - operating with platform_type : linux_ 11:42:47 INFO - Initialising browser for kraken test... 11:42:47 INFO - TEST-INFO | started process 29801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdJOZNq/profile http://localhost:38831/getInfo.html) 11:42:52 INFO - PROCESS | 29801 | __metrics Screen width/height:1600/1200 11:42:52 INFO - PROCESS | 29801 | colorDepth:24 11:42:52 INFO - PROCESS | 29801 | Browser inner width/height: 1024/697 11:42:52 INFO - PROCESS | 29801 | __metrics 11:42:52 INFO - PROCESS | 29801 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:42:52 INFO - PROCESS | 29801 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:42:53 INFO - PROCESS | 29801 | console.error: PushService: 11:42:53 INFO - PROCESS | 29801 | stateChangeProcessEnqueue: Error transitioning state 11:42:53 INFO - PROCESS | 29801 | UnknownError 11:42:54 INFO - TEST-INFO | 29801: exit 0 11:42:54 INFO - Browser initialized. 11:42:54 INFO - Running cycle 1/1 for kraken test... 11:42:54 INFO - TEST-INFO | started process 29884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdJOZNq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:06 INFO - PROCESS | 29884 | RSS: Main: 175038464 11:43:06 INFO - PROCESS | 29884 | 11:43:09 INFO - PROCESS | 29884 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38831/tests/kraken/driver.html?testName=audio-beat-detection) 11:43:10 INFO - PROCESS | 29884 | RSS: Main: 234491904 11:43:10 INFO - PROCESS | 29884 | 11:43:12 INFO - PROCESS | 29884 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38831/tests/kraken/driver.html?testName=audio-dft) 11:43:13 INFO - PROCESS | 29884 | RSS: Main: 219009024 11:43:13 INFO - PROCESS | 29884 | 11:43:16 INFO - PROCESS | 29884 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38831/tests/kraken/driver.html?testName=audio-fft) 11:43:17 INFO - PROCESS | 29884 | RSS: Main: 300453888 11:43:17 INFO - PROCESS | 29884 | 11:43:19 INFO - PROCESS | 29884 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38831/tests/kraken/driver.html?testName=audio-oscillator) 11:43:20 INFO - PROCESS | 29884 | RSS: Main: 211091456 11:43:20 INFO - PROCESS | 29884 | 11:43:22 INFO - PROCESS | 29884 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38831/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:43:23 INFO - PROCESS | 29884 | RSS: Main: 214433792 11:43:23 INFO - PROCESS | 29884 | 11:43:26 INFO - PROCESS | 29884 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38831/tests/kraken/driver.html?testName=imaging-darkroom) 11:43:26 INFO - PROCESS | 29884 | RSS: Main: 251035648 11:43:26 INFO - PROCESS | 29884 | 11:43:30 INFO - PROCESS | 29884 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38831/tests/kraken/driver.html?testName=imaging-desaturate) 11:43:31 INFO - PROCESS | 29884 | RSS: Main: 244416512 11:43:31 INFO - PROCESS | 29884 | 11:43:34 INFO - PROCESS | 29884 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38831/tests/kraken/driver.html?testName=json-parse-financial) 11:43:34 INFO - PROCESS | 29884 | RSS: Main: 246890496 11:43:34 INFO - PROCESS | 29884 | 11:43:36 INFO - PROCESS | 29884 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38831/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:43:36 INFO - PROCESS | 29884 | RSS: Main: 211197952 11:43:36 INFO - PROCESS | 29884 | 11:43:38 INFO - PROCESS | 29884 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38831/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:43:39 INFO - PROCESS | 29884 | RSS: Main: 217468928 11:43:39 INFO - PROCESS | 29884 | 11:43:41 INFO - PROCESS | 29884 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38831/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:43:42 INFO - PROCESS | 29884 | RSS: Main: 223330304 11:43:42 INFO - PROCESS | 29884 | 11:43:45 INFO - PROCESS | 29884 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38831/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:43:45 INFO - PROCESS | 29884 | RSS: Main: 223989760 11:43:45 INFO - PROCESS | 29884 | 11:43:48 INFO - PROCESS | 29884 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38831/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:43:49 INFO - PROCESS | 29884 | RSS: Main: 222064640 11:43:49 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | Cycle 1(1): loaded http://localhost:38831/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38831/tests/kraken/driver.html?testName=ai-astar) 11:43:51 INFO - PROCESS | 29884 | RSS: Main: 273121280 11:43:51 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | __start_tp_report 11:43:51 INFO - PROCESS | 29884 | _x_x_mozilla_page_load 11:43:51 INFO - PROCESS | 29884 | _x_x_mozilla_page_load_details 11:43:51 INFO - PROCESS | 29884 | |i|pagename|runs| 11:43:51 INFO - PROCESS | 29884 | |0;ai-astar;114;116;116;116;115;115;116;115;116;114 11:43:51 INFO - PROCESS | 29884 | |1;audio-beat-detection;154;124;124;170;131;125;127;122;157;123 11:43:51 INFO - PROCESS | 29884 | |2;audio-dft;163;163;163;163;161;160;161;161;160;165 11:43:51 INFO - PROCESS | 29884 | |3;audio-fft;76;77;77;119;78;78;78;78;106;77 11:43:51 INFO - PROCESS | 29884 | |4;audio-oscillator;83;83;125;84;83;82;113;83;83;125 11:43:51 INFO - PROCESS | 29884 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;117;117;117 11:43:51 INFO - PROCESS | 29884 | |6;imaging-darkroom;147;148;148;147;147;146;147;147;146;146 11:43:51 INFO - PROCESS | 29884 | |7;imaging-desaturate;94;95;95;95;94;95;95;95;95;94 11:43:51 INFO - PROCESS | 29884 | |8;json-parse-financial;65;64;66;64;65;64;64;65;64;64 11:43:51 INFO - PROCESS | 29884 | |9;json-stringify-tinderbox;65;66;66;66;66;66;66;67;67;66 11:43:51 INFO - PROCESS | 29884 | |10;stanford-crypto-aes;85;82;86;83;83;82;82;82;81;82 11:43:51 INFO - PROCESS | 29884 | |11;stanford-crypto-ccm;137;135;138;131;131;130;134;133;182;134 11:43:51 INFO - PROCESS | 29884 | |12;stanford-crypto-pbkdf2;180;179;173;173;174;178;174;173;173;174 11:43:51 INFO - PROCESS | 29884 | |13;stanford-crypto-sha256-iterative;72;73;69;76;69;68;67;68;69;71 11:43:51 INFO - PROCESS | 29884 | __end_tp_report 11:43:51 INFO - PROCESS | 29884 | __start_cc_report 11:43:51 INFO - PROCESS | 29884 | _x_x_mozilla_cycle_collect,1932 11:43:51 INFO - PROCESS | 29884 | __end_cc_report 11:43:51 INFO - PROCESS | 29884 | __startTimestamp1474569831434__endTimestamp 11:43:51 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | ------- Summary: start ------- 11:43:51 INFO - PROCESS | 29884 | Number of tests: 14 11:43:51 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | [#0] ai-astar Cycles:10 Average:115.30 Median:116.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 11:43:51 INFO - PROCESS | 29884 | Values: 114.0 116.0 116.0 116.0 115.0 115.0 116.0 115.0 116.0 114.0 11:43:51 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:129.00 stddev:17.64 (13.7%) stddev-sans-first:17.42 11:43:51 INFO - PROCESS | 29884 | Values: 154.0 124.0 124.0 170.0 131.0 125.0 127.0 122.0 157.0 123.0 11:43:51 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | [#2] audio-dft Cycles:10 Average:162.00 Median:163.00 stddev:1.63 (1.0%) stddev-sans-first:1.69 11:43:51 INFO - PROCESS | 29884 | Values: 163.0 163.0 163.0 163.0 161.0 160.0 161.0 161.0 160.0 165.0 11:43:51 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | [#3] audio-fft Cycles:10 Average:84.40 Median:77.50 stddev:15.14 (19.5%) stddev-sans-first:15.75 11:43:51 INFO - PROCESS | 29884 | Values: 76.0 77.0 77.0 119.0 78.0 78.0 78.0 78.0 106.0 77.0 11:43:51 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:83.00 stddev:18.65 (22.5%) stddev-sans-first:19.32 11:43:51 INFO - PROCESS | 29884 | Values: 83.0 83.0 125.0 84.0 83.0 82.0 113.0 83.0 83.0 125.0 11:43:51 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:43:51 INFO - PROCESS | 29884 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 11:43:51 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 11:43:51 INFO - PROCESS | 29884 | Values: 147.0 148.0 148.0 147.0 147.0 146.0 147.0 147.0 146.0 146.0 11:43:51 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 11:43:51 INFO - PROCESS | 29884 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 11:43:51 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 11:43:51 INFO - PROCESS | 29884 | Values: 65.0 64.0 66.0 64.0 65.0 64.0 64.0 65.0 64.0 64.0 11:43:51 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 11:43:51 INFO - PROCESS | 29884 | Values: 65.0 66.0 66.0 66.0 66.0 66.0 66.0 67.0 67.0 66.0 11:43:51 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:1.55 (1.9%) stddev-sans-first:1.42 11:43:51 INFO - PROCESS | 29884 | Values: 85.0 82.0 86.0 83.0 83.0 82.0 82.0 82.0 81.0 82.0 11:43:51 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:134.50 stddev:15.50 (11.5%) stddev-sans-first:16.43 11:43:51 INFO - PROCESS | 29884 | Values: 137.0 135.0 138.0 131.0 131.0 130.0 134.0 133.0 182.0 134.0 11:43:51 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:174.00 stddev:2.77 (1.6%) stddev-sans-first:2.30 11:43:51 INFO - PROCESS | 29884 | Values: 180.0 179.0 173.0 173.0 174.0 178.0 174.0 173.0 173.0 174.0 11:43:51 INFO - PROCESS | 29884 | 11:43:51 INFO - PROCESS | 29884 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:2.78 (4.0%) stddev-sans-first:2.87 11:43:51 INFO - PROCESS | 29884 | Values: 72.0 73.0 69.0 76.0 69.0 68.0 67.0 68.0 69.0 71.0 11:43:51 INFO - PROCESS | 29884 | -------- Summary: end -------- 11:43:51 INFO - PROCESS | 29884 | 11:43:52 INFO - TEST-INFO | 29884: exit 0 11:43:52 INFO - TEST-OK | kraken | took 64916ms 11:43:52 INFO - SUITE-END | took 1185s 11:43:53 INFO - Completed test suite (00:19:45) 11:43:53 INFO - javascript benchmark 11:43:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2589.870506474676, 2626.6979297380785, 2646.7750241229496, 2655.322892662371, 2666.3067602423375, 4494.887627809307, 4556.749378784166, 4684.203685373486, 4711.693739906904, 4723.40957380327, 4584.541545845414, 4596.241620132674, 4598.609118224955, 4609.0, 4612.21592329304, 4175.4363160973335, 4236.533981262074, 4236.978815105936, 4294.355846623001, 4316.136772645467, 4191.308434108369, 4248.362745588156, 4264.808083636229, 4344.913101737963, 4373.343998400233, 4221.78891055446, 4274.914501709964, 4285.635720963722, 4289.764062976535, 4343.305071188611, 4254.149170165948, 4259.7231179973205, 4272.380504826782, 4316.633086187678, 4323.913521729579, 4147.834086636531, 4189.392538081992, 4192.287311157111, 4228.4080228768, 4253.213155566199, 4541.772911354419, 4552.271636538138, 4559.612432943204, 4647.465541462741, 4727.57451829337, 4918.827841025547, 4926.729029903354, 4927.704337739747, 4933.7286449245275, 4998.775055122528, 4818.759062046884, 4918.606511479073, 4931.235658472942, 4961.627877909171, 5014.749262536859, 4607.470140933769, 4653.185692503798, 4653.627709783277, 4655.650826188049, 4658.627309815207, 5063.569596584258, 5098.59211263098, 5100.1074811907765, 5103.795848166106, 5169.302144210558, 4724.456687480915, 4754.215554433549, 4885.340479035356, 4894.535019173173, 4944.777485013183, 4898.608111351084, 4972.005598880239, 5002.574781143643, 5012.122878496249, 5075.923861142086, 4976.0794253063295, 4986.650934434555, 4989.25161225819, 4989.775460104304, 5052.368453943257, 4944.505549445027, 4948.282499037619, 4952.0, 4960.578350840219, 5021.849344519597, 4143.6685065194715, 4168.374743788456, 4170.7706076166105, 4175.707700460999, 4193.874183774492, 3683.1528748388023, 3689.151495156129, 3733.4773131761576, 3737.850485980585, 3747.1006958329804, 4252.170826688828, 4263.531011588722, 4273.209456250542, 4318.093200427883, 4322.438083049246, 4813.229883218668, 4837.588804951619, 4875.902481950341, 4909.214525675875, 4913.705177689279, 4272.0, 4278.465191851019, 4287.764172970454, 4293.012607100322, 4303.376010478463, 4461.843835465808, 4471.23988921884, 4482.977585112054, 4534.7052441591195, 4537.115262523776, 4680.882977925579, 4683.648726345469, 4684.1568517666465, 4686.5782079613, 4735.952640473552, 4849.903001940012, 4901.975490122527, 4903.509649035068, 4905.730184839868, 4962.975185124052, 4648.790804413742, 4703.811847526061, 4704.0, 4723.4331880174595, 4777.665563410528, 4839.41926968766, 4843.2250839865455, 4851.56335929768, 4852.587530059985, 4908.582770464551, 4879.95120048795, 4925.778339974781, 4935.75321233944, 4943.925841112315, 4997.5002499749735, 4752.0, 4827.324174615486, 4846.0, 4856.125897338513, 4867.3915760529935, 4881.755912204447, 4887.828925987574, 4890.657653964188, 4923.6307276955085, 4939.333190019302, 4788.856334309976, 4800.73595952226, 4807.663463557517, 4818.638602104927, 4825.131476334293, 4682.461516925461, 4769.0, 4797.112534181188, 4838.564529192389, 4847.345608342828, 4757.0, 4809.78355973975, 4837.419509658864, 4848.636352273523, 4868.683535570177], "value": 4555.364195084303, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.3958524793223, 571.7598608584397, 574.405490317521, 575.94816466518, 579.753604717995, 27269.863650681742, 27890.163295101127, 29817.552736708913, 29874.850625746894, 29901.102966910974, 29979.550306745416, 38221.23557528855, 39649.40525892114, 39739.403908941385, 42575.57424425755, 7100.076989991307, 7232.276772322778, 7243.130824301065, 7245.347918687317, 7248.782536523912, 7623.504472209316, 7712.113106992683, 7715.884261736079, 7716.305532502074, 7721.961390193069, 7750.302472777449, 7775.922240777605, 7777.18339574345, 7787.065552133724, 7797.961010194941, 7640.083190017206, 7701.730439434593, 7702.037245344332, 7716.228377162295, 7727.884081738778, 7628.580428076453, 7700.768976930701, 7701.383889288843, 7706.845863082707, 7709.036370453693, 35881.82059089714, 36088.278234435165, 36418.27163456716, 36443.4533481998, 36517.0, 2868.211241908471, 2886.321714397115, 2892.3802670504583, 2899.839175298934, 3231.0145405651265, 26286.73713262862, 28799.424011519863, 28843.717896290666, 28881.133565993056, 31631.20921976946, 3457.9308413831836, 3465.5148279240925, 3475.8549561923205, 3514.4201206801104, 3530.3115892400992, 243393.0, 246606.0, 246827.0, 246915.0, 247065.0, 54572.0, 55704.72147639236, 55740.72129639326, 56073.0, 56121.0, 32310.35379292448, 33492.0, 58423.0, 58878.705606471696, 58911.41088589059, 13299.268540230187, 13547.525836595672, 13550.728985420237, 13554.051216414953, 13556.525521606696, 9909.0, 10013.64952226683, 10038.096571308617, 10086.445245511568, 10092.14216791581, 18033.18850651724, 18042.548936276697, 18091.0, 18222.17556278779, 18466.0, 7101.538400003983, 7240.855182896418, 7272.454565907578, 7278.199398066208, 7288.161861385903, 719.5466855880761, 785.3324674027032, 811.6063709101081, 909.0182602788972, 950.5009869818263, 26870.32824179372, 27241.641337386318, 27836.443271134867, 30071.849640752094, 30323.393532129234, 771.0222486497178, 889.666375109334, 899.4153800030033, 912.8219997100501, 921.3504479342048, 13589.0, 14458.20479873596, 14463.566093017227, 14615.26923653813, 14717.779233311509, 367132.0, 370102.0, 371595.0, 371849.0, 371909.0, 45667.314990275176, 46202.306965395546, 46330.76834615873, 46331.76834115808, 46413.53586464092, 1053.4837929414532, 1091.8471414002047, 1115.1469126118689, 1122.0, 1139.0830381542937, 25743.485130297664, 27890.86054569714, 28281.43437131287, 28502.85748571244, 28841.278968025967, 39597.80201099091, 40228.77597852184, 40243.0, 40248.597514025656, 40377.0, 251866.0, 253780.0, 253932.0, 254143.0, 254175.0, 24058.63912041286, 25162.874185628956, 25206.49587008286, 26054.60918086268, 26217.475650486504, 39137.80431097826, 40017.1996560073, 40140.79929600333, 40230.798846005586, 40863.0, 34115.82942085274, 34420.311593768485, 34486.31027379489, 34554.82722586371, 35016.474752879236, 34252.65747342594, 34826.0, 35098.473522897686, 35369.64630353663, 35398.29203415969, 33847.66152338445, 34306.48540271848, 34679.47980780341, 34783.0, 35104.12239694028, 30074.849625751733, 31949.840250798596, 32081.518777217894, 32502.512462313556, 32710.182245444055, 24258.63612045856, 24395.094795966128, 24631.0, 24737.257882263562, 25048.248552543453], "value": 16726.777768022177, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.8068791133008, 359.2402069622747, 365.1364522903334, 373.91026153723107, 385.4622801192337, 12200.877991220097, 15689.686206275883, 16020.279087441064, 16204.35182592695, 17032.148392580384, 16062.75905861413, 16414.7537786933, 16578.253978570963, 16658.250378732955, 16773.0, 4839.854804355875, 4845.927311090337, 4988.575971042465, 5011.574016208627, 5029.4216165141115, 3556.6621170988715, 3752.4558938953837, 4913.041956818422, 4988.825391111312, 4989.2017277235645, 3712.05342637627, 3767.2842159989514, 3772.0758414188563, 3776.603456637055, 5209.802013622737, 3739.2895349883433, 5820.301563812327, 5826.970865145647, 5835.679037652927, 5859.3554708981765, 4552.772361381918, 4827.155247831651, 5152.690838549662, 5157.974210128926, 5161.612879034087, 10735.677929662123, 10961.780764384668, 10962.725931851688, 10968.835467467994, 10969.780604387948, 1804.593966357572, 1813.8095499972576, 1966.3216190414284, 2136.9679454808193, 2170.967435488469, 8533.573321333908, 8552.61513231906, 8665.696700615448, 8832.602532886036, 9013.639454421815, 1641.351666091899, 1674.6985542602326, 1680.915954202285, 1705.1474262868567, 1717.3731587970426, 65125.348746512405, 65277.67361163164, 65722.34277657258, 66087.0, 67295.0, 9370.437773733598, 9407.482588457564, 9541.332106752461, 9577.90422095784, 9658.32391732586, 12973.0, 12980.480780768852, 12985.610431687064, 12991.740165196832, 13031.869681303066, 6425.1968503937005, 6549.6070235785055, 6559.311272316433, 6732.764353247613, 6782.898256526156, 6139.508839292936, 6195.411435913581, 6313.810585682437, 6341.904871426932, 6358.1416508771645, 3913.4325522799604, 4036.9394459083137, 4048.4939382577177, 4055.9391609125887, 4062.6343629073526, 1617.781599484078, 1633.1670847867672, 1702.7190513565124, 1706.9489404802137, 1778.2264714848823, 846.289117141604, 848.1179573243758, 894.0, 895.3553441522093, 902.634433054614, 15458.304376303093, 16063.277152527931, 16083.919580402024, 16107.516774496784, 16812.915935420246, 780.7033327335577, 795.8050277682005, 809.4212637963766, 823.9176082391833, 876.4171825735814, 8388.622511986976, 8878.245349145265, 9289.303302252358, 9328.533573321307, 9401.815447683079, 358150.0, 363689.0, 364089.0, 368857.0485836824, 369971.0, 38756.80621596874, 57702.0, 58103.70948145232, 67829.0, 69453.65273173703, 854.1842540373804, 861.6553378648465, 881.7927786970057, 892.5581836990731, 892.9196372326522, 13939.372728227458, 14544.563663090124, 15149.394024238907, 15957.7492182709, 16200.837991619934, 37198.0, 37285.81357093197, 37802.43296350612, 38071.428928566645, 38401.0, 47010.0, 47043.76478117587, 47648.28527572159, 49357.25964110469, 49745.0, 6298.779542715983, 6430.906745853123, 6652.966735166487, 6679.098321726505, 6773.221079575912, 11244.66266012021, 11572.685462907284, 11652.592159274385, 11757.353345566076, 12216.45025973851, 9696.95151524238, 9777.217822574035, 9891.653792117242, 10027.29808913369, 11041.613543525938, 10177.185825133824, 10270.43512606784, 10295.53670084863, 10560.84158737635, 10670.8399374011, 9921.355111917703, 10626.096781773636, 10643.361398316125, 11049.0, 11102.222844400814, 6518.282988871126, 7337.59643219628, 7339.926600733925, 7461.589612571361, 7777.066751989797, 8664.696735614476, 10359.430231337348, 10373.0, 10427.843582346119, 10705.732356691145], "value": 7616.466782488091, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.6202101390595, 1338.5315139701106, 1342.4361768057415, 1561.461295852931, 1581.3200323860735, 7133.393661538769, 7513.2862378074, 7520.097588289399, 7520.360769334613, 7578.848423031536, 6408.551401401904, 6626.304238054995, 7150.070490836197, 7366.152892417374, 7543.509671871325, 2102.3692892132376, 2143.356992902131, 2147.7530084040377, 2149.0651566568513, 2149.408912549046, 1997.9700304495443, 2018.8183063524352, 2041.4079916824103, 2059.5983783162287, 2060.330392622396, 2079.5217100066993, 2122.246602456129, 2123.4266747978036, 2125.0543508138885, 2134.253011445989, 2079.9688004679865, 2081.4276074079676, 2084.801943815335, 2085.979140208594, 2090.9895450522804, 1943.620993906189, 1952.375239923225, 1966.410076976901, 1969.2319995201883, 1972.615340008699, 7440.107187137578, 7619.352355049828, 7623.466357354987, 7628.0846298443985, 7630.7329243476215, 4305.13897220554, 4424.513303536608, 4455.487618923833, 4456.376107344942, 4462.040661257845, 2677.3574342157935, 2677.651905252324, 2738.2880451082665, 2809.466201421744, 2834.985825070882, 837.6440012994453, 851.221132663612, 862.7066797288952, 874.2481465939287, 886.0474989386436, 10229.079382855505, 10275.640352587698, 10280.640177593748, 10280.794384112276, 10283.228757843117, 3795.525559305087, 3812.866549670748, 3964.306246406867, 3992.121733218687, 4069.1251380953236, 8763.298936085226, 8779.956100219586, 8805.295576353876, 8805.339599530062, 8815.955920220485, 4448.377227188196, 4453.3320001999955, 4454.799534020977, 4459.219636563588, 4461.063176732858, 3396.575428071491, 3512.806795626214, 3874.7868867212574, 4116.300228961084, 4116.938245926313, 3397.6602339765827, 3541.982290088533, 3547.875824346187, 3551.964480355215, 3661.5423072115987, 1106.8727096383857, 1156.6125348008343, 1160.1067178272683, 1163.4706208675032, 1163.8241354484812, 695.3255342317943, 798.9201079892081, 808.2402541610867, 809.0251247247053, 820.9819823419036, 4962.280469331927, 4972.776225069808, 5011.599072074226, 5013.172826483589, 5244.501772331622, 382.5868062492501, 383.2430948876003, 385.44303481469007, 390.04050036908956, 853.1852081262504, 3581.3016461789703, 3623.510826038451, 3659.4876717259604, 3702.241040586673, 3797.145642230476, 8605.698800541952, 8986.32602554798, 9013.77465563353, 9024.819503609891, 9044.0, 8968.596413161424, 8988.146126118008, 8995.28037756978, 9030.142136497023, 9043.547822608974, 7002.579845209304, 7186.065811444583, 7206.459515536356, 7206.603636799921, 7229.638518074181, 5012.8496145115705, 5136.640435169502, 5142.6914385137015, 5150.639455238097, 5169.405518365436, 8471.152884711479, 8642.870356944524, 8643.56782160902, 8648.0, 8734.694285700225, 8588.65645374178, 8602.139786021347, 8746.868796968178, 8810.471371717718, 8821.823563528566, 5986.9401305986385, 6023.247094113236, 6024.548158888013, 6057.0, 6075.787347442818, 6969.54697944632, 7027.367536921702, 7029.613371264425, 7030.472714546532, 7034.929650703632, 6351.396617321347, 6381.266154392119, 6432.807015789534, 6583.572067815577, 6613.801585952429, 6193.628382297076, 6238.469730072813, 6385.29761726219, 6400.903986440114, 6418.903716444163, 5950.821475355746, 6033.456988871023, 6049.546284028627, 6051.969740151271, 6055.515558755377, 4471.3740076388685, 4553.157665831832, 4606.930896036495, 4615.79228934692, 4685.508021657677, 4407.669424793217, 4444.200043992112, 4486.932696009497, 4528.252838281646, 4631.560001799824], "value": 3896.290874309382, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [266.40325670498083, 268.1205645482817, 279.75661174777946, 281.1032805350929, 285.21565694340563, 4603.217453032984, 4741.8814529636775, 4799.808007679693, 4811.989482208736, 4817.445993710724, 4568.634509239261, 4687.632745463545, 4707.152712511746, 4724.31497432872, 4727.8818029549275, 3526.365254254233, 3713.814309284525, 3715.1640880801874, 3724.4413337999245, 3738.9904725724036, 3530.8411121499594, 3617.7027587481875, 3662.157703728131, 3673.669369756721, 3687.1703866630064, 3646.0, 3651.4522821576843, 3652.589291067896, 3656.305301992626, 3659.8719044833438, 3643.0892276930767, 3645.2162785001087, 3654.0, 3673.2653469306247, 3673.302072606223, 3174.0, 3230.628477725068, 3235.223546348883, 3241.1086951088405, 3251.235959549504, 4530.660200484944, 4563.110193512266, 4567.2920697291975, 4598.632109431271, 4600.239856086355, 4212.094399704079, 4218.641415479688, 4220.6412454941365, 4222.9577704222875, 4242.681798865066, 4775.594074503671, 4952.133376659106, 4954.87612809679, 4968.701877887338, 4992.126377883892, 3481.2863363010774, 3483.1988642612087, 3484.686378225972, 3487.5989261235027, 3488.337215928965, 5231.659942103751, 5247.291615631917, 5263.815766448156, 5267.710275934784, 5267.9736601316745, 3465.2722928184858, 3564.2515071835205, 3574.6595026864925, 3577.5528058992627, 3581.94627080594, 3602.0994751312173, 3604.387254166798, 3608.404613238839, 3608.6210947850623, 3642.2351306225987, 4174.102567947845, 4180.561041090642, 4199.286121359315, 4207.915841683211, 4210.221109094828, 4692.53074692528, 4827.865451618867, 4840.75796210188, 4969.2546118081855, 4985.0, 1211.9760000798688, 1226.693326668333, 1231.2427856867962, 1232.9938350308191, 1233.210745123122, 754.0649594502777, 787.9448438609357, 799.7084708196221, 801.5431204213543, 804.5816175588778, 4005.679545636342, 4007.757595145514, 4009.3184158693093, 4011.6389524942897, 4020.9195816084098, 4556.585009944734, 4560.651264598734, 4574.722634336839, 4588.242939914877, 4606.631469482433, 3974.5627980922077, 3993.7004724645767, 4005.35914253718, 4008.719389642697, 4012.538558065801, 2307.042577330423, 2388.5103553771437, 2394.245812569035, 2405.3883897788523, 2469.2221950085664, 4268.509121451073, 4274.914501709948, 4309.633681137076, 4338.0, 4356.978215108904, 4555.2711566149255, 4585.770711464414, 4593.793279302439, 4630.143423466669, 4649.721016739007, 4134.772587507656, 4231.449911511484, 4279.422277992493, 4326.44248070688, 4347.608715215646, 4523.547645235451, 4526.298423744325, 4527.1931402530645, 4543.727756228262, 4549.45406551216, 4394.813400381943, 4441.733495990251, 4456.796664900394, 4471.977640111779, 4481.327800829901, 4288.292431748727, 4351.8694439166875, 4359.760213188305, 4393.956060439355, 4530.252508336088, 3598.208394153282, 3600.6219346969237, 3618.6743193112748, 3620.7465477416326, 3631.8728844490315, 4940.604751619933, 5163.4578369270685, 5178.792848286026, 5219.347581552306, 5229.790808367623, 4803.183458811941, 4926.433460152129, 4986.601071914166, 5002.924956125588, 5002.949970500248, 4988.625853060962, 5006.724630145377, 5028.120078986236, 5036.874078148076, 5040.319556859777, 4859.8579333855805, 4927.507249275044, 5001.474845141208, 5003.899922001612, 5022.171341728574, 4990.675606085593, 5048.167052436307, 5050.570701490415, 5064.215046667772, 5064.468230835857, 4937.0372777308085, 4960.461178022214, 4963.528464795839, 5000.499950004971, 5003.498950314964], "value": 3611.2247480537785, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.5316999935158, 607.3076692570473, 620.1380081686453, 634.7936920500837, 734.9448791340648, 12199.634010979673, 12953.35233238339, 12958.805617915727, 12963.416646250918, 12964.74070518589, 12012.399380031007, 12097.576584819533, 12107.636770896886, 12114.575989840358, 12123.636290911287, 714.3891972363646, 729.7445893937106, 730.9561426314411, 731.1737736357908, 731.5574077683005, 732.3226015935265, 737.0823324960431, 739.3419856327846, 742.0205328965767, 742.1279996004699, 774.6707649249047, 775.1163673412315, 775.8099265679916, 776.1501156233915, 776.54572075336, 769.7536788227769, 770.3067239484453, 770.452978385347, 771.0824119298045, 771.4522688890894, 572.1846368924266, 572.3503823160701, 572.7222297185862, 572.7623036439873, 572.8338781753287, 10521.947390263076, 10577.36535807854, 10578.947105264502, 10600.363978161335, 10691.518881650345, 10936.125109991182, 10937.0, 11111.499982500807, 11240.49417776202, 11311.604093856758, 8699.130086991314, 8818.735437936872, 8847.955760221223, 9253.814923701555, 9256.166944974984, 3116.9688303116905, 3158.3525377297597, 3182.9363412731846, 3211.2935154266024, 3230.111719277194, 63757.36242637561, 64614.353856461305, 64729.0, 65713.0, 66660.3333966659, 8551.059383467813, 8691.956540217385, 8693.304535637133, 8719.65121395137, 8784.824303513893, 17071.146442678066, 17177.570560735832, 17199.91400042992, 17236.0, 17249.741253881202, 6592.901106483407, 6674.599524028574, 6749.190097188271, 6810.740013097593, 7043.718251269995, 3581.265840502743, 3684.1158122050515, 3720.8511659533856, 3825.2923209206388, 3853.2293541291856, 2808.606795048695, 2827.717228277197, 2831.801773875809, 2839.7870159738104, 2886.682464928856, 456.3998342180089, 457.6316065567184, 464.45426623717674, 467.0961689131473, 471.3118846484103, 484.3678998906461, 512.9307543481582, 517.93047357208, 519.9454057324002, 523.2595876834237, 7779.788058929938, 7788.221177882167, 7960.323372513401, 8047.637856296481, 8464.280536154372, 468.8968426946066, 497.5795452842415, 547.6905548365161, 565.2482198675751, 580.7880123754884, 3773.0, 3813.542374915028, 3853.6917046636204, 3877.3408520551575, 3919.9608003919598, 102261.0, 104513.47743261234, 106513.46743266234, 107224.46387768011, 109993.45003274933, 77733.0, 91460.0, 91637.54181229051, 91997.5400122995, 92776.53611731899, 45968.0, 70055.0, 79883.0, 79902.6004869972, 80818.19181808224, 7373.63131843395, 7392.630368481447, 7567.205443428361, 7772.154155482665, 7795.727149549739, 41916.371254430596, 47117.764411177726, 47693.28460073171, 48303.75848120737, 48783.75608121937, 64185.35814641981, 64261.35738642554, 69616.6519167401, 70875.64562177156, 71398.64300678464, 8532.488050716976, 8711.564421779012, 8817.426867253607, 9230.984591694774, 9678.612855485984, 10436.843447348145, 10729.103142151731, 10947.178961577754, 11599.362035088152, 11660.825087623523, 9762.75593110178, 9940.6580111684, 10129.64546240878, 10227.590896364061, 10271.640492583023, 9659.46872921968, 9712.70861874145, 9827.11555959967, 9993.150582200595, 10050.748731281776, 11018.393988330397, 11770.176087674123, 11772.941135294268, 12089.093318001362, 13085.672858178621, 9682.951585242028, 9775.511224438607, 9921.00789921002, 9959.502024898871, 10399.064084232456, 10200.693979180636, 10231.43727095017, 10515.421651809223, 10580.735481612714, 10592.470376480991], "value": 6199.186099847637, "unit": "score"}], "name": "dromaeo_css", "value": 6082.239658788944, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 116.0, 116.0, 115.0, 115.0, 116.0, 115.0, 116.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 124.0, 170.0, 131.0, 125.0, 127.0, 122.0, 157.0, 123.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 161.0, 160.0, 161.0, 161.0, 160.0, 165.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 119.0, 78.0, 78.0, 78.0, 78.0, 106.0, 77.0], "value": 84.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 125.0, 84.0, 83.0, 82.0, 113.0, 83.0, 83.0, 125.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 86.0, 83.0, 83.0, 82.0, 82.0, 82.0, 81.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 138.0, 131.0, 131.0, 130.0, 134.0, 133.0, 182.0, 134.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 179.0, 173.0, 173.0, 174.0, 178.0, 174.0, 173.0, 173.0, 174.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 69.0, 76.0, 69.0, 68.0, 67.0, 68.0, 69.0, 71.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1547.6999999999998, "alertThreshold": 2.0}]} 11:43:53 INFO - Return code: 0 11:43:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:43:53 INFO - # TBPL SUCCESS # 11:43:53 INFO - Running post-action listener: _resource_record_post_action 11:43:53 INFO - [mozharness: 2016-09-22 18:43:53.232146Z] Finished run-tests step (success) 11:43:53 INFO - Running post-run listener: _resource_record_post_run 11:43:53 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 390569984; Read time: 116; Write time: 271240 11:43:53 INFO - TinderboxPrint: CPU usage
13.1% 11:43:53 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 116 11:43:53 INFO - TinderboxPrint: I/O write bytes / time
390,569,984 / 271,240 11:43:53 INFO - TinderboxPrint: CPU idle
8,334.4 (86.9%) 11:43:53 INFO - TinderboxPrint: CPU user
1,206.7 (12.6%) 11:43:53 INFO - TinderboxPrint: Swap in / out
0 / 0 11:43:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99721216; Read time: 0; Write time: 87096 11:43:53 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290848768; Read time: 104; Write time: 184144 11:43:53 INFO - Running post-run listener: _upload_blobber_files 11:43:53 INFO - Blob upload gear active. 11:43:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:43:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:43:53 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:43:53 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:43:54 INFO - (blobuploader) - INFO - Open directory for files ... 11:43:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:43:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:43:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:43:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:43:59 INFO - (blobuploader) - INFO - Done attempting. 11:43:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:43:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:43:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:44:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:00 INFO - (blobuploader) - INFO - Done attempting. 11:44:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:44:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:44:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:00 INFO - (blobuploader) - INFO - Done attempting. 11:44:00 INFO - (blobuploader) - INFO - Iteration through files over. 11:44:00 INFO - Return code: 0 11:44:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:44:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:44:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/03f4b3ecc93c91a044ddd75789db1b6b4bd8fccb5548741ee175f6b7da5d6c569ec70db3d741bb3d3de421b75a45fd23f1e32f880d9fa01ec8a21161fe72ffe1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/087ab3dba9c4b72db7bf67a851aee4254161c3d2133c0676181773ad9886083dfb28ed50006ce0817df02d586b8af5a8c1376f4dd3ae2c3dc873efbabaafab2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/106fe4cef5388bab9a6293b8d8a8cc433b1249064287567925710cbd971a3f898c732d54c80a21eec79b635ff669bc24e10b7ee03e9308119d0516479ad3e4f6"} 11:44:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:44:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:44:00 INFO - Contents: 11:44:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/03f4b3ecc93c91a044ddd75789db1b6b4bd8fccb5548741ee175f6b7da5d6c569ec70db3d741bb3d3de421b75a45fd23f1e32f880d9fa01ec8a21161fe72ffe1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/087ab3dba9c4b72db7bf67a851aee4254161c3d2133c0676181773ad9886083dfb28ed50006ce0817df02d586b8af5a8c1376f4dd3ae2c3dc873efbabaafab2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/106fe4cef5388bab9a6293b8d8a8cc433b1249064287567925710cbd971a3f898c732d54c80a21eec79b635ff669bc24e10b7ee03e9308119d0516479ad3e4f6"} 11:44:00 INFO - Running post-run listener: copy_logs_to_upload_dir 11:44:00 INFO - Copying logs to upload dir... 11:44:00 INFO - mkdir: /builds/slave/test/build/upload/logs 11:44:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.082392 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-22 11:44:00.419155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 11:44:00.423139) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/03f4b3ecc93c91a044ddd75789db1b6b4bd8fccb5548741ee175f6b7da5d6c569ec70db3d741bb3d3de421b75a45fd23f1e32f880d9fa01ec8a21161fe72ffe1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/087ab3dba9c4b72db7bf67a851aee4254161c3d2133c0676181773ad9886083dfb28ed50006ce0817df02d586b8af5a8c1376f4dd3ae2c3dc873efbabaafab2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/106fe4cef5388bab9a6293b8d8a8cc433b1249064287567925710cbd971a3f898c732d54c80a21eec79b635ff669bc24e10b7ee03e9308119d0516479ad3e4f6"} build_url:https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/FWG6DySgQuyyOzrKZcrEmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/03f4b3ecc93c91a044ddd75789db1b6b4bd8fccb5548741ee175f6b7da5d6c569ec70db3d741bb3d3de421b75a45fd23f1e32f880d9fa01ec8a21161fe72ffe1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/087ab3dba9c4b72db7bf67a851aee4254161c3d2133c0676181773ad9886083dfb28ed50006ce0817df02d586b8af5a8c1376f4dd3ae2c3dc873efbabaafab2c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/106fe4cef5388bab9a6293b8d8a8cc433b1249064287567925710cbd971a3f898c732d54c80a21eec79b635ff669bc24e10b7ee03e9308119d0516479ad3e4f6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 11:44:00.453046) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 11:44:00.453389) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1474567546.998533-1607769599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004346 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 11:44:00.538310) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 11:44:00.539065) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 11:44:00.539744) ========= ========= Total master_lag: 0.18 =========