builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1474558991.37 results: success (0) buildid: 20160922080506 builduid: 7437edbd5dda401ea7e8b64f57ecc69a revision: 190e45ee01153267e1507726381f41379d2e3673 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 08:43:11.374554) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 08:43:11.375017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 08:43:11.375306) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 08:43:11.411677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 08:43:11.411937) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 08:43:11-- 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% 211M=0s 2016-09-22 08:43:11 (211 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125882 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 08:43:11.551134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 08:43:11.551471) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016483 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 08:43:11.601611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 08:43:11.601918) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 190e45ee01153267e1507726381f41379d2e3673 --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 190e45ee01153267e1507726381f41379d2e3673 --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=9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 08:43:11,863 truncating revision to first 12 chars 2016-09-22 08:43:11,863 Setting DEBUG logging. 2016-09-22 08:43:11,863 attempt 1/10 2016-09-22 08:43:11,863 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/190e45ee0115?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 08:43:12,905 unpacking tar archive at: fx-team-190e45ee0115/testing/mozharness/ program finished with exit code 0 elapsedTime=1.392408 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-22 08:43:13.008314) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 08:43:13.008596) ========= script_repo_revision: 190e45ee01153267e1507726381f41379d2e3673 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 08:43:13.008965) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 08:43:13.009326) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 08:43:13.022548) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-22 08:43:13.022819) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:43:13 INFO - MultiFileLogger online at 20160922 08:43:13 in /builds/slave/test 08:43:13 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 08:43:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:43:13 INFO - {'append_to_log': False, 08:43:13 INFO - 'base_work_dir': '/builds/slave/test', 08:43:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:43:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:43:13 INFO - 'branch': 'Fx-Team-Non-PGO', 08:43:13 INFO - 'buildbot_json_path': 'buildprops.json', 08:43:13 INFO - 'config_files': ('talos/linux_config.py',), 08:43:13 INFO - 'default_actions': ('clobber', 08:43:13 INFO - 'read-buildbot-config', 08:43:13 INFO - 'download-and-extract', 08:43:13 INFO - 'populate-webroot', 08:43:13 INFO - 'create-virtualenv', 08:43:13 INFO - 'install', 08:43:13 INFO - 'run-tests'), 08:43:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:43:13 INFO - 'download_minidump_stackwalk': True, 08:43:13 INFO - 'download_symbols': 'ondemand', 08:43:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:43:13 INFO - 'tooltool.py': '/tools/tooltool.py', 08:43:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:43:13 INFO - '/tools/misc-python/virtualenv.py')}, 08:43:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:43:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:43:13 INFO - 'installer_path': 'installer.exe', 08:43:13 INFO - 'log_level': 'info', 08:43:13 INFO - 'log_name': 'talos', 08:43:13 INFO - 'log_to_console': True, 08:43:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:43:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:43:13 INFO - 'opt_config_files': (), 08:43:13 INFO - 'pip_index': False, 08:43:13 INFO - 'sps_profile': False, 08:43:13 INFO - 'sps_profile_interval': 0, 08:43:13 INFO - 'suite': 'dromaeojs', 08:43:13 INFO - 'system_bits': '32', 08:43:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:43:13 INFO - 'title': 'talos-linux64-ix-040', 08:43:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:43:13 INFO - 'use_talos_json': True, 08:43:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:43:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:43:13 INFO - 'work_dir': 'build'} 08:43:13 INFO - [mozharness: 2016-09-22 15:43:13.379130Z] Running clobber step. 08:43:13 INFO - Running pre-action listener: _resource_record_pre_action 08:43:13 INFO - Running main action method: clobber 08:43:13 INFO - rmtree: /builds/slave/test/build 08:43:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:43:14 INFO - Running post-action listener: _resource_record_post_action 08:43:14 INFO - [mozharness: 2016-09-22 15:43:14.338709Z] Finished clobber step (success) 08:43:14 INFO - [mozharness: 2016-09-22 15:43:14.338811Z] Running read-buildbot-config step. 08:43:14 INFO - Running pre-action listener: _resource_record_pre_action 08:43:14 INFO - Running main action method: read_buildbot_config 08:43:14 INFO - Using buildbot properties: 08:43:14 INFO - { 08:43:14 INFO - "project": "", 08:43:14 INFO - "product": "firefox", 08:43:14 INFO - "script_repo_revision": "production", 08:43:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:43:14 INFO - "repository": "", 08:43:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:43:14 INFO - "buildid": "20160922080506", 08:43:14 INFO - "pgo_build": "False", 08:43:14 INFO - "basedir": "/builds/slave/test", 08:43:14 INFO - "buildnumber": 2172, 08:43:14 INFO - "slavename": "talos-linux64-ix-040", 08:43:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:43:14 INFO - "platform": "ubuntu64_hw", 08:43:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:43:14 INFO - "branch": "fx-team", 08:43:14 INFO - "repo_path": "integration/fx-team", 08:43:14 INFO - "revision": "190e45ee01153267e1507726381f41379d2e3673", 08:43:14 INFO - "stage_platform": "linux64", 08:43:14 INFO - "builduid": "7437edbd5dda401ea7e8b64f57ecc69a", 08:43:14 INFO - "slavebuilddir": "test" 08:43:14 INFO - } 08:43:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 08:43:14 INFO - Running post-action listener: _resource_record_post_action 08:43:14 INFO - [mozharness: 2016-09-22 15:43:14.341258Z] Finished read-buildbot-config step (success) 08:43:14 INFO - [mozharness: 2016-09-22 15:43:14.341348Z] Running download-and-extract step. 08:43:14 INFO - Running pre-action listener: _resource_record_pre_action 08:43:14 INFO - Running main action method: download_and_extract 08:43:14 INFO - mkdir: /builds/slave/test/build/tests 08:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:14 INFO - trying https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:43:14 INFO - Downloading https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/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 08:43:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/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 08:43:14 INFO - Downloaded 1361 bytes. 08:43:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:43:14 INFO - Using the following test package requirements: 08:43:14 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:43:14 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:43:14 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:43:14 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:14 INFO - u'jsshell-linux-x86_64.zip'], 08:43:14 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:43:14 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:43:14 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:43:14 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:43:14 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:43:14 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:43:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:43:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:43:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:43:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:43:14 INFO - Fetch https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:43:15 INFO - Expected file size: 20373210 08:43:19 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 08:43:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:43:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:43:19 INFO - Fetch https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:43:20 INFO - Expected file size: 20373210 08:43:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 08:43:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:43:25 INFO - Fetch https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:43:25 INFO - Expected file size: 14414059 08:43:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:26 INFO - trying https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:43:26 INFO - Downloading https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/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 08:43:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/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 08:43:27 INFO - Downloaded 55702780 bytes. 08:43:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:43:27 INFO - mkdir: /builds/slave/test/properties 08:43:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:43:27 INFO - Writing to file /builds/slave/test/properties/build_url 08:43:27 INFO - Contents: 08:43:27 INFO - build_url:https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:43:27 INFO - Running post-action listener: _resource_record_post_action 08:43:27 INFO - Running post-action listener: set_extra_try_arguments 08:43:27 INFO - [mozharness: 2016-09-22 15:43:27.989646Z] Finished download-and-extract step (success) 08:43:27 INFO - [mozharness: 2016-09-22 15:43:27.989877Z] Running populate-webroot step. 08:43:27 INFO - Running pre-action listener: _resource_record_pre_action 08:43:27 INFO - Running main action method: populate_webroot 08:43:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:43:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:43:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:43:27 INFO - '--tppagecycles', 08:43:27 INFO - '7'], 08:43:27 INFO - 'tests': ['tsvgm']}}, 08:43:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:43:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:43:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:43:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:43:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:43:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:43:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:27 INFO - 'talos_options': ['--disable-e10s'], 08:43:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:28 INFO - 'talos_options': ['--disable-e10s'], 08:43:28 INFO - 'tests': ['damp', 'tps']}, 08:43:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:28 INFO - 'tests': ['damp', 'tps']}, 08:43:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:43:28 INFO - 'tests': ['dromaeo_dom']}, 08:43:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:43:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:43:28 INFO - 'tests': ['basic_compositor_video']}, 08:43:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:43:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:43:28 INFO - 'tests': ['a11yr', 08:43:28 INFO - 'ts_paint', 08:43:28 INFO - 'tpaint', 08:43:28 INFO - 'sessionrestore', 08:43:28 INFO - 'sessionrestore_no_auto_restore', 08:43:28 INFO - 'tabpaint']}, 08:43:28 INFO - 'other-e10s': {'tests': ['a11yr', 08:43:28 INFO - 'ts_paint', 08:43:28 INFO - 'tpaint', 08:43:28 INFO - 'sessionrestore', 08:43:28 INFO - 'sessionrestore_no_auto_restore', 08:43:28 INFO - 'tabpaint']}, 08:43:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:43:28 INFO - 'ts_paint', 08:43:28 INFO - 'tpaint', 08:43:28 INFO - 'sessionrestore', 08:43:28 INFO - 'sessionrestore_no_auto_restore', 08:43:28 INFO - 'tabpaint']}, 08:43:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:43:28 INFO - 'ts_paint', 08:43:28 INFO - 'tpaint', 08:43:28 INFO - 'sessionrestore', 08:43:28 INFO - 'sessionrestore_no_auto_restore', 08:43:28 INFO - 'tabpaint']}, 08:43:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:43:28 INFO - 'tests': ['a11yr', 08:43:28 INFO - 'ts_paint', 08:43:28 INFO - 'tpaint', 08:43:28 INFO - 'sessionrestore', 08:43:28 INFO - 'sessionrestore_no_auto_restore', 08:43:28 INFO - 'tabpaint']}, 08:43:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:43:28 INFO - 'tests': ['a11yr', 08:43:28 INFO - 'ts_paint', 08:43:28 INFO - 'tpaint', 08:43:28 INFO - 'sessionrestore', 08:43:28 INFO - 'sessionrestore_no_auto_restore', 08:43:28 INFO - 'tabpaint']}, 08:43:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:43:28 INFO - 'tests': ['tsvgx', 08:43:28 INFO - 'tsvgr_opacity', 08:43:28 INFO - 'tart', 08:43:28 INFO - 'tscrollx', 08:43:28 INFO - 'cart']}, 08:43:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:43:28 INFO - 'tsvgr_opacity', 08:43:28 INFO - 'tart', 08:43:28 INFO - 'tscrollx', 08:43:28 INFO - 'cart']}, 08:43:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:28 INFO - 'talos_options': ['--disable-e10s'], 08:43:28 INFO - 'tests': ['tp5o']}, 08:43:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:28 INFO - 'tests': ['tp5o']}, 08:43:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:28 INFO - 'talos_options': ['--disable-e10s', 08:43:28 INFO - '--xperf_path', 08:43:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:28 INFO - 'tests': ['tp5n']}, 08:43:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:28 INFO - 'talos_options': ['--xperf_path', 08:43:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:28 INFO - 'tests': ['tp5n']}}, 08:43:28 INFO - 'talos.zip': {'path': '', 08:43:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:43:28 INFO - Running post-action listener: _resource_record_post_action 08:43:28 INFO - [mozharness: 2016-09-22 15:43:28.005916Z] Finished populate-webroot step (success) 08:43:28 INFO - [mozharness: 2016-09-22 15:43:28.006025Z] Running create-virtualenv step. 08:43:28 INFO - Running pre-action listener: _resource_record_pre_action 08:43:28 INFO - Running main action method: create_virtualenv 08:43:28 INFO - Creating virtualenv /builds/slave/test/build/venv 08:43: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 08:43:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:43:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:43:28 INFO - Using real prefix '/usr' 08:43:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:43:28 INFO - Installing distribute.............................................................................................................................................................................................done. 08:43:30 INFO - Installing pip.................done. 08:43:30 INFO - Return code: 0 08:43:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:30 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 0x7f730d92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f60>, '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 0x1eb2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb31d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', '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 08:43:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:43:30 INFO - Using env: {'DISPLAY': ':0', 08:43:30 INFO - 'HOME': '/home/cltbld', 08:43:30 INFO - 'LANG': 'en_US.UTF-8', 08:43:30 INFO - 'LANGUAGE': 'en_US:en', 08:43:30 INFO - 'LOGNAME': 'cltbld', 08:43:30 INFO - 'MAIL': '/var/mail/cltbld', 08:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:30 INFO - 'MOZ_NO_REMOTE': '1', 08:43:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:30 INFO - 'NO_EM_RESTART': '1', 08:43:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:30 INFO - 'PWD': '/builds/slave/test', 08:43:30 INFO - 'SHELL': '/bin/bash', 08:43:30 INFO - 'SHLVL': '1', 08:43:30 INFO - 'TERM': 'linux', 08:43:30 INFO - 'TMOUT': '86400', 08:43:30 INFO - 'USER': 'cltbld', 08:43:30 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', 08:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:30 INFO - '_': '/tools/buildbot/bin/python'} 08:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:43:30 INFO - Cleaning up... 08:43:30 INFO - Return code: 0 08:43:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:30 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 0x7f730d92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f60>, '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 0x1eb2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb31d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', '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 08:43:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:43:30 INFO - Using env: {'DISPLAY': ':0', 08:43:30 INFO - 'HOME': '/home/cltbld', 08:43:30 INFO - 'LANG': 'en_US.UTF-8', 08:43:30 INFO - 'LANGUAGE': 'en_US:en', 08:43:30 INFO - 'LOGNAME': 'cltbld', 08:43:30 INFO - 'MAIL': '/var/mail/cltbld', 08:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:30 INFO - 'MOZ_NO_REMOTE': '1', 08:43:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:30 INFO - 'NO_EM_RESTART': '1', 08:43:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:30 INFO - 'PWD': '/builds/slave/test', 08:43:30 INFO - 'SHELL': '/bin/bash', 08:43:30 INFO - 'SHLVL': '1', 08:43:30 INFO - 'TERM': 'linux', 08:43:30 INFO - 'TMOUT': '86400', 08:43:30 INFO - 'USER': 'cltbld', 08:43:30 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', 08:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:30 INFO - '_': '/tools/buildbot/bin/python'} 08:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:31 INFO - Downloading/unpacking psutil>=3.1.1 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:43:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:33 INFO - Installing collected packages: psutil 08:43:33 INFO - Running setup.py install for psutil 08:43:33 INFO - building 'psutil._psutil_linux' extension 08:43: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 08:43:33 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 08:43:33 INFO - building 'psutil._psutil_posix' extension 08:43:33 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 08:43:33 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 08:43:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:33 INFO - Successfully installed psutil 08:43:33 INFO - Cleaning up... 08:43:33 INFO - Return code: 0 08:43:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:43:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f730d92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f60>, '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 0x1eb2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb31d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', '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 08:43:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:43:33 INFO - Using env: {'DISPLAY': ':0', 08:43:33 INFO - 'HOME': '/home/cltbld', 08:43:33 INFO - 'LANG': 'en_US.UTF-8', 08:43:33 INFO - 'LANGUAGE': 'en_US:en', 08:43:33 INFO - 'LOGNAME': 'cltbld', 08:43:33 INFO - 'MAIL': '/var/mail/cltbld', 08:43:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:33 INFO - 'MOZ_NO_REMOTE': '1', 08:43:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:33 INFO - 'NO_EM_RESTART': '1', 08:43:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:33 INFO - 'PWD': '/builds/slave/test', 08:43:33 INFO - 'SHELL': '/bin/bash', 08:43:33 INFO - 'SHLVL': '1', 08:43:33 INFO - 'TERM': 'linux', 08:43:33 INFO - 'TMOUT': '86400', 08:43:33 INFO - 'USER': 'cltbld', 08:43:33 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', 08:43:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:33 INFO - '_': '/tools/buildbot/bin/python'} 08:43:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:43:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:43:35 INFO - Installing collected packages: mozsystemmonitor 08:43:35 INFO - Running setup.py install for mozsystemmonitor 08:43:35 INFO - Successfully installed mozsystemmonitor 08:43:35 INFO - Cleaning up... 08:43:35 INFO - Return code: 0 08:43:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:35 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 0x7f730d92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f60>, '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 0x1eb2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb31d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', '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 08:43:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:43:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:43:35 INFO - Using env: {'DISPLAY': ':0', 08:43:35 INFO - 'HOME': '/home/cltbld', 08:43:35 INFO - 'LANG': 'en_US.UTF-8', 08:43:35 INFO - 'LANGUAGE': 'en_US:en', 08:43:35 INFO - 'LOGNAME': 'cltbld', 08:43:35 INFO - 'MAIL': '/var/mail/cltbld', 08:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:35 INFO - 'MOZ_NO_REMOTE': '1', 08:43:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:35 INFO - 'NO_EM_RESTART': '1', 08:43:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:35 INFO - 'PWD': '/builds/slave/test', 08:43:35 INFO - 'SHELL': '/bin/bash', 08:43:35 INFO - 'SHLVL': '1', 08:43:35 INFO - 'TERM': 'linux', 08:43:35 INFO - 'TMOUT': '86400', 08:43:35 INFO - 'USER': 'cltbld', 08:43:35 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', 08:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:35 INFO - '_': '/tools/buildbot/bin/python'} 08:43:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:36 INFO - Downloading/unpacking jsonschema==2.5.1 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:43:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:38 INFO - Downloading functools32-3.2.3-2.tar.gz 08:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:43:38 INFO - warning: no files found matching '*.txt' 08:43:38 INFO - no previously-included directories found matching 'build' 08:43:38 INFO - no previously-included directories found matching 'dist' 08:43:38 INFO - no previously-included directories found matching '.git*' 08:43:38 INFO - Installing collected packages: jsonschema, functools32 08:43:38 INFO - Running setup.py install for functools32 08:43:38 INFO - warning: no files found matching '*.txt' 08:43:38 INFO - no previously-included directories found matching 'build' 08:43:38 INFO - no previously-included directories found matching 'dist' 08:43:38 INFO - no previously-included directories found matching '.git*' 08:43:38 INFO - Successfully installed jsonschema functools32 08:43:38 INFO - Cleaning up... 08:43:38 INFO - Return code: 0 08:43:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:38 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 0x7f730d92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f60>, '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 0x1eb2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb31d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', '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 08:43:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:43:38 INFO - Using env: {'DISPLAY': ':0', 08:43:38 INFO - 'HOME': '/home/cltbld', 08:43:38 INFO - 'LANG': 'en_US.UTF-8', 08:43:38 INFO - 'LANGUAGE': 'en_US:en', 08:43:38 INFO - 'LOGNAME': 'cltbld', 08:43:38 INFO - 'MAIL': '/var/mail/cltbld', 08:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:38 INFO - 'MOZ_NO_REMOTE': '1', 08:43:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:38 INFO - 'NO_EM_RESTART': '1', 08:43:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:38 INFO - 'PWD': '/builds/slave/test', 08:43:38 INFO - 'SHELL': '/bin/bash', 08:43:38 INFO - 'SHLVL': '1', 08:43:38 INFO - 'TERM': 'linux', 08:43:38 INFO - 'TMOUT': '86400', 08:43:38 INFO - 'USER': 'cltbld', 08:43:38 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', 08:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:38 INFO - '_': '/tools/buildbot/bin/python'} 08:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:43:38 INFO - Cleaning up... 08:43:38 INFO - Return code: 0 08:43:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:38 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 0x7f730d92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f60>, '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 0x1eb2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb31d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', '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 08:43:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:43:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:43:38 INFO - Using env: {'DISPLAY': ':0', 08:43:38 INFO - 'HOME': '/home/cltbld', 08:43:38 INFO - 'LANG': 'en_US.UTF-8', 08:43:38 INFO - 'LANGUAGE': 'en_US:en', 08:43:38 INFO - 'LOGNAME': 'cltbld', 08:43:38 INFO - 'MAIL': '/var/mail/cltbld', 08:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:38 INFO - 'MOZ_NO_REMOTE': '1', 08:43:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:38 INFO - 'NO_EM_RESTART': '1', 08:43:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:38 INFO - 'PWD': '/builds/slave/test', 08:43:38 INFO - 'SHELL': '/bin/bash', 08:43:38 INFO - 'SHLVL': '1', 08:43:38 INFO - 'TERM': 'linux', 08:43:38 INFO - 'TMOUT': '86400', 08:43:38 INFO - 'USER': 'cltbld', 08:43:38 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', 08:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:38 INFO - '_': '/tools/buildbot/bin/python'} 08:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:40 INFO - Downloading blobuploader-1.2.4.tar.gz 08:43:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:43:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:43:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:41 INFO - Downloading docopt-0.6.1.tar.gz 08:43:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:43:41 INFO - Installing collected packages: blobuploader, requests, docopt 08:43:41 INFO - Running setup.py install for blobuploader 08:43:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:43:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:43:41 INFO - Running setup.py install for requests 08:43:42 INFO - Running setup.py install for docopt 08:43:42 INFO - Successfully installed blobuploader requests docopt 08:43:42 INFO - Cleaning up... 08:43:42 INFO - Return code: 0 08:43:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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 0x7f730d92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f60>, '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 0x1eb2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb31d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', '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 08:43: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 08:43: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 08:43:42 INFO - Using env: {'DISPLAY': ':0', 08:43:42 INFO - 'HOME': '/home/cltbld', 08:43:42 INFO - 'LANG': 'en_US.UTF-8', 08:43:42 INFO - 'LANGUAGE': 'en_US:en', 08:43:42 INFO - 'LOGNAME': 'cltbld', 08:43:42 INFO - 'MAIL': '/var/mail/cltbld', 08:43:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:42 INFO - 'MOZ_NO_REMOTE': '1', 08:43:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:42 INFO - 'NO_EM_RESTART': '1', 08:43:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:42 INFO - 'PWD': '/builds/slave/test', 08:43:42 INFO - 'SHELL': '/bin/bash', 08:43:42 INFO - 'SHLVL': '1', 08:43:42 INFO - 'TERM': 'linux', 08:43:42 INFO - 'TMOUT': '86400', 08:43:42 INFO - 'USER': 'cltbld', 08:43:42 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', 08:43:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:42 INFO - '_': '/tools/buildbot/bin/python'} 08:43:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:42 INFO - Running setup.py (path:/tmp/pip-axNe3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:42 INFO - Running setup.py (path:/tmp/pip-RGAvcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:42 INFO - Running setup.py (path:/tmp/pip-OyYdu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:42 INFO - Running setup.py (path:/tmp/pip-1yp61Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:42 INFO - Running setup.py (path:/tmp/pip-M2M9AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:42 INFO - Running setup.py (path:/tmp/pip-uGsQcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:42 INFO - Running setup.py (path:/tmp/pip-263hj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:42 INFO - Running setup.py (path:/tmp/pip-oHZ8Id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:42 INFO - Running setup.py (path:/tmp/pip-PAANsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:43 INFO - Running setup.py (path:/tmp/pip-TQLRa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:43 INFO - Running setup.py (path:/tmp/pip-pD4dbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:43 INFO - Running setup.py (path:/tmp/pip-LeUf1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:43 INFO - Running setup.py (path:/tmp/pip-DMzpq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:43 INFO - Running setup.py (path:/tmp/pip-XIt3uN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:43 INFO - Running setup.py (path:/tmp/pip-eeBsNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:43 INFO - Running setup.py (path:/tmp/pip-0jYCIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:43 INFO - Running setup.py (path:/tmp/pip-TfHUnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:43:43 INFO - Running setup.py install for manifestparser 08:43:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:43:43 INFO - Running setup.py install for mozcrash 08:43:43 INFO - Running setup.py install for mozdebug 08:43:43 INFO - Running setup.py install for mozdevice 08:43:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:43:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:43:44 INFO - Running setup.py install for mozfile 08:43:44 INFO - Running setup.py install for mozhttpd 08:43:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:43:44 INFO - Running setup.py install for mozinfo 08:43:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:43:44 INFO - Running setup.py install for mozInstall 08:43:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:43:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:43:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:43:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:43:44 INFO - Running setup.py install for mozleak 08:43:44 INFO - Running setup.py install for mozlog 08:43:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:43:44 INFO - Running setup.py install for moznetwork 08:43:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:43:44 INFO - Running setup.py install for mozprocess 08:43:44 INFO - Running setup.py install for mozprofile 08:43:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:43:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:43:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:43:45 INFO - Running setup.py install for mozrunner 08:43:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:43:45 INFO - Running setup.py install for mozscreenshot 08:43:45 INFO - Running setup.py install for moztest 08:43:45 INFO - Running setup.py install for mozversion 08:43:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:43:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:43:45 INFO - Cleaning up... 08:43:45 INFO - Return code: 0 08:43:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:45 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 0x7f730d92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f60>, '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 0x1eb2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb31d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', '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 08:43:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:43:45 INFO - Using env: {'DISPLAY': ':0', 08:43:45 INFO - 'HOME': '/home/cltbld', 08:43:45 INFO - 'LANG': 'en_US.UTF-8', 08:43:45 INFO - 'LANGUAGE': 'en_US:en', 08:43:45 INFO - 'LOGNAME': 'cltbld', 08:43:45 INFO - 'MAIL': '/var/mail/cltbld', 08:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:45 INFO - 'MOZ_NO_REMOTE': '1', 08:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:45 INFO - 'NO_EM_RESTART': '1', 08:43:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:45 INFO - 'PWD': '/builds/slave/test', 08:43:45 INFO - 'SHELL': '/bin/bash', 08:43:45 INFO - 'SHLVL': '1', 08:43:45 INFO - 'TERM': 'linux', 08:43:45 INFO - 'TMOUT': '86400', 08:43:45 INFO - 'USER': 'cltbld', 08:43:45 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', 08:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:45 INFO - '_': '/tools/buildbot/bin/python'} 08:43:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:45 INFO - Running setup.py (path:/tmp/pip-ym_y3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:45 INFO - Running setup.py (path:/tmp/pip-slatQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:45 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)) 08:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:45 INFO - Running setup.py (path:/tmp/pip-TML3bQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:45 INFO - Running setup.py (path:/tmp/pip-XT1Jbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:45 INFO - Running setup.py (path:/tmp/pip-VZIWgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43: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)) 08:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:46 INFO - Running setup.py (path:/tmp/pip-0FE4gQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43: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)) 08:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:46 INFO - Running setup.py (path:/tmp/pip-Jmnm2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43: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)) 08:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:46 INFO - Running setup.py (path:/tmp/pip-okXLqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43: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)) 08:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:46 INFO - Running setup.py (path:/tmp/pip-fY7dPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:46 INFO - Running setup.py (path:/tmp/pip-EnIXXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:46 INFO - Running setup.py (path:/tmp/pip-Xwg2_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:46 INFO - Running setup.py (path:/tmp/pip-DjkLva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:46 INFO - Running setup.py (path:/tmp/pip-ecc8M5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:46 INFO - Running setup.py (path:/tmp/pip-QOOkAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:46 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)) 08:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:46 INFO - Running setup.py (path:/tmp/pip-_JFKEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:46 INFO - Running setup.py (path:/tmp/pip-HJizV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:46 INFO - Running setup.py (path:/tmp/pip-rVpFrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:43:46 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)) 08:43:46 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)) 08:43:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:43:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:43:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:43:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:48 INFO - Downloading blessings-1.6.tar.gz 08:43:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:43:48 INFO - Installing collected packages: blessings 08:43:48 INFO - Running setup.py install for blessings 08:43:48 INFO - Successfully installed blessings 08:43:48 INFO - Cleaning up... 08:43:49 INFO - Return code: 0 08:43:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:43:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:49 INFO - Reading from file tmpfile_stdout 08:43:49 INFO - Current package versions: 08:43:49 INFO - argparse == 1.2.1 08:43:49 INFO - blessings == 1.6 08:43:49 INFO - blobuploader == 1.2.4 08:43:49 INFO - docopt == 0.6.1 08:43:49 INFO - functools32 == 3.2.3-2 08:43:49 INFO - jsonschema == 2.5.1 08:43:49 INFO - manifestparser == 1.1 08:43:49 INFO - mozInstall == 1.12 08:43:49 INFO - mozcrash == 0.17 08:43:49 INFO - mozdebug == 0.1 08:43:49 INFO - mozdevice == 0.48 08:43:49 INFO - mozfile == 1.2 08:43:49 INFO - mozhttpd == 0.7 08:43:49 INFO - mozinfo == 0.9 08:43:49 INFO - mozleak == 0.1 08:43:49 INFO - mozlog == 3.4 08:43:49 INFO - moznetwork == 0.27 08:43:49 INFO - mozprocess == 0.23 08:43:49 INFO - mozprofile == 0.28 08:43:49 INFO - mozrunner == 6.12 08:43:49 INFO - mozscreenshot == 0.1 08:43:49 INFO - mozsystemmonitor == 0.3 08:43:49 INFO - moztest == 0.7 08:43:49 INFO - mozversion == 1.4 08:43:49 INFO - psutil == 3.1.1 08:43:49 INFO - requests == 1.2.3 08:43:49 INFO - wsgiref == 0.1.2 08:43:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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 0x7f730d92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f60>, '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 0x1eb2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb31d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', '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 08:43: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 08:43: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 08:43:49 INFO - Using env: {'DISPLAY': ':0', 08:43:49 INFO - 'HOME': '/home/cltbld', 08:43:49 INFO - 'LANG': 'en_US.UTF-8', 08:43:49 INFO - 'LANGUAGE': 'en_US:en', 08:43:49 INFO - 'LOGNAME': 'cltbld', 08:43:49 INFO - 'MAIL': '/var/mail/cltbld', 08:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:49 INFO - 'MOZ_NO_REMOTE': '1', 08:43:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:49 INFO - 'NO_EM_RESTART': '1', 08:43:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:49 INFO - 'PWD': '/builds/slave/test', 08:43:49 INFO - 'SHELL': '/bin/bash', 08:43:49 INFO - 'SHLVL': '1', 08:43:49 INFO - 'TERM': 'linux', 08:43:49 INFO - 'TMOUT': '86400', 08:43:49 INFO - 'USER': 'cltbld', 08:43:49 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', 08:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:49 INFO - '_': '/tools/buildbot/bin/python'} 08:43:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:43:49 INFO - Cleaning up... 08:43:49 INFO - Return code: 0 08:43:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:49 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 0x7f730d92cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1eb4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb1f60>, '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 0x1eb2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb31d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', '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 08:43:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:43:49 INFO - Using env: {'DISPLAY': ':0', 08:43:49 INFO - 'HOME': '/home/cltbld', 08:43:49 INFO - 'LANG': 'en_US.UTF-8', 08:43:49 INFO - 'LANGUAGE': 'en_US:en', 08:43:49 INFO - 'LOGNAME': 'cltbld', 08:43:49 INFO - 'MAIL': '/var/mail/cltbld', 08:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:49 INFO - 'MOZ_NO_REMOTE': '1', 08:43:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:49 INFO - 'NO_EM_RESTART': '1', 08:43:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:49 INFO - 'PWD': '/builds/slave/test', 08:43:49 INFO - 'SHELL': '/bin/bash', 08:43:49 INFO - 'SHLVL': '1', 08:43:49 INFO - 'TERM': 'linux', 08:43:49 INFO - 'TMOUT': '86400', 08:43:49 INFO - 'USER': 'cltbld', 08:43:49 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', 08:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:49 INFO - '_': '/tools/buildbot/bin/python'} 08:43:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:43:49 INFO - Cleaning up... 08:43:49 INFO - Return code: 0 08:43:49 INFO - Running post-action listener: _resource_record_post_action 08:43:49 INFO - Running post-action listener: _start_resource_monitoring 08:43:49 INFO - Starting resource monitoring. 08:43:49 INFO - [mozharness: 2016-09-22 15:43:49.692553Z] Finished create-virtualenv step (success) 08:43:49 INFO - [mozharness: 2016-09-22 15:43:49.693002Z] Running install step. 08:43:49 INFO - Running pre-action listener: _resource_record_pre_action 08:43:49 INFO - Running main action method: install 08:43:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:49 INFO - Reading from file tmpfile_stdout 08:43:49 INFO - Detecting whether we're running mozinstall >=1.0... 08:43:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:43:49 INFO - Reading from file tmpfile_stdout 08:43:49 INFO - Output received: 08:43:49 INFO - Usage: mozinstall [options] installer 08:43:49 INFO - Options: 08:43:49 INFO - -h, --help show this help message and exit 08:43:49 INFO - -d DEST, --destination=DEST 08:43:49 INFO - Directory to install application into. [default: 08:43:49 INFO - "/builds/slave/test"] 08:43:49 INFO - --app=APP Application being installed. [default: firefox] 08:43:49 INFO - mkdir: /builds/slave/test/build/application 08:43:49 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'] 08:43:49 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 08:44:06 INFO - Reading from file tmpfile_stdout 08:44:06 INFO - Output received: 08:44:06 INFO - /builds/slave/test/build/application/firefox/firefox 08:44:06 INFO - Running post-action listener: _resource_record_post_action 08:44:06 INFO - [mozharness: 2016-09-22 15:44:06.072814Z] Finished install step (success) 08:44:06 INFO - [mozharness: 2016-09-22 15:44:06.073059Z] Running run-tests step. 08:44:06 INFO - Running pre-action listener: _resource_record_pre_action 08:44:06 INFO - Running main action method: run_tests 08:44:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:44:06 INFO - Python 2.7.3 08:44:06 INFO - Return code: 0 08:44:06 INFO - grabbing minidump binary from tooltool 08:44: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')]} 08:44: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 0x1eb1f60>, '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 0x1eb2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1eb31d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:44: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 08:44: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 08:44: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 08:44:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:44:06 INFO - Return code: 0 08:44:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:44:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:44:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:44:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:44:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:44: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/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:44: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/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:44:06 INFO - Using env: {'DISPLAY': ':0', 08:44:06 INFO - 'HOME': '/home/cltbld', 08:44:06 INFO - 'LANG': 'en_US.UTF-8', 08:44:06 INFO - 'LANGUAGE': 'en_US:en', 08:44:06 INFO - 'LOGNAME': 'cltbld', 08:44:06 INFO - 'MAIL': '/var/mail/cltbld', 08:44:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:44:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:06 INFO - 'MOZ_NO_REMOTE': '1', 08:44:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:06 INFO - 'NO_EM_RESTART': '1', 08:44:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:06 INFO - 'PWD': '/builds/slave/test', 08:44:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:44:06 INFO - 'SHELL': '/bin/bash', 08:44:06 INFO - 'SHLVL': '1', 08:44:06 INFO - 'TERM': 'linux', 08:44:06 INFO - 'TMOUT': '86400', 08:44:06 INFO - 'USER': 'cltbld', 08:44:06 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355', 08:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:06 INFO - '_': '/tools/buildbot/bin/python'} 08:44: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/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:44:06 INFO - mozversion application_buildid: 20160922080506 08:44:06 INFO - mozversion application_changeset: 190e45ee01153267e1507726381f41379d2e3673 08:44:06 INFO - mozversion application_display_name: Nightly 08:44:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:44:06 INFO - mozversion application_name: Firefox 08:44:06 INFO - mozversion application_remotingname: firefox 08:44:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:44:06 INFO - mozversion application_vendor: Mozilla 08:44:06 INFO - mozversion application_version: 52.0a1 08:44:06 INFO - mozversion platform_buildid: 20160922080506 08:44:06 INFO - mozversion platform_changeset: 190e45ee01153267e1507726381f41379d2e3673 08:44:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:44:06 INFO - mozversion platform_version: 52.0a1 08:44:06 INFO - using testdate: 1474559046 08:44:06 INFO - actual date: 1474559046 08:44:06 INFO - starting webserver on 'localhost:45816' 08:44:06 INFO - SUITE-START | Running 2 tests 08:44:06 INFO - TEST-START | dromaeo_css 08:44:06 INFO - operating with platform_type : linux_ 08:44:06 INFO - Initialising browser for dromaeo_css test... 08:44:06 INFO - TEST-INFO | started process 21576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkKyJQZ/profile http://localhost:45816/getInfo.html) 08:44:10 INFO - PROCESS | 21576 | __metrics Screen width/height:1600/1200 08:44:10 INFO - PROCESS | 21576 | colorDepth:24 08:44:10 INFO - PROCESS | 21576 | Browser inner width/height: 1024/697 08:44:10 INFO - PROCESS | 21576 | __metrics 08:44:11 INFO - PROCESS | 21576 | 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" 08:44:11 INFO - PROCESS | 21576 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:44:12 INFO - PROCESS | 21576 | console.error: PushService: 08:44:12 INFO - PROCESS | 21576 | stateChangeProcessEnqueue: Error transitioning state 08:44:12 INFO - PROCESS | 21576 | UnknownError 08:44:12 INFO - TEST-INFO | 21576: exit 0 08:44:12 INFO - Browser initialized. 08:44:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:44:12 INFO - TEST-INFO | started process 21656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkKyJQZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:25 INFO - PROCESS | 21656 | RSS: Main: 175116288 08:44:25 INFO - PROCESS | 21656 | 08:45:16 INFO - PROCESS | 21656 | 1474559116595 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:47:28 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:45816/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45816/tests/dromaeo/cssquery-ext.html) 08:47:30 INFO - PROCESS | 21656 | RSS: Main: 307810304 08:47:30 INFO - PROCESS | 21656 | 08:50:32 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:45816/tests/dromaeo/cssquery-ext.html (next: http://localhost:45816/tests/dromaeo/cssquery-jquery.html) 08:50:33 INFO - PROCESS | 21656 | RSS: Main: 281477120 08:50:33 INFO - PROCESS | 21656 | 08:53:35 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:45816/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45816/tests/dromaeo/cssquery-mootools.html) 08:53:36 INFO - PROCESS | 21656 | RSS: Main: 223227904 08:53:36 INFO - PROCESS | 21656 | 08:56:38 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:45816/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45816/tests/dromaeo/cssquery-prototype.html) 08:56:39 INFO - PROCESS | 21656 | RSS: Main: 219439104 08:56:39 INFO - PROCESS | 21656 | 08:59:42 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:45816/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45816/tests/dromaeo/cssquery-yui.html) 08:59:42 INFO - PROCESS | 21656 | RSS: Main: 220655616 08:59:42 INFO - PROCESS | 21656 | 09:02:45 INFO - PROCESS | 21656 | Cycle 1(1): loaded http://localhost:45816/tests/dromaeo/cssquery-yui.html (next: http://localhost:45816/tests/dromaeo/cssquery-dojo.html) 09:02:45 INFO - PROCESS | 21656 | RSS: Main: 317399040 09:02:45 INFO - PROCESS | 21656 | 09:02:45 INFO - PROCESS | 21656 | __start_tp_report 09:02:45 INFO - PROCESS | 21656 | _x_x_mozilla_page_load 09:02:45 INFO - PROCESS | 21656 | _x_x_mozilla_page_load_details 09:02:45 INFO - PROCESS | 21656 | |i|pagename|runs| 09:02:45 INFO - PROCESS | 21656 | |0;dojo.html;2544.249446413308;2579.41963058312;2603.062897356952;2607.035396903146;2623.1343656593326;4476.932846007313;4574.2223821950265;4616.769161541922;4628.375169352136;4670.813167473301;4573.977130114353;4600.309953506976;4624.606908412789;4655.99896022356;4672.5327467253255;4250.744955302676;4277.636400905927;4283.957160428403;4305.24658184818;4401.537838526957;4297.1405718856195;4300.182965236595;4340.587644173798;4350.303951367781;4398.274284743014;4185.393117997874;4202.726822756511;4231.555686652919;4271.252530807096;4284.228838809013;4253.744775313491;4271.743695378256;4274.636655884254;4278.122984788111;4279.40088387626;4181.91636167278;4212.389203565496;4220.873373798791;4231.196072746168;4250.3199488081755;4610.792514336829;4665.346851440801;4666.743329116897;4668;4684.601808846252;4911.705297682115;4925.458199598042;4930.383702037246;4931.01379724053;4985.476524964863;4951.678140920829;4954.801807927679;4956.90086198274;4962.379702537183;5012.323336349583;4446.955530444687;4487.551244875486;4540.8637740867825;4596.816127354935;4597.402337696078;4997.775100120503;5029.874253143701;5087.516685914832;5089.236614507779;5091.592672586185;4740.241561350167;4785.090832741768;4827.975860120677;4836.564709176191;4905.2151655734915;4792.041591681677;4835.1296766581645;4857.344258525054;4904.509549045067;4922.827701030446;4819.349387832668;4854.708717476963;4856.368672072608;4943.233798761198;4957.082939656175;4852.4662287148385;4885.487023862514;4886.486918873538;4899.436564795023;4942.283368911488;4232.597903199191;4239.936400953927;4241.1941731071;4247.787610619518;4293.806778694904;3654.8903532893523;3671;3691.187938653492;3697.6302369762807;3715.256948610289;4263.637590804754;4273.1026484438;4275.4441922550495;4331.371951067078;4333.674974376934;4932.112219800399;4934.309196712463;4937.11131996237;4942.283368911488;4993;4217.093324935154;4255.765932873722;4270.957290427056;4272.401863739079;4281;4437.312216606431;4463.174312752151;4483.237849565582;4528.049109687003;4549.749763763025;4646.837360692495;4648.116857797076;4651.790669419952;4704.858854234379;4775.617950563947;4837;4869.95130048695;4873.756312184306;4880.609551235963;4945.109880221595;4555.293929440942;4604.102200070954;4623.976880115578;4764.380630518011;4784.64115191369;4971.850844474671;4973.104841128632;4975.825846095369;5023.34696489454;5026.698398096126;5017.046761115376;5035.093683137071;5036.6726162799305;5048.646594738333;5098;4759.3336932830125;4778.808847646055;4830.130576496264;4883.926741098958;4972.726500042532;4753.025629745963;4816.301636262792;4819.397575303087;4874.147024270667;4876.926846097241;4734.360861283682;4741.312509686145;4743.739094349844;4746.92879606813;4784.47370789206;4704.411948506437;4746.7863946121815;4834.540718631724;4843.370361853077;4900.95099049005;4682.344471774022;4721.362616046789;4733.171694953438;4738;4803.687760295569 09:02:45 INFO - PROCESS | 21656 | |1;ext.html;556.983290501285;574.3825387708214;579.7883772423066;580.6051884718393;580.6719203649935;28500;38434;39983.40024899629;40019.39970900435;42993;40342.59657403425;40827.795861020655;40829;40831.18337633253;40837.18325633493;7615.619219039054;7772.533647981111;7773.144954055049;7773.261540153676;7776.805579860492;7584.165741768401;7674.923250767504;7677.577733224671;7679.424043196755;7679.884801727979;7678.961605191967;7714.305712485875;7720.382369410462;7721;7724.9227507725045;7668.693252269931;7703.345215656648;7707.768766937001;7710.1904300048245;7714.459987800856;7666.271704188093;7764.961175194145;7767.262110099531;7768.145503994556;7769.028871391076;37715.434268485995;38021.61978380208;38024;38082.23835523274;38119;2875.166201801475;2889.927751806201;2901.8839246430116;3194.648588655246;3196.1394551876174;28545;28735.27588344706;28775.424491510053;28824.711752882413;29715.851420742758;3262.934741305184;3336.4995250712345;3351.8324083795956;3360.294338188983;3398.065531978701;250047;250754.99999999817;250999;252041;252231.99999999817;51699.224511632354;52020.21969670458;52070.47929520732;52124.47875521196;52148;31677;32931.50602740961;32997.83501082527;34371;34426;13765.793513097311;13941.093828901088;13941.930290348484;13944.651383715489;13955.302234888215;10447.164226861833;10533.157347412189;10535.736606584744;10548.736281592868;10556.313839600401;17202.397916072878;17286.394976175772;17505;17603.82396176022;17630.91184544069;6569;6631.734730610721;6681.298463661343;6833;6857.55425897315;749.4603885202754;917.2478567574525;948.8861336639509;955.1165172215673;977.7946631207384;26694.5995810063;26999.595006074924;27276.863615681796;27627.309317266827;27746.02888898879;872.3631748823394;939.8252184769038;975.8389865672226;982.526210683974;996.0288718499405;13727.862721372858;14692.632684182981;14698;14856.108633482027;14971.92514037423;372323;375180;375566;375582;375865;47686.76156619264;48274.75862620665;48288.275675864184;48313.27530087052;48340.758296208296;1060.3160961179997;1084.9132069434427;1133.0935251798694;1134.2117228526095;1175.841261429713;25788.484230315666;28710.851565937963;29121.85439072791;29337.55993660054;29600.407991840475;41213.381799272436;41764.79117604514;41794.79102604589;41827.7908610455;41888.581114189685;225983;227260;227260;227525;228223;21988.780112199314;22736.317910462712;23845.523089537764;24623.507529848943;25007.624885626366;40349;40565;40633.39049914313;40830.38754418627;41135.971600710225;33835.83082084574;34461.65538344585;34893.825530872185;35107.29785404226;35255;34728.479072814436;34736.30527389388;34848.303033938675;35075.473867891495;35322.470162947066;33793;34062;34333.484997724554;34456.13859653529;34870.47694284537;29433.55849662214;31712.207194820316;32025.679743203204;32111.35777284488;32332.83833580817;24234.394140146636;24330.27009189727;24511.387215319046;24582.50834983326;24940.625890611293 09:02:45 INFO - PROCESS | 21656 | |2;jquery.html;343.929494453637;344.54003904787123;349.0471014131422;351.4938488576448;363.30064625595736;15266.465673701423;15988.760168597466;16073.276702548384;16773.329066837312;16911.40810071648;15858.444954426597;15938.840611593881;16331.755023674625;16418.343266269363;16431;4951.876203094934;4978.203487442001;5137.229415587654;5156.484351564851;5157.123289040854;5119.462456442057;5139.357580302462;5180.715060671661;5182.222666600002;5182.300389447433;4897.3878265216845;5038.546530812227;5059.974700126494;5071.2139618359215;5140.177571588547;5035.395752509704;5075.213341932006;5079.263506791532;5079.568236699885;5080.364954380702;4333.090051089243;4451.176532341495;4469.865904022885;4483.798229079699;4513.368128462018;20092.69860952087;20095.89952050245;20263.29078482246;20294.898525507277;20378;1895.5924476237676;1977.5352792093847;2143.528423746789;2161.848670593059;2264.241479104502;12643.683907902285;12842.293673847935;12955.740885182338;13029;13511.932440337834;1672.6654669066236;1679.7480377943284;1715.1081437652476;1743.564108972757;1812.4925020994142;65081.67459162674;66600.3339966599;66803.66598166978;67520.3247967519;68350.65824670845;8679.826403471896;8684.305255579664;8822.206001459772;8861.86012112973;9099.636014559343;12109.878901210875;12132.211406258564;12137.817932731015;12144.817827732591;12224.083193760503;6468.8059358219325;6580.243272023683;6604.207495100619;6683.097781799492;6747.874419557824;6313.715882785285;6319.6208227506495;6435.710393032325;6570.375814297634;6573.835654108686;5517.2551705519245;5667.518260947783;5689.829305120853;5808.651480911159;5898.410158984153;1632.6979508790912;1643.589102724319;1674.506020723865;1689.2820551265663;1715.6482921001166;802.2218448105328;813.7459237910954;818.7380038387658;857.1557016338901;877.9561021949005;16053.357865685242;16829.611368188813;17193.31226750941;17615.38346157904;17745.7338139928;835.6699103853944;840.2857571064668;849.439370015799;856.2208390364738;857.8970523537215;9433;9805.558749856273;9893.554790034466;10066.496675166212;10146.391216527032;348961;349343;358494;358738;358851;39458.60541394607;40192.196156076716;62249.68875155595;66263.33736662669;66723.66638166778;861.9655213791503;894.458852394305;907.228855472856;911.1526280559144;915.638322862479;15241.31414086391;15279.465218717292;15867.28597213105;16113.919430402773;16297.755533666766;38054.23891522099;38165;38517;38655.42016869805;39322;52066.47933520616;52113;52595.21107183472;52760.73619631877;53476.19785703295;7005.509614326948;7158.570485770871;7246.7101315948885;7393;7915.327197188303;10923.235373523778;11293.71765705831;11653.92522804868;11867.109966752356;11868.940655296668;9417.952910235404;9549.140577348073;9744.269179811401;9894.950525247328;10140.29017968735;9675.70972870815;10112.49437528106;10154.847677284994;10262.384256944608;10268.383896966207;9474.14732674035;9668.85496717564;9783.119519243302;9885.3574517659;10082.193424526167;7181.497295189495;7274.16347120088;7283.526570772883;7329.083864516935;7479.626018699152;7635.541867487968;9454.480003599869;9638.855417168608;9754.610425308498;9847.60609575609 09:02:45 INFO - PROCESS | 21656 | |3;mootools.html;1197.5090213012656;1293.4890718166325;1312.4381985437328;1327.2103098656296;1620.7244768389373;6402.839929001777;6877.862442751149;7121.430285577155;7125.714971401144;7312.780616581498;7085.078939737839;7143.178534468538;7174.6771395287205;7176;7184.892226616605;2002.8297594704432;2020.333290014299;2023.251396983111;2026.8783872967595;2029.7767245603045;2008.9296874609392;2067.5554755727517;2074.73028506294;2076.771555128935;2087.7077209190725;2041.397787652646;2044.37646517812;2053.1068984991502;2053.3121404329495;2059.835213182942;2001.9299324523645;2011.6077364913847;2012.7584689837167;2013.2550956146174;2018.1927229108328;1949.6198241342943;1955.2960934063726;1956.4521933858543;1956.8825870447818;1957.5889063296725;7227.457940654472;7466.104067511933;7569.280918312751;7569.886451703229;7591.848163036763;4149.211649786531;4269.402283680287;4275.123599662062;4285.207236661227;4293.463317085364;2660.135455976796;2743.1359121876544;2807.8034537582375;2809.3538486148095;2818.422223444189;887.2148148888281;894.1237587164616;907.9001309855911;913.7532866126109;922.4649703172211;10053.698389048268;10108.797824043479;10158.542865571068;10160.644377446753;10164.44095574743;3611.8194090295906;3689.5019172411917;3858.498395208605;3870.767753934773;3884.320243957296;8003.6798528058225;8013.11855695873;8015.198480151938;8019.879701804478;8025.9598702006115;4347.608715215646;4353.49934757507;4355.869323920288;4358.193734159191;4364.1053584015835;3514.7012503937453;3643.5809881863397;3865.536135663738;4074.6536544393466;4099.9180016400105;3170.682931706857;3201.6798320168264;3329.583802024747;3339.1819004343606;3346.0798280473064;977.6187286958092;990.3955591941102;995.5669283861544;1000.3547711725896;1004.5278719002057;652.3900153356627;705.4321271376591;761.584936209767;803.7628899474669;872.6771094694876;4953.554180123806;5035.949640503622;5086.3896332440345;5208.9739551302;5465.316835395575;362.9600743918167;369.0993974701773;375.228904601042;376.1048704084262;379.6298608856343;3447.3622379859808;3590;3723.3670276053135;3759.5112635357227;3762.7177961652988;8359.665613375519;8673.91326086731;8879.689210877588;9020.684276050306;9102.499362534993;8592.312614990786;8865.734027979172;8885;8890.06654301302;8893.955530222436;6649.966750166218;6686.5653732507235;6824.829379265558;6826.795196144124;6864.828379290558;5171.534561889448;5362.9094455474615;5433.5924805640525;5502.889942201214;5590.105583106846;8465.83068338642;8469.830603388022;8471.703490377808;8525.658973640984;8550.05949345584;8471.49171049739;8527.275181609384;8533.061363249913;8620.181082797124;8802.075782042793;5594.188842617879;6574.605523668595;6664.0670306158145;6675.03212034262;6684.06423100776;6431.228252609717;6478.3197764235965;6965.33829286217;7029.226785053742;7230.74692385764;6252.937470625236;6378.425941665272;6613.107230523818;6672.299408562031;6741.056252124805;6389.616623002635;6443.194600674916;6457.031445283245;6458.806235812933;6471.611703297817;6140.9078863816185;6287.371262873859;6302.275238347649;6306.936930630635;6324.7153878076515;4482.103579284091;4484.237679594412;4553.362529245842;4582.152301824173;4587.655925805645;4535.727856328631;4542.477615074176;4564.201264778584;4570.405847239837;4618.653600979873 09:02:45 INFO - PROCESS | 21656 | |4;prototype.html;268.1539742113631;274.90790585153974;276.3864221428429;278.7969909839043;283.92192147159534;4820.156472617291;4821.4696383397795;4827.903441931159;4840.443349014856;4851.593038018975;4732.46194986629;4749.786259618317;4752.47722750498;4766.904661906759;4772.475027746945;3522.36597412465;3633.401303426497;3635.963640363589;3637.690796282306;3640.8361623726864;3544.982275088621;3619.49327094207;3681.8527258909744;3686.262747450507;3727;3676.816159192043;3687.446882967563;3692.593814680383;3692.6676599106077;3694.4643026761105;3612.169201083739;3695.90760230995;3700.648438398348;3701.222743223926;3758.7932663703623;3249.545063691085;3252.544643749853;3257.7719559630837;3260.2012506935953;3265.134739294089;4597.655175861823;4609.354690343354;4616.8153273869;4625.4911959684405;4686.2267725825195;3967.920641587152;4117.258893399187;4123.876283711494;4207.137536804948;4217.186609757803;4876.853694389174;4877.1708809502115;4886.70679759212;4895.559399654048;4914.508549145093;3433.7939723616414;3446.138465383654;3449.344624521358;3453.1194545390763;3486.773359731609;5054;5156.819511317086;5193.818216362409;5196.662216955886;5201.973990130025;3496.4056110461283;3503.1767534629344;3504.8948531544092;3504.9824750876082;3505.8422370993367;3540.061883600848;3541.592716837545;3545.858165673396;3556.395412779834;3592.6586974237407;4088.814243869245;4090.6091928744368;4095.959040409558;4097.959020409758;4101.5488296287385;4685.5782979532005;4933.728644924492;4945.455999840086;4952.727599982036;4998.6500944933505;1234.1854376111723;1240.4665993622648;1243.6320047947368;1247.09585550477;1253.1165528302524;768.4006474949548;772.3435080181913;783.4006984656742;784.8822676598442;794.4875555266821;3977.5226972763453;4242.575742425733;4346.21768081742;4435.401220835146;4500.392447019611;5098.643094983389;5130.358705161855;5163.173892177234;5163.561097306771;5183.533481986639;4405.40527028847;4428.933565996513;4435.179491794029;4442.267025940748;4456;2586.6766654168227;2697.4874773792917;2725.1960671601923;2740.369714965529;2743.0810678422554;4932.531409516162;4938.333325001151;4940.530649588283;4948.678335908155;4952.702837829742;5239.73801309933;5241.947580524222;5248.868778280574;5253.55344795689;5258.158694608845;4726.976365118152;4876.536729010738;4902.607791376681;4904.215325547895;4912.877178070506;5090.396525094583;5101.3113229715;5103.923441148311;5120.974395128001;5138.818071843422;5027.874303142451;5028;5055.545000949932;5060.696358218519;5062.190049592047;4668.762777863937;4838;4873.512648735098;4887.242477416006;4896.192128298933;3578.5884623267616;3580.3555360035443;3589.641035896494;3590.407582748922;3591.37150998569;5093.821716239914;5095.363079615048;5115.820946266863;5150.40770311404;5152.871178220575;4682.742449165328;4964.726940018334;5006.924896126488;5011.348524691767;5023.57299629521;5011.123053465702;5023.709470296962;5025.165814477617;5035.985605757726;5048.9649621828175;4941.70349779;4944.208926571731;4944.788526810954;4977.178765503796;4977.552020318189;4753.358296629911;4896.730679812645;4994.350734404504;5032.295478632921;5051.368578927634;4764.166270902648;4808.206645903387;4911.435184953776;4924.285978533164;4925.679830810986 09:02:45 INFO - PROCESS | 21656 | |5;yui.html;602.4216751918158;638.2914964389527;674.7739507265065;699.9230084690686;719.7408932784197;11942.402879856005;12402.565910193145;12423.875761242385;12424.503019879217;12427.88149066585;11617.767644647101;11856.881431185686;11915.165938384316;12077.214981026227;12185.268883866975;605.9091136329564;721.422861710632;736.3740820302727;739.1462860396251;740.1155619035255;619.7087368936593;721.0410154494535;745.7278093495862;753.0398741604444;754.9169591344947;786.3512602103287;787.8975733154682;788.5111231036765;791.0112359550562;791.0507391130637;630.180765005491;781.2734157233771;781.6521647866701;782.6399856066216;783.0485959559135;475.8049199828054;547.1164070026917;565.1409857017352;567.5941701683316;569.9914501282484;12577.11960162789;12582.937085314607;12585.685357866036;12604.432800523999;12621.432035558422;11477;12139.939300303531;12256.08079394049;12344.259344439362;12381.566645167466;11970.40147992597;11987.58043468483;12006.579769708018;12105.818412723816;12145;4210.642095421862;4221.092465119983;4233.470816147981;4311.568843115695;4325.13497300538;61317.38682613206;61537.76924461486;61581.692091539255;61736.69131654313;61859.381406185814;9978.401295922267;10030.31220078483;10103.090721834924;10711.678649640524;10715.624953126604;18679.533011674815;18683.90658046701;18711.812881871007;18737.531561710795;18740.344087956855;6983.406410455168;6985.3713165815325;6998.6500674967065;7006.124234470692;7010.894836577353;3606.6753992140834;3671.100580357776;3750.7562008469363;3836.9040773980314;3837.0407398150464;2731.2762118038736;2786.0805934042123;2811.353388720606;2813.4373125375005;2827.929301767472;471.94572624147975;477.6202918679658;480.56508859482227;494.53513697125305;495.35603715170134;414.40119028004244;428.25056151734464;448.6321216602355;462.2188501432568;535.7650615331698;8046.9597652012535;8183.508989460533;8478.491290522588;8638.611262493203;8753.868691969625;484.58810011489953;528.5375296615462;551.0907003444349;553.673332733681;557.0808166525185;3747.2130852521277;3802.296575133609;3813.9809300953316;3883.514560679915;4148.419221309019;56706.77751725977;57068.714656426455;57117.42882571204;57119.42880571141;58069.12896306559;50547.74726126346;68882.96675549871;74591;80099.59950200212;89424;78503.60748196336;79061.20938790539;79611.60194199224;79725.80411293835;80235;7459.850802983801;7744.380449563909;8027.2775450209765;8112.878306825521;8212.17878212174;44052.55947440484;44367.77816110899;45431.772841135586;46166.30750538812;46718;60022.69648204535;67935.66032169807;68427;68518.65740671265;71696;10146.644867429604;10185.287029908131;10620.734481638021;10623.681289561326;10904.836427453753;11338.829917551078;11617.593384231512;11636.767264654829;11645.708857278636;12039.63881083569;10253.07722304996;10368.896311036793;10509.894901050891;10548.472576371305;10558.31370960885;10466.267361284637;10707.785844283226;10778.407187604756;10858.891411086104;10997.780044398907;9776.364536305118;9780.315377923476;10117.848232276374;10265.948670256601;10454.895451045697;8237.546934918637;8340.35005555257;8652.221300083023;8744.387892847439;8990.325725570478;8596.527191004554;8957.10428957125;8987.640494380152;9003.189712925869;9321.30090243248 09:02:45 INFO - PROCESS | 21656 | __end_tp_report 09:02:45 INFO - PROCESS | 21656 | __start_cc_report 09:02:45 INFO - PROCESS | 21656 | _x_x_mozilla_cycle_collect,1153 09:02:45 INFO - PROCESS | 21656 | __end_cc_report 09:02:45 INFO - PROCESS | 21656 | __startTimestamp1474560165907__endTimestamp 09:02:45 INFO - PROCESS | 21656 | 09:02:45 INFO - PROCESS | 21656 | ------- Summary: start ------- 09:02:45 INFO - PROCESS | 21656 | Number of tests: 6 09:02:45 INFO - PROCESS | 21656 | 09:02:45 INFO - PROCESS | 21656 | [#0] dojo.html Cycles:165 Average:4574.73 Median:4704.41 stddev:472.09 (10.0%) stddev-sans-first:445.86 09:02:45 INFO - PROCESS | 21656 | Values: 2544.2 2579.4 2603.1 2607.0 2623.1 4476.9 4574.2 4616.8 4628.4 4670.8 4574.0 4600.3 4624.6 4656.0 4672.5 4250.7 4277.6 4284.0 4305.2 4401.5 4297.1 4300.2 4340.6 4350.3 4398.3 4185.4 4202.7 4231.6 4271.3 4284.2 4253.7 4271.7 4274.6 4278.1 4279.4 4181.9 4212.4 4220.9 4231.2 4250.3 4610.8 4665.3 4666.7 4668.0 4684.6 4911.7 4925.5 4930.4 4931.0 4985.5 4951.7 4954.8 4956.9 4962.4 5012.3 4447.0 4487.6 4540.9 4596.8 4597.4 4997.8 5029.9 5087.5 5089.2 5091.6 4740.2 4785.1 4828.0 4836.6 4905.2 4792.0 4835.1 4857.3 4904.5 4922.8 4819.3 4854.7 4856.4 4943.2 4957.1 4852.5 4885.5 4886.5 4899.4 4942.3 4232.6 4239.9 4241.2 4247.8 4293.8 3654.9 3671.0 3691.2 3697.6 3715.3 4263.6 4273.1 4275.4 4331.4 4333.7 4932.1 4934.3 4937.1 4942.3 4993.0 4217.1 4255.8 4271.0 4272.4 4281.0 4437.3 4463.2 4483.2 4528.0 4549.7 4646.8 4648.1 4651.8 4704.9 4775.6 4837.0 4870.0 4873.8 4880.6 4945.1 4555.3 4604.1 4624.0 4764.4 4784.6 4971.9 4973.1 4975.8 5023.3 5026.7 5017.0 5035.1 5036.7 5048.6 5098.0 4759.3 4778.8 4830.1 4883.9 4972.7 4753.0 4816.3 4819.4 4874.1 4876.9 4734.4 4741.3 4743.7 4746.9 4784.5 4704.4 4746.8 4834.5 4843.4 4901.0 4682.3 4721.4 4733.2 4738.0 4803.7 09:02:45 INFO - PROCESS | 21656 | 09:02:45 INFO - PROCESS | 21656 | [#1] ext.html Cycles:180 Average:43498.54 Median:34882.15 stddev:76704.79 (219.9%) stddev-sans-first:76852.21 09:02:45 INFO - PROCESS | 21656 | Values: 557.0 574.4 579.8 580.6 580.7 28500.0 38434.0 39983.4 40019.4 42993.0 40342.6 40827.8 40829.0 40831.2 40837.2 7615.6 7772.5 7773.1 7773.3 7776.8 7584.2 7674.9 7677.6 7679.4 7679.9 7679.0 7714.3 7720.4 7721.0 7724.9 7668.7 7703.3 7707.8 7710.2 7714.5 7666.3 7765.0 7767.3 7768.1 7769.0 37715.4 38021.6 38024.0 38082.2 38119.0 2875.2 2889.9 2901.9 3194.6 3196.1 28545.0 28735.3 28775.4 28824.7 29715.9 3262.9 3336.5 3351.8 3360.3 3398.1 250047.0 250755.0 250999.0 252041.0 252232.0 51699.2 52020.2 52070.5 52124.5 52148.0 31677.0 32931.5 32997.8 34371.0 34426.0 13765.8 13941.1 13941.9 13944.7 13955.3 10447.2 10533.2 10535.7 10548.7 10556.3 17202.4 17286.4 17505.0 17603.8 17630.9 6569.0 6631.7 6681.3 6833.0 6857.6 749.5 917.2 948.9 955.1 977.8 26694.6 26999.6 27276.9 27627.3 27746.0 872.4 939.8 975.8 982.5 996.0 13727.9 14692.6 14698.0 14856.1 14971.9 372323.0 375180.0 375566.0 375582.0 375865.0 47686.8 48274.8 48288.3 48313.3 48340.8 1060.3 1084.9 1133.1 1134.2 1175.8 25788.5 28710.9 29121.9 29337.6 29600.4 41213.4 41764.8 41794.8 41827.8 41888.6 225983.0 227260.0 227260.0 227525.0 228223.0 21988.8 22736.3 23845.5 24623.5 25007.6 40349.0 40565.0 40633.4 40830.4 41136.0 33835.8 34461.7 34893.8 35107.3 35255.0 34728.5 34736.3 34848.3 35075.5 35322.5 33793.0 34062.0 34333.5 34456.1 34870.5 29433.6 31712.2 32025.7 32111.4 32332.8 24234.4 24330.3 24511.4 24582.5 24940.6 09:02:45 INFO - PROCESS | 21656 | 09:02:45 INFO - PROCESS | 21656 | [#2] jquery.html Cycles:180 Average:22617.78 Median:5065.59 stddev:58445.48 (1153.8%) stddev-sans-first:58585.51 09:02:45 INFO - PROCESS | 21656 | Values: 343.9 344.5 349.0 351.5 363.3 15266.5 15988.8 16073.3 16773.3 16911.4 15858.4 15938.8 16331.8 16418.3 16431.0 4951.9 4978.2 5137.2 5156.5 5157.1 5119.5 5139.4 5180.7 5182.2 5182.3 4897.4 5038.5 5060.0 5071.2 5140.2 5035.4 5075.2 5079.3 5079.6 5080.4 4333.1 4451.2 4469.9 4483.8 4513.4 20092.7 20095.9 20263.3 20294.9 20378.0 1895.6 1977.5 2143.5 2161.8 2264.2 12643.7 12842.3 12955.7 13029.0 13511.9 1672.7 1679.7 1715.1 1743.6 1812.5 65081.7 66600.3 66803.7 67520.3 68350.7 8679.8 8684.3 8822.2 8861.9 9099.6 12109.9 12132.2 12137.8 12144.8 12224.1 6468.8 6580.2 6604.2 6683.1 6747.9 6313.7 6319.6 6435.7 6570.4 6573.8 5517.3 5667.5 5689.8 5808.7 5898.4 1632.7 1643.6 1674.5 1689.3 1715.6 802.2 813.7 818.7 857.2 878.0 16053.4 16829.6 17193.3 17615.4 17745.7 835.7 840.3 849.4 856.2 857.9 9433.0 9805.6 9893.6 10066.5 10146.4 348961.0 349343.0 358494.0 358738.0 358851.0 39458.6 40192.2 62249.7 66263.3 66723.7 862.0 894.5 907.2 911.2 915.6 15241.3 15279.5 15867.3 16113.9 16297.8 38054.2 38165.0 38517.0 38655.4 39322.0 52066.5 52113.0 52595.2 52760.7 53476.2 7005.5 7158.6 7246.7 7393.0 7915.3 10923.2 11293.7 11653.9 11867.1 11868.9 9418.0 9549.1 9744.3 9895.0 10140.3 9675.7 10112.5 10154.8 10262.4 10268.4 9474.1 9668.9 9783.1 9885.4 10082.2 7181.5 7274.2 7283.5 7329.1 7479.6 7635.5 9454.5 9638.9 9754.6 9847.6 09:02:45 INFO - PROCESS | 21656 | 09:02:45 INFO - PROCESS | 21656 | [#3] mootools.html Cycles:180 Average:4828.83 Median:5190.25 stddev:2708.78 (52.2%) stddev-sans-first:2702.63 09:02:45 INFO - PROCESS | 21656 | Values: 1197.5 1293.5 1312.4 1327.2 1620.7 6402.8 6877.9 7121.4 7125.7 7312.8 7085.1 7143.2 7174.7 7176.0 7184.9 2002.8 2020.3 2023.3 2026.9 2029.8 2008.9 2067.6 2074.7 2076.8 2087.7 2041.4 2044.4 2053.1 2053.3 2059.8 2001.9 2011.6 2012.8 2013.3 2018.2 1949.6 1955.3 1956.5 1956.9 1957.6 7227.5 7466.1 7569.3 7569.9 7591.8 4149.2 4269.4 4275.1 4285.2 4293.5 2660.1 2743.1 2807.8 2809.4 2818.4 887.2 894.1 907.9 913.8 922.5 10053.7 10108.8 10158.5 10160.6 10164.4 3611.8 3689.5 3858.5 3870.8 3884.3 8003.7 8013.1 8015.2 8019.9 8026.0 4347.6 4353.5 4355.9 4358.2 4364.1 3514.7 3643.6 3865.5 4074.7 4099.9 3170.7 3201.7 3329.6 3339.2 3346.1 977.6 990.4 995.6 1000.4 1004.5 652.4 705.4 761.6 803.8 872.7 4953.6 5035.9 5086.4 5209.0 5465.3 363.0 369.1 375.2 376.1 379.6 3447.4 3590.0 3723.4 3759.5 3762.7 8359.7 8673.9 8879.7 9020.7 9102.5 8592.3 8865.7 8885.0 8890.1 8894.0 6650.0 6686.6 6824.8 6826.8 6864.8 5171.5 5362.9 5433.6 5502.9 5590.1 8465.8 8469.8 8471.7 8525.7 8550.1 8471.5 8527.3 8533.1 8620.2 8802.1 5594.2 6574.6 6664.1 6675.0 6684.1 6431.2 6478.3 6965.3 7029.2 7230.7 6252.9 6378.4 6613.1 6672.3 6741.1 6389.6 6443.2 6457.0 6458.8 6471.6 6140.9 6287.4 6302.3 6306.9 6324.7 4482.1 4484.2 4553.4 4582.2 4587.7 4535.7 4542.5 4564.2 4570.4 4618.7 09:02:45 INFO - PROCESS | 21656 | 09:02:45 INFO - PROCESS | 21656 | [#4] prototype.html Cycles:180 Average:4116.09 Median:4751.13 stddev:1220.06 (25.7%) stddev-sans-first:1188.80 09:02:45 INFO - PROCESS | 21656 | Values: 268.2 274.9 276.4 278.8 283.9 4820.2 4821.5 4827.9 4840.4 4851.6 4732.5 4749.8 4752.5 4766.9 4772.5 3522.4 3633.4 3636.0 3637.7 3640.8 3545.0 3619.5 3681.9 3686.3 3727.0 3676.8 3687.4 3692.6 3692.7 3694.5 3612.2 3695.9 3700.6 3701.2 3758.8 3249.5 3252.5 3257.8 3260.2 3265.1 4597.7 4609.4 4616.8 4625.5 4686.2 3967.9 4117.3 4123.9 4207.1 4217.2 4876.9 4877.2 4886.7 4895.6 4914.5 3433.8 3446.1 3449.3 3453.1 3486.8 5054.0 5156.8 5193.8 5196.7 5202.0 3496.4 3503.2 3504.9 3505.0 3505.8 3540.1 3541.6 3545.9 3556.4 3592.7 4088.8 4090.6 4096.0 4098.0 4101.5 4685.6 4933.7 4945.5 4952.7 4998.7 1234.2 1240.5 1243.6 1247.1 1253.1 768.4 772.3 783.4 784.9 794.5 3977.5 4242.6 4346.2 4435.4 4500.4 5098.6 5130.4 5163.2 5163.6 5183.5 4405.4 4428.9 4435.2 4442.3 4456.0 2586.7 2697.5 2725.2 2740.4 2743.1 4932.5 4938.3 4940.5 4948.7 4952.7 5239.7 5241.9 5248.9 5253.6 5258.2 4727.0 4876.5 4902.6 4904.2 4912.9 5090.4 5101.3 5103.9 5121.0 5138.8 5027.9 5028.0 5055.5 5060.7 5062.2 4668.8 4838.0 4873.5 4887.2 4896.2 3578.6 3580.4 3589.6 3590.4 3591.4 5093.8 5095.4 5115.8 5150.4 5152.9 4682.7 4964.7 5006.9 5011.3 5023.6 5011.1 5023.7 5025.2 5036.0 5049.0 4941.7 4944.2 4944.8 4977.2 4977.6 4753.4 4896.7 4994.4 5032.3 5051.4 4764.2 4808.2 4911.4 4924.3 4925.7 09:02:45 INFO - PROCESS | 21656 | 09:02:45 INFO - PROCESS | 21656 | [#5] yui.html Cycles:180 Average:16342.32 Median:489.56 stddev:22419.08 (4579.4%) stddev-sans-first:22450.81 09:02:45 INFO - PROCESS | 21656 | Values: 602.4 638.3 674.8 699.9 719.7 11942.4 12402.6 12423.9 12424.5 12427.9 11617.8 11856.9 11915.2 12077.2 12185.3 605.9 721.4 736.4 739.1 740.1 619.7 721.0 745.7 753.0 754.9 786.4 787.9 788.5 791.0 791.1 630.2 781.3 781.7 782.6 783.0 475.8 547.1 565.1 567.6 570.0 12577.1 12582.9 12585.7 12604.4 12621.4 11477.0 12139.9 12256.1 12344.3 12381.6 11970.4 11987.6 12006.6 12105.8 12145.0 4210.6 4221.1 4233.5 4311.6 4325.1 61317.4 61537.8 61581.7 61736.7 61859.4 9978.4 10030.3 10103.1 10711.7 10715.6 18679.5 18683.9 18711.8 18737.5 18740.3 6983.4 6985.4 6998.7 7006.1 7010.9 3606.7 3671.1 3750.8 3836.9 3837.0 2731.3 2786.1 2811.4 2813.4 2827.9 471.9 477.6 480.6 494.5 495.4 414.4 428.3 448.6 462.2 535.8 8047.0 8183.5 8478.5 8638.6 8753.9 484.6 528.5 551.1 553.7 557.1 3747.2 3802.3 3814.0 3883.5 4148.4 56706.8 57068.7 57117.4 57119.4 58069.1 50547.7 68883.0 74591.0 80099.6 89424.0 78503.6 79061.2 79611.6 79725.8 80235.0 7459.9 7744.4 8027.3 8112.9 8212.2 44052.6 44367.8 45431.8 46166.3 46718.0 60022.7 67935.7 68427.0 68518.7 71696.0 10146.6 10185.3 10620.7 10623.7 10904.8 11338.8 11617.6 11636.8 11645.7 12039.6 10253.1 10368.9 10509.9 10548.5 10558.3 10466.3 10707.8 10778.4 10858.9 10997.8 9776.4 9780.3 10117.8 10265.9 10454.9 8237.5 8340.4 8652.2 8744.4 8990.3 8596.5 8957.1 8987.6 9003.2 9321.3 09:02:45 INFO - PROCESS | 21656 | -------- Summary: end -------- 09:02:45 INFO - PROCESS | 21656 | 09:02:46 INFO - TEST-INFO | 21656: exit 0 09:02:46 INFO - TEST-OK | dromaeo_css | took 1120567ms 09:02:46 INFO - TEST-START | kraken 09:02:46 INFO - operating with platform_type : linux_ 09:02:46 INFO - Initialising browser for kraken test... 09:02:46 INFO - TEST-INFO | started process 21963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeRlyuE/profile http://localhost:45816/getInfo.html) 09:02:51 INFO - PROCESS | 21963 | __metrics Screen width/height:1600/1200 09:02:51 INFO - PROCESS | 21963 | colorDepth:24 09:02:51 INFO - PROCESS | 21963 | Browser inner width/height: 1024/697 09:02:51 INFO - PROCESS | 21963 | __metrics 09:02:52 INFO - PROCESS | 21963 | 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" 09:02:52 INFO - PROCESS | 21963 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:02:52 INFO - PROCESS | 21963 | console.error: PushService: 09:02:52 INFO - PROCESS | 21963 | stateChangeProcessEnqueue: Error transitioning state 09:02:52 INFO - PROCESS | 21963 | UnknownError 09:02:53 INFO - TEST-INFO | 21963: exit 0 09:02:53 INFO - Browser initialized. 09:02:53 INFO - Running cycle 1/1 for kraken test... 09:02:53 INFO - TEST-INFO | started process 22043 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeRlyuE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:03:05 INFO - PROCESS | 22043 | RSS: Main: 175587328 09:03:05 INFO - PROCESS | 22043 | 09:03:08 INFO - PROCESS | 22043 | Cycle 1(1): loaded http://localhost:45816/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45816/tests/kraken/driver.html?testName=audio-beat-detection) 09:03:09 INFO - PROCESS | 22043 | RSS: Main: 243089408 09:03:09 INFO - PROCESS | 22043 | 09:03:12 INFO - PROCESS | 22043 | Cycle 1(1): loaded http://localhost:45816/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45816/tests/kraken/driver.html?testName=audio-dft) 09:03:12 INFO - PROCESS | 22043 | RSS: Main: 218402816 09:03:12 INFO - PROCESS | 22043 | 09:03:16 INFO - PROCESS | 22043 | Cycle 1(1): loaded http://localhost:45816/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45816/tests/kraken/driver.html?testName=audio-fft) 09:03:16 INFO - PROCESS | 22043 | RSS: Main: 300404736 09:03:16 INFO - PROCESS | 22043 | 09:03:18 INFO - PROCESS | 22043 | Cycle 1(1): loaded http://localhost:45816/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45816/tests/kraken/driver.html?testName=audio-oscillator) 09:03:19 INFO - PROCESS | 22043 | RSS: Main: 209915904 09:03:19 INFO - PROCESS | 22043 | 09:03:21 INFO - PROCESS | 22043 | Cycle 1(1): loaded http://localhost:45816/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45816/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:03:22 INFO - PROCESS | 22043 | RSS: Main: 213721088 09:03:22 INFO - PROCESS | 22043 | 09:03:25 INFO - PROCESS | 22043 | Cycle 1(1): loaded http://localhost:45816/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45816/tests/kraken/driver.html?testName=imaging-darkroom) 09:03:26 INFO - PROCESS | 22043 | RSS: Main: 250048512 09:03:26 INFO - PROCESS | 22043 | 09:03:29 INFO - PROCESS | 22043 | Cycle 1(1): loaded http://localhost:45816/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45816/tests/kraken/driver.html?testName=imaging-desaturate) 09:03:30 INFO - PROCESS | 22043 | RSS: Main: 244916224 09:03:30 INFO - PROCESS | 22043 | 09:03:33 INFO - PROCESS | 22043 | Cycle 1(1): loaded http://localhost:45816/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45816/tests/kraken/driver.html?testName=json-parse-financial) 09:03:33 INFO - PROCESS | 22043 | RSS: Main: 248135680 09:03:33 INFO - PROCESS | 22043 | 09:03:35 INFO - PROCESS | 22043 | Cycle 1(1): loaded http://localhost:45816/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45816/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:03:36 INFO - PROCESS | 22043 | RSS: Main: 211124224 09:03:36 INFO - PROCESS | 22043 | 09:03:38 INFO - PROCESS | 22043 | Cycle 1(1): loaded http://localhost:45816/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45816/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:03:38 INFO - PROCESS | 22043 | RSS: Main: 218624000 09:03:38 INFO - PROCESS | 22043 | 09:03:40 INFO - PROCESS | 22043 | Cycle 1(1): loaded http://localhost:45816/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45816/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:03:41 INFO - PROCESS | 22043 | RSS: Main: 222498816 09:03:41 INFO - PROCESS | 22043 | 09:03:44 INFO - PROCESS | 22043 | Cycle 1(1): loaded http://localhost:45816/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45816/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:03:45 INFO - PROCESS | 22043 | RSS: Main: 223535104 09:03:45 INFO - PROCESS | 22043 | 09:03:47 INFO - PROCESS | 22043 | Cycle 1(1): loaded http://localhost:45816/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45816/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:03:48 INFO - PROCESS | 22043 | RSS: Main: 221888512 09:03:48 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | Cycle 1(1): loaded http://localhost:45816/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45816/tests/kraken/driver.html?testName=ai-astar) 09:03:50 INFO - PROCESS | 22043 | RSS: Main: 273473536 09:03:50 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | __start_tp_report 09:03:50 INFO - PROCESS | 22043 | _x_x_mozilla_page_load 09:03:50 INFO - PROCESS | 22043 | _x_x_mozilla_page_load_details 09:03:50 INFO - PROCESS | 22043 | |i|pagename|runs| 09:03:50 INFO - PROCESS | 22043 | |0;ai-astar;113;117;119;116;115;117;118;117;117;116 09:03:50 INFO - PROCESS | 22043 | |1;audio-beat-detection;160;125;128;167;126;124;128;125;193;129 09:03:50 INFO - PROCESS | 22043 | |2;audio-dft;163;162;162;161;162;164;162;163;161;162 09:03:50 INFO - PROCESS | 22043 | |3;audio-fft;76;77;76;110;76;76;76;75;111;77 09:03:50 INFO - PROCESS | 22043 | |4;audio-oscillator;84;84;118;85;83;85;116;83;84;115 09:03:50 INFO - PROCESS | 22043 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 09:03:50 INFO - PROCESS | 22043 | |6;imaging-darkroom;146;148;148;148;148;146;147;146;147;147 09:03:50 INFO - PROCESS | 22043 | |7;imaging-desaturate;95;95;95;95;94;94;94;95;95;95 09:03:50 INFO - PROCESS | 22043 | |8;json-parse-financial;66;65;64;64;65;66;64;64;65;65 09:03:50 INFO - PROCESS | 22043 | |9;json-stringify-tinderbox;66;67;65;65;68;66;67;66;66;67 09:03:50 INFO - PROCESS | 22043 | |10;stanford-crypto-aes;92;87;88;85;83;83;82;82;83;82 09:03:50 INFO - PROCESS | 22043 | |11;stanford-crypto-ccm;135;134;147;135;135;133;136;137;182;132 09:03:50 INFO - PROCESS | 22043 | |12;stanford-crypto-pbkdf2;181;175;177;180;173;177;178;176;177;175 09:03:50 INFO - PROCESS | 22043 | |13;stanford-crypto-sha256-iterative;70;69;73;73;70;73;74;71;69;68 09:03:50 INFO - PROCESS | 22043 | __end_tp_report 09:03:50 INFO - PROCESS | 22043 | __start_cc_report 09:03:50 INFO - PROCESS | 22043 | _x_x_mozilla_cycle_collect,1963 09:03:50 INFO - PROCESS | 22043 | __end_cc_report 09:03:50 INFO - PROCESS | 22043 | __startTimestamp1474560230629__endTimestamp 09:03:50 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | ------- Summary: start ------- 09:03:50 INFO - PROCESS | 22043 | Number of tests: 14 09:03:50 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | [#0] ai-astar Cycles:10 Average:116.50 Median:117.00 stddev:1.65 (1.4%) stddev-sans-first:1.17 09:03:50 INFO - PROCESS | 22043 | Values: 113.0 117.0 119.0 116.0 115.0 117.0 118.0 117.0 117.0 116.0 09:03:50 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:128.50 stddev:24.14 (18.8%) stddev-sans-first:24.56 09:03:50 INFO - PROCESS | 22043 | Values: 160.0 125.0 128.0 167.0 126.0 124.0 128.0 125.0 193.0 129.0 09:03:50 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 09:03:50 INFO - PROCESS | 22043 | Values: 163.0 162.0 162.0 161.0 162.0 164.0 162.0 163.0 161.0 162.0 09:03:50 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:14.51 (19.1%) stddev-sans-first:15.16 09:03:50 INFO - PROCESS | 22043 | Values: 76.0 77.0 76.0 110.0 76.0 76.0 76.0 75.0 111.0 77.0 09:03:50 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:84.00 stddev:15.65 (18.6%) stddev-sans-first:16.20 09:03:50 INFO - PROCESS | 22043 | Values: 84.0 84.0 118.0 85.0 83.0 85.0 116.0 83.0 84.0 115.0 09:03:50 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:03:50 INFO - PROCESS | 22043 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 09:03:50 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:0.88 (0.6%) stddev-sans-first:0.83 09:03:50 INFO - PROCESS | 22043 | Values: 146.0 148.0 148.0 148.0 148.0 146.0 147.0 146.0 147.0 147.0 09:03:50 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:03:50 INFO - PROCESS | 22043 | Values: 95.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 09:03:50 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 09:03:50 INFO - PROCESS | 22043 | Values: 66.0 65.0 64.0 64.0 65.0 66.0 64.0 64.0 65.0 65.0 09:03:50 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 09:03:50 INFO - PROCESS | 22043 | Values: 66.0 67.0 65.0 65.0 68.0 66.0 67.0 66.0 66.0 67.0 09:03:50 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:3.33 (4.0%) stddev-sans-first:2.26 09:03:50 INFO - PROCESS | 22043 | Values: 92.0 87.0 88.0 85.0 83.0 83.0 82.0 82.0 83.0 82.0 09:03:50 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:135.50 stddev:15.12 (11.2%) stddev-sans-first:15.90 09:03:50 INFO - PROCESS | 22043 | Values: 135.0 134.0 147.0 135.0 135.0 133.0 136.0 137.0 182.0 132.0 09:03:50 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:177.00 stddev:2.38 (1.3%) stddev-sans-first:2.01 09:03:50 INFO - PROCESS | 22043 | Values: 181.0 175.0 177.0 180.0 173.0 177.0 178.0 176.0 177.0 175.0 09:03:50 INFO - PROCESS | 22043 | 09:03:50 INFO - PROCESS | 22043 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:72.00 stddev:2.11 (2.9%) stddev-sans-first:2.20 09:03:50 INFO - PROCESS | 22043 | Values: 70.0 69.0 73.0 73.0 70.0 73.0 74.0 71.0 69.0 68.0 09:03:50 INFO - PROCESS | 22043 | -------- Summary: end -------- 09:03:50 INFO - PROCESS | 22043 | 09:03:51 INFO - TEST-INFO | 22043: exit 0 09:03:51 INFO - TEST-OK | kraken | took 64975ms 09:03:51 INFO - SUITE-END | took 1185s 09:03:52 INFO - Completed test suite (00:19:45) 09:03:52 INFO - javascript benchmark 09:03:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2544.249446413308, 2579.41963058312, 2603.062897356952, 2607.035396903146, 2623.1343656593326, 4476.932846007313, 4574.2223821950265, 4616.769161541922, 4628.375169352136, 4670.813167473301, 4573.977130114353, 4600.309953506976, 4624.606908412789, 4655.99896022356, 4672.5327467253255, 4250.744955302676, 4277.636400905927, 4283.957160428403, 4305.24658184818, 4401.537838526957, 4297.1405718856195, 4300.182965236595, 4340.587644173798, 4350.303951367781, 4398.274284743014, 4185.393117997874, 4202.726822756511, 4231.555686652919, 4271.252530807096, 4284.228838809013, 4253.744775313491, 4271.743695378256, 4274.636655884254, 4278.122984788111, 4279.40088387626, 4181.91636167278, 4212.389203565496, 4220.873373798791, 4231.196072746168, 4250.3199488081755, 4610.792514336829, 4665.346851440801, 4666.743329116897, 4668.0, 4684.601808846252, 4911.705297682115, 4925.458199598042, 4930.383702037246, 4931.01379724053, 4985.476524964863, 4951.678140920829, 4954.801807927679, 4956.90086198274, 4962.379702537183, 5012.323336349583, 4446.955530444687, 4487.551244875486, 4540.8637740867825, 4596.816127354935, 4597.402337696078, 4997.775100120503, 5029.874253143701, 5087.516685914832, 5089.236614507779, 5091.592672586185, 4740.241561350167, 4785.090832741768, 4827.975860120677, 4836.564709176191, 4905.2151655734915, 4792.041591681677, 4835.1296766581645, 4857.344258525054, 4904.509549045067, 4922.827701030446, 4819.349387832668, 4854.708717476963, 4856.368672072608, 4943.233798761198, 4957.082939656175, 4852.4662287148385, 4885.487023862514, 4886.486918873538, 4899.436564795023, 4942.283368911488, 4232.597903199191, 4239.936400953927, 4241.1941731071, 4247.787610619518, 4293.806778694904, 3654.8903532893523, 3671.0, 3691.187938653492, 3697.6302369762807, 3715.256948610289, 4263.637590804754, 4273.1026484438, 4275.4441922550495, 4331.371951067078, 4333.674974376934, 4932.112219800399, 4934.309196712463, 4937.11131996237, 4942.283368911488, 4993.0, 4217.093324935154, 4255.765932873722, 4270.957290427056, 4272.401863739079, 4281.0, 4437.312216606431, 4463.174312752151, 4483.237849565582, 4528.049109687003, 4549.749763763025, 4646.837360692495, 4648.116857797076, 4651.790669419952, 4704.858854234379, 4775.617950563947, 4837.0, 4869.95130048695, 4873.756312184306, 4880.609551235963, 4945.109880221595, 4555.293929440942, 4604.102200070954, 4623.976880115578, 4764.380630518011, 4784.64115191369, 4971.850844474671, 4973.104841128632, 4975.825846095369, 5023.34696489454, 5026.698398096126, 5017.046761115376, 5035.093683137071, 5036.6726162799305, 5048.646594738333, 5098.0, 4759.3336932830125, 4778.808847646055, 4830.130576496264, 4883.926741098958, 4972.726500042532, 4753.025629745963, 4816.301636262792, 4819.397575303087, 4874.147024270667, 4876.926846097241, 4734.360861283682, 4741.312509686145, 4743.739094349844, 4746.92879606813, 4784.47370789206, 4704.411948506437, 4746.7863946121815, 4834.540718631724, 4843.370361853077, 4900.95099049005, 4682.344471774022, 4721.362616046789, 4733.171694953438, 4738.0, 4803.687760295569], "value": 4544.941863311566, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.983290501285, 574.3825387708214, 579.7883772423066, 580.6051884718393, 580.6719203649935, 28500.0, 38434.0, 39983.40024899629, 40019.39970900435, 42993.0, 40342.59657403425, 40827.795861020655, 40829.0, 40831.18337633253, 40837.18325633493, 7615.619219039054, 7772.533647981111, 7773.144954055049, 7773.261540153676, 7776.805579860492, 7584.165741768401, 7674.923250767504, 7677.577733224671, 7679.424043196755, 7679.884801727979, 7678.961605191967, 7714.305712485875, 7720.382369410462, 7721.0, 7724.9227507725045, 7668.693252269931, 7703.345215656648, 7707.768766937001, 7710.1904300048245, 7714.459987800856, 7666.271704188093, 7764.961175194145, 7767.262110099531, 7768.145503994556, 7769.028871391076, 37715.434268485995, 38021.61978380208, 38024.0, 38082.23835523274, 38119.0, 2875.166201801475, 2889.927751806201, 2901.8839246430116, 3194.648588655246, 3196.1394551876174, 28545.0, 28735.27588344706, 28775.424491510053, 28824.711752882413, 29715.851420742758, 3262.934741305184, 3336.4995250712345, 3351.8324083795956, 3360.294338188983, 3398.065531978701, 250047.0, 250754.99999999817, 250999.0, 252041.0, 252231.99999999817, 51699.224511632354, 52020.21969670458, 52070.47929520732, 52124.47875521196, 52148.0, 31677.0, 32931.50602740961, 32997.83501082527, 34371.0, 34426.0, 13765.793513097311, 13941.093828901088, 13941.930290348484, 13944.651383715489, 13955.302234888215, 10447.164226861833, 10533.157347412189, 10535.736606584744, 10548.736281592868, 10556.313839600401, 17202.397916072878, 17286.394976175772, 17505.0, 17603.82396176022, 17630.91184544069, 6569.0, 6631.734730610721, 6681.298463661343, 6833.0, 6857.55425897315, 749.4603885202754, 917.2478567574525, 948.8861336639509, 955.1165172215673, 977.7946631207384, 26694.5995810063, 26999.595006074924, 27276.863615681796, 27627.309317266827, 27746.02888898879, 872.3631748823394, 939.8252184769038, 975.8389865672226, 982.526210683974, 996.0288718499405, 13727.862721372858, 14692.632684182981, 14698.0, 14856.108633482027, 14971.92514037423, 372323.0, 375180.0, 375566.0, 375582.0, 375865.0, 47686.76156619264, 48274.75862620665, 48288.275675864184, 48313.27530087052, 48340.758296208296, 1060.3160961179997, 1084.9132069434427, 1133.0935251798694, 1134.2117228526095, 1175.841261429713, 25788.484230315666, 28710.851565937963, 29121.85439072791, 29337.55993660054, 29600.407991840475, 41213.381799272436, 41764.79117604514, 41794.79102604589, 41827.7908610455, 41888.581114189685, 225983.0, 227260.0, 227260.0, 227525.0, 228223.0, 21988.780112199314, 22736.317910462712, 23845.523089537764, 24623.507529848943, 25007.624885626366, 40349.0, 40565.0, 40633.39049914313, 40830.38754418627, 41135.971600710225, 33835.83082084574, 34461.65538344585, 34893.825530872185, 35107.29785404226, 35255.0, 34728.479072814436, 34736.30527389388, 34848.303033938675, 35075.473867891495, 35322.470162947066, 33793.0, 34062.0, 34333.484997724554, 34456.13859653529, 34870.47694284537, 29433.55849662214, 31712.207194820316, 32025.679743203204, 32111.35777284488, 32332.83833580817, 24234.394140146636, 24330.27009189727, 24511.387215319046, 24582.50834983326, 24940.625890611293], "value": 16753.987307090523, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.929494453637, 344.54003904787123, 349.0471014131422, 351.4938488576448, 363.30064625595736, 15266.465673701423, 15988.760168597466, 16073.276702548384, 16773.329066837312, 16911.40810071648, 15858.444954426597, 15938.840611593881, 16331.755023674625, 16418.343266269363, 16431.0, 4951.876203094934, 4978.203487442001, 5137.229415587654, 5156.484351564851, 5157.123289040854, 5119.462456442057, 5139.357580302462, 5180.715060671661, 5182.222666600002, 5182.300389447433, 4897.3878265216845, 5038.546530812227, 5059.974700126494, 5071.2139618359215, 5140.177571588547, 5035.395752509704, 5075.213341932006, 5079.263506791532, 5079.568236699885, 5080.364954380702, 4333.090051089243, 4451.176532341495, 4469.865904022885, 4483.798229079699, 4513.368128462018, 20092.69860952087, 20095.89952050245, 20263.29078482246, 20294.898525507277, 20378.0, 1895.5924476237676, 1977.5352792093847, 2143.528423746789, 2161.848670593059, 2264.241479104502, 12643.683907902285, 12842.293673847935, 12955.740885182338, 13029.0, 13511.932440337834, 1672.6654669066236, 1679.7480377943284, 1715.1081437652476, 1743.564108972757, 1812.4925020994142, 65081.67459162674, 66600.3339966599, 66803.66598166978, 67520.3247967519, 68350.65824670845, 8679.826403471896, 8684.305255579664, 8822.206001459772, 8861.86012112973, 9099.636014559343, 12109.878901210875, 12132.211406258564, 12137.817932731015, 12144.817827732591, 12224.083193760503, 6468.8059358219325, 6580.243272023683, 6604.207495100619, 6683.097781799492, 6747.874419557824, 6313.715882785285, 6319.6208227506495, 6435.710393032325, 6570.375814297634, 6573.835654108686, 5517.2551705519245, 5667.518260947783, 5689.829305120853, 5808.651480911159, 5898.410158984153, 1632.6979508790912, 1643.589102724319, 1674.506020723865, 1689.2820551265663, 1715.6482921001166, 802.2218448105328, 813.7459237910954, 818.7380038387658, 857.1557016338901, 877.9561021949005, 16053.357865685242, 16829.611368188813, 17193.31226750941, 17615.38346157904, 17745.7338139928, 835.6699103853944, 840.2857571064668, 849.439370015799, 856.2208390364738, 857.8970523537215, 9433.0, 9805.558749856273, 9893.554790034466, 10066.496675166212, 10146.391216527032, 348961.0, 349343.0, 358494.0, 358738.0, 358851.0, 39458.60541394607, 40192.196156076716, 62249.68875155595, 66263.33736662669, 66723.66638166778, 861.9655213791503, 894.458852394305, 907.228855472856, 911.1526280559144, 915.638322862479, 15241.31414086391, 15279.465218717292, 15867.28597213105, 16113.919430402773, 16297.755533666766, 38054.23891522099, 38165.0, 38517.0, 38655.42016869805, 39322.0, 52066.47933520616, 52113.0, 52595.21107183472, 52760.73619631877, 53476.19785703295, 7005.509614326948, 7158.570485770871, 7246.7101315948885, 7393.0, 7915.327197188303, 10923.235373523778, 11293.71765705831, 11653.92522804868, 11867.109966752356, 11868.940655296668, 9417.952910235404, 9549.140577348073, 9744.269179811401, 9894.950525247328, 10140.29017968735, 9675.70972870815, 10112.49437528106, 10154.847677284994, 10262.384256944608, 10268.383896966207, 9474.14732674035, 9668.85496717564, 9783.119519243302, 9885.3574517659, 10082.193424526167, 7181.497295189495, 7274.16347120088, 7283.526570772883, 7329.083864516935, 7479.626018699152, 7635.541867487968, 9454.480003599869, 9638.855417168608, 9754.610425308498, 9847.60609575609], "value": 7968.024005293207, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1197.5090213012656, 1293.4890718166325, 1312.4381985437328, 1327.2103098656296, 1620.7244768389373, 6402.839929001777, 6877.862442751149, 7121.430285577155, 7125.714971401144, 7312.780616581498, 7085.078939737839, 7143.178534468538, 7174.6771395287205, 7176.0, 7184.892226616605, 2002.8297594704432, 2020.333290014299, 2023.251396983111, 2026.8783872967595, 2029.7767245603045, 2008.9296874609392, 2067.5554755727517, 2074.73028506294, 2076.771555128935, 2087.7077209190725, 2041.397787652646, 2044.37646517812, 2053.1068984991502, 2053.3121404329495, 2059.835213182942, 2001.9299324523645, 2011.6077364913847, 2012.7584689837167, 2013.2550956146174, 2018.1927229108328, 1949.6198241342943, 1955.2960934063726, 1956.4521933858543, 1956.8825870447818, 1957.5889063296725, 7227.457940654472, 7466.104067511933, 7569.280918312751, 7569.886451703229, 7591.848163036763, 4149.211649786531, 4269.402283680287, 4275.123599662062, 4285.207236661227, 4293.463317085364, 2660.135455976796, 2743.1359121876544, 2807.8034537582375, 2809.3538486148095, 2818.422223444189, 887.2148148888281, 894.1237587164616, 907.9001309855911, 913.7532866126109, 922.4649703172211, 10053.698389048268, 10108.797824043479, 10158.542865571068, 10160.644377446753, 10164.44095574743, 3611.8194090295906, 3689.5019172411917, 3858.498395208605, 3870.767753934773, 3884.320243957296, 8003.6798528058225, 8013.11855695873, 8015.198480151938, 8019.879701804478, 8025.9598702006115, 4347.608715215646, 4353.49934757507, 4355.869323920288, 4358.193734159191, 4364.1053584015835, 3514.7012503937453, 3643.5809881863397, 3865.536135663738, 4074.6536544393466, 4099.9180016400105, 3170.682931706857, 3201.6798320168264, 3329.583802024747, 3339.1819004343606, 3346.0798280473064, 977.6187286958092, 990.3955591941102, 995.5669283861544, 1000.3547711725896, 1004.5278719002057, 652.3900153356627, 705.4321271376591, 761.584936209767, 803.7628899474669, 872.6771094694876, 4953.554180123806, 5035.949640503622, 5086.3896332440345, 5208.9739551302, 5465.316835395575, 362.9600743918167, 369.0993974701773, 375.228904601042, 376.1048704084262, 379.6298608856343, 3447.3622379859808, 3590.0, 3723.3670276053135, 3759.5112635357227, 3762.7177961652988, 8359.665613375519, 8673.91326086731, 8879.689210877588, 9020.684276050306, 9102.499362534993, 8592.312614990786, 8865.734027979172, 8885.0, 8890.06654301302, 8893.955530222436, 6649.966750166218, 6686.5653732507235, 6824.829379265558, 6826.795196144124, 6864.828379290558, 5171.534561889448, 5362.9094455474615, 5433.5924805640525, 5502.889942201214, 5590.105583106846, 8465.83068338642, 8469.830603388022, 8471.703490377808, 8525.658973640984, 8550.05949345584, 8471.49171049739, 8527.275181609384, 8533.061363249913, 8620.181082797124, 8802.075782042793, 5594.188842617879, 6574.605523668595, 6664.0670306158145, 6675.03212034262, 6684.06423100776, 6431.228252609717, 6478.3197764235965, 6965.33829286217, 7029.226785053742, 7230.74692385764, 6252.937470625236, 6378.425941665272, 6613.107230523818, 6672.299408562031, 6741.056252124805, 6389.616623002635, 6443.194600674916, 6457.031445283245, 6458.806235812933, 6471.611703297817, 6140.9078863816185, 6287.371262873859, 6302.275238347649, 6306.936930630635, 6324.7153878076515, 4482.103579284091, 4484.237679594412, 4553.362529245842, 4582.152301824173, 4587.655925805645, 4535.727856328631, 4542.477615074176, 4564.201264778584, 4570.405847239837, 4618.653600979873], "value": 3808.5428034089086, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.1539742113631, 274.90790585153974, 276.3864221428429, 278.7969909839043, 283.92192147159534, 4820.156472617291, 4821.4696383397795, 4827.903441931159, 4840.443349014856, 4851.593038018975, 4732.46194986629, 4749.786259618317, 4752.47722750498, 4766.904661906759, 4772.475027746945, 3522.36597412465, 3633.401303426497, 3635.963640363589, 3637.690796282306, 3640.8361623726864, 3544.982275088621, 3619.49327094207, 3681.8527258909744, 3686.262747450507, 3727.0, 3676.816159192043, 3687.446882967563, 3692.593814680383, 3692.6676599106077, 3694.4643026761105, 3612.169201083739, 3695.90760230995, 3700.648438398348, 3701.222743223926, 3758.7932663703623, 3249.545063691085, 3252.544643749853, 3257.7719559630837, 3260.2012506935953, 3265.134739294089, 4597.655175861823, 4609.354690343354, 4616.8153273869, 4625.4911959684405, 4686.2267725825195, 3967.920641587152, 4117.258893399187, 4123.876283711494, 4207.137536804948, 4217.186609757803, 4876.853694389174, 4877.1708809502115, 4886.70679759212, 4895.559399654048, 4914.508549145093, 3433.7939723616414, 3446.138465383654, 3449.344624521358, 3453.1194545390763, 3486.773359731609, 5054.0, 5156.819511317086, 5193.818216362409, 5196.662216955886, 5201.973990130025, 3496.4056110461283, 3503.1767534629344, 3504.8948531544092, 3504.9824750876082, 3505.8422370993367, 3540.061883600848, 3541.592716837545, 3545.858165673396, 3556.395412779834, 3592.6586974237407, 4088.814243869245, 4090.6091928744368, 4095.959040409558, 4097.959020409758, 4101.5488296287385, 4685.5782979532005, 4933.728644924492, 4945.455999840086, 4952.727599982036, 4998.6500944933505, 1234.1854376111723, 1240.4665993622648, 1243.6320047947368, 1247.09585550477, 1253.1165528302524, 768.4006474949548, 772.3435080181913, 783.4006984656742, 784.8822676598442, 794.4875555266821, 3977.5226972763453, 4242.575742425733, 4346.21768081742, 4435.401220835146, 4500.392447019611, 5098.643094983389, 5130.358705161855, 5163.173892177234, 5163.561097306771, 5183.533481986639, 4405.40527028847, 4428.933565996513, 4435.179491794029, 4442.267025940748, 4456.0, 2586.6766654168227, 2697.4874773792917, 2725.1960671601923, 2740.369714965529, 2743.0810678422554, 4932.531409516162, 4938.333325001151, 4940.530649588283, 4948.678335908155, 4952.702837829742, 5239.73801309933, 5241.947580524222, 5248.868778280574, 5253.55344795689, 5258.158694608845, 4726.976365118152, 4876.536729010738, 4902.607791376681, 4904.215325547895, 4912.877178070506, 5090.396525094583, 5101.3113229715, 5103.923441148311, 5120.974395128001, 5138.818071843422, 5027.874303142451, 5028.0, 5055.545000949932, 5060.696358218519, 5062.190049592047, 4668.762777863937, 4838.0, 4873.512648735098, 4887.242477416006, 4896.192128298933, 3578.5884623267616, 3580.3555360035443, 3589.641035896494, 3590.407582748922, 3591.37150998569, 5093.821716239914, 5095.363079615048, 5115.820946266863, 5150.40770311404, 5152.871178220575, 4682.742449165328, 4964.726940018334, 5006.924896126488, 5011.348524691767, 5023.57299629521, 5011.123053465702, 5023.709470296962, 5025.165814477617, 5035.985605757726, 5048.9649621828175, 4941.70349779, 4944.208926571731, 4944.788526810954, 4977.178765503796, 4977.552020318189, 4753.358296629911, 4896.730679812645, 4994.350734404504, 5032.295478632921, 5051.368578927634, 4764.166270902648, 4808.206645903387, 4911.435184953776, 4924.285978533164, 4925.679830810986], "value": 3718.7274828883374, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.4216751918158, 638.2914964389527, 674.7739507265065, 699.9230084690686, 719.7408932784197, 11942.402879856005, 12402.565910193145, 12423.875761242385, 12424.503019879217, 12427.88149066585, 11617.767644647101, 11856.881431185686, 11915.165938384316, 12077.214981026227, 12185.268883866975, 605.9091136329564, 721.422861710632, 736.3740820302727, 739.1462860396251, 740.1155619035255, 619.7087368936593, 721.0410154494535, 745.7278093495862, 753.0398741604444, 754.9169591344947, 786.3512602103287, 787.8975733154682, 788.5111231036765, 791.0112359550562, 791.0507391130637, 630.180765005491, 781.2734157233771, 781.6521647866701, 782.6399856066216, 783.0485959559135, 475.8049199828054, 547.1164070026917, 565.1409857017352, 567.5941701683316, 569.9914501282484, 12577.11960162789, 12582.937085314607, 12585.685357866036, 12604.432800523999, 12621.432035558422, 11477.0, 12139.939300303531, 12256.08079394049, 12344.259344439362, 12381.566645167466, 11970.40147992597, 11987.58043468483, 12006.579769708018, 12105.818412723816, 12145.0, 4210.642095421862, 4221.092465119983, 4233.470816147981, 4311.568843115695, 4325.13497300538, 61317.38682613206, 61537.76924461486, 61581.692091539255, 61736.69131654313, 61859.381406185814, 9978.401295922267, 10030.31220078483, 10103.090721834924, 10711.678649640524, 10715.624953126604, 18679.533011674815, 18683.90658046701, 18711.812881871007, 18737.531561710795, 18740.344087956855, 6983.406410455168, 6985.3713165815325, 6998.6500674967065, 7006.124234470692, 7010.894836577353, 3606.6753992140834, 3671.100580357776, 3750.7562008469363, 3836.9040773980314, 3837.0407398150464, 2731.2762118038736, 2786.0805934042123, 2811.353388720606, 2813.4373125375005, 2827.929301767472, 471.94572624147975, 477.6202918679658, 480.56508859482227, 494.53513697125305, 495.35603715170134, 414.40119028004244, 428.25056151734464, 448.6321216602355, 462.2188501432568, 535.7650615331698, 8046.9597652012535, 8183.508989460533, 8478.491290522588, 8638.611262493203, 8753.868691969625, 484.58810011489953, 528.5375296615462, 551.0907003444349, 553.673332733681, 557.0808166525185, 3747.2130852521277, 3802.296575133609, 3813.9809300953316, 3883.514560679915, 4148.419221309019, 56706.77751725977, 57068.714656426455, 57117.42882571204, 57119.42880571141, 58069.12896306559, 50547.74726126346, 68882.96675549871, 74591.0, 80099.59950200212, 89424.0, 78503.60748196336, 79061.20938790539, 79611.60194199224, 79725.80411293835, 80235.0, 7459.850802983801, 7744.380449563909, 8027.2775450209765, 8112.878306825521, 8212.17878212174, 44052.55947440484, 44367.77816110899, 45431.772841135586, 46166.30750538812, 46718.0, 60022.69648204535, 67935.66032169807, 68427.0, 68518.65740671265, 71696.0, 10146.644867429604, 10185.287029908131, 10620.734481638021, 10623.681289561326, 10904.836427453753, 11338.829917551078, 11617.593384231512, 11636.767264654829, 11645.708857278636, 12039.63881083569, 10253.07722304996, 10368.896311036793, 10509.894901050891, 10548.472576371305, 10558.31370960885, 10466.267361284637, 10707.785844283226, 10778.407187604756, 10858.891411086104, 10997.780044398907, 9776.364536305118, 9780.315377923476, 10117.848232276374, 10265.948670256601, 10454.895451045697, 8237.546934918637, 8340.35005555257, 8652.221300083023, 8744.387892847439, 8990.325725570478, 8596.527191004554, 8957.10428957125, 8987.640494380152, 9003.189712925869, 9321.30090243248], "value": 6215.5330781586645, "unit": "score"}], "name": "dromaeo_css", "value": 6136.868187426138, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 119.0, 116.0, 115.0, 117.0, 118.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 125.0, 128.0, 167.0, 126.0, 124.0, 128.0, 125.0, 193.0, 129.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 162.0, 164.0, 162.0, 163.0, 161.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 110.0, 76.0, 76.0, 76.0, 75.0, 111.0, 77.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 118.0, 85.0, 83.0, 85.0, 116.0, 83.0, 84.0, 115.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 148.0, 148.0, 146.0, 147.0, 146.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 64.0, 65.0, 66.0, 64.0, 64.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 65.0, 68.0, 66.0, 67.0, 66.0, 66.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 87.0, 88.0, 85.0, 83.0, 83.0, 82.0, 82.0, 83.0, 82.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 147.0, 135.0, 135.0, 133.0, 136.0, 137.0, 182.0, 132.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 175.0, 177.0, 180.0, 173.0, 177.0, 178.0, 176.0, 177.0, 175.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 73.0, 73.0, 70.0, 73.0, 74.0, 71.0, 69.0, 68.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1558.9, "alertThreshold": 2.0}]} 09:03:52 INFO - Return code: 0 09:03:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:03:52 INFO - # TBPL SUCCESS # 09:03:52 INFO - Running post-action listener: _resource_record_post_action 09:03:52 INFO - [mozharness: 2016-09-22 16:03:52.417695Z] Finished run-tests step (success) 09:03:52 INFO - Running post-run listener: _resource_record_post_run 09:03:52 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406589440; Read time: 8; Write time: 255384 09:03:52 INFO - TinderboxPrint: CPU usage
13.0% 09:03:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:03:52 INFO - TinderboxPrint: I/O write bytes / time
406,589,440 / 255,384 09:03:52 INFO - TinderboxPrint: CPU idle
8,341.5 (87.0%) 09:03:52 INFO - TinderboxPrint: CPU user
1,200.7 (12.5%) 09:03:52 INFO - TinderboxPrint: Swap in / out
0 / 0 09:03:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115920896; Read time: 0; Write time: 74988 09:03:52 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 290131968; Read time: 0; Write time: 180372 09:03:53 INFO - Running post-run listener: _upload_blobber_files 09:03:53 INFO - Blob upload gear active. 09:03:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:03: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 09:03: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'] 09:03: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 09:03:53 INFO - (blobuploader) - INFO - Open directory for files ... 09:03:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:03:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:03:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:56 INFO - (blobuploader) - INFO - Done attempting. 09:03:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:03:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:03:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:57 INFO - (blobuploader) - INFO - Done attempting. 09:03:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:03:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:03:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:58 INFO - (blobuploader) - INFO - Done attempting. 09:03:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:58 INFO - Return code: 0 09:03:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c750fab8161400219e4d546636cdfb9c7e379c96e76f0794ffb8680bde9a3634729ccf7385d4a217014743cc7edcf010bafa6ccbc6145a51af8e3cf69e5dd657", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6215456fa36faade2dd7e4317e1cabf48a6f5fb1249e13d67abd16dd9df179e65a5db3cd6dfcb25d3134311cf82139daa701fa510d7505a9810a3107ce858aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b752caf6c17dabdf74e5d3e00f89b6458e3887fa5e1edfad44b8813bb7f489e8630fcca49c513a6b2db9270c69f128d6bf3932e6c35bb07dcfd6142bb3cf3944"} 09:03:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:58 INFO - Contents: 09:03:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c750fab8161400219e4d546636cdfb9c7e379c96e76f0794ffb8680bde9a3634729ccf7385d4a217014743cc7edcf010bafa6ccbc6145a51af8e3cf69e5dd657", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6215456fa36faade2dd7e4317e1cabf48a6f5fb1249e13d67abd16dd9df179e65a5db3cd6dfcb25d3134311cf82139daa701fa510d7505a9810a3107ce858aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b752caf6c17dabdf74e5d3e00f89b6458e3887fa5e1edfad44b8813bb7f489e8630fcca49c513a6b2db9270c69f128d6bf3932e6c35bb07dcfd6142bb3cf3944"} 09:03:58 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:58 INFO - Copying logs to upload dir... 09:03:58 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.032601 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-22 09:03:58.070857) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 09:03:58.074830) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355 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/c750fab8161400219e4d546636cdfb9c7e379c96e76f0794ffb8680bde9a3634729ccf7385d4a217014743cc7edcf010bafa6ccbc6145a51af8e3cf69e5dd657", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6215456fa36faade2dd7e4317e1cabf48a6f5fb1249e13d67abd16dd9df179e65a5db3cd6dfcb25d3134311cf82139daa701fa510d7505a9810a3107ce858aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b752caf6c17dabdf74e5d3e00f89b6458e3887fa5e1edfad44b8813bb7f489e8630fcca49c513a6b2db9270c69f128d6bf3932e6c35bb07dcfd6142bb3cf3944"} build_url:https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/DUalvtIjSXOzMm49g5F3cw/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/c750fab8161400219e4d546636cdfb9c7e379c96e76f0794ffb8680bde9a3634729ccf7385d4a217014743cc7edcf010bafa6ccbc6145a51af8e3cf69e5dd657", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6215456fa36faade2dd7e4317e1cabf48a6f5fb1249e13d67abd16dd9df179e65a5db3cd6dfcb25d3134311cf82139daa701fa510d7505a9810a3107ce858aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b752caf6c17dabdf74e5d3e00f89b6458e3887fa5e1edfad44b8813bb7f489e8630fcca49c513a6b2db9270c69f128d6bf3932e6c35bb07dcfd6142bb3cf3944"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 09:03:58.100912) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 09:03:58.101316) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1474558349.551830-1513983355 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004377 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 09:03:58.183430) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 09:03:58.183777) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 09:03:58.184190) ========= ========= Total master_lag: 0.17 =========