builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1474676469.2 results: success (0) buildid: 20160923153005 builduid: 54d00c2fd1c84cc79c913eb78d62c3c7 revision: 92d96352192c049c6c3c66e61f3d3c8f4545aaab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 17:21:09.203655) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 17:21:09.204213) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 17:21:09.204493) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 17:21:09.219074) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:21:09.219339) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-23 17:21:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2016-09-23 17:21:10 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092121 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:21:09.325961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:21:09.326236) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014432 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:21:09.377240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:21:09.377555) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 92d96352192c049c6c3c66e61f3d3c8f4545aaab --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 92d96352192c049c6c3c66e61f3d3c8f4545aaab --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=e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-23 17:21:10,484 truncating revision to first 12 chars 2016-09-23 17:21:10,484 Setting DEBUG logging. 2016-09-23 17:21:10,485 attempt 1/10 2016-09-23 17:21:10,485 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/92d96352192c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 17:21:10,971 unpacking tar archive at: fx-team-92d96352192c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.780643 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:21:10.175433) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 17:21:10.175742) ========= script_repo_revision: 92d96352192c049c6c3c66e61f3d3c8f4545aaab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 17:21:10.176094) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 17:21:10.176564) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 17:21:10.186993) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-23 17:21:10.187255) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:21:11 INFO - MultiFileLogger online at 20160923 17:21:11 in /builds/slave/test 17:21:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:21:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:21:11 INFO - {'append_to_log': False, 17:21:11 INFO - 'base_work_dir': '/builds/slave/test', 17:21:11 INFO - 'blob_upload_branch': 'Fx-Team', 17:21:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:21:11 INFO - 'branch': 'Fx-Team', 17:21:11 INFO - 'buildbot_json_path': 'buildprops.json', 17:21:11 INFO - 'config_files': ('talos/linux_config.py',), 17:21:11 INFO - 'default_actions': ('clobber', 17:21:11 INFO - 'read-buildbot-config', 17:21:11 INFO - 'download-and-extract', 17:21:11 INFO - 'populate-webroot', 17:21:11 INFO - 'create-virtualenv', 17:21:11 INFO - 'install', 17:21:11 INFO - 'run-tests'), 17:21:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:21:11 INFO - 'download_minidump_stackwalk': True, 17:21:11 INFO - 'download_symbols': 'ondemand', 17:21:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:21:11 INFO - 'tooltool.py': '/tools/tooltool.py', 17:21:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:21:11 INFO - '/tools/misc-python/virtualenv.py')}, 17:21:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:21:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:21:11 INFO - 'installer_path': 'installer.exe', 17:21:11 INFO - 'log_level': 'info', 17:21:11 INFO - 'log_name': 'talos', 17:21:11 INFO - 'log_to_console': True, 17:21:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:21:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:21:11 INFO - 'opt_config_files': (), 17:21:11 INFO - 'pip_index': False, 17:21:11 INFO - 'sps_profile': False, 17:21:11 INFO - 'sps_profile_interval': 0, 17:21:11 INFO - 'suite': 'dromaeojs-e10s', 17:21:11 INFO - 'system_bits': '32', 17:21:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:21:11 INFO - 'title': 'talos-linux64-ix-067', 17:21:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:21:11 INFO - 'use_talos_json': True, 17:21:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:21:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:21:11 INFO - 'work_dir': 'build'} 17:21:11 INFO - [mozharness: 2016-09-24 00:21:11.388069Z] Running clobber step. 17:21:11 INFO - Running pre-action listener: _resource_record_pre_action 17:21:11 INFO - Running main action method: clobber 17:21:11 INFO - rmtree: /builds/slave/test/build 17:21:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:21:11 INFO - Running post-action listener: _resource_record_post_action 17:21:11 INFO - [mozharness: 2016-09-24 00:21:11.845379Z] Finished clobber step (success) 17:21:11 INFO - [mozharness: 2016-09-24 00:21:11.845479Z] Running read-buildbot-config step. 17:21:11 INFO - Running pre-action listener: _resource_record_pre_action 17:21:11 INFO - Running main action method: read_buildbot_config 17:21:11 INFO - Using buildbot properties: 17:21:11 INFO - { 17:21:11 INFO - "project": "", 17:21:11 INFO - "product": "firefox", 17:21:11 INFO - "script_repo_revision": "production", 17:21:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:21:11 INFO - "repository": "", 17:21:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:21:11 INFO - "buildid": "20160923153005", 17:21:11 INFO - "pgo_build": "True", 17:21:11 INFO - "basedir": "/builds/slave/test", 17:21:11 INFO - "buildnumber": 1201, 17:21:11 INFO - "slavename": "talos-linux64-ix-067", 17:21:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:21:11 INFO - "platform": "ubuntu64_hw", 17:21:11 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:21:11 INFO - "branch": "fx-team", 17:21:11 INFO - "repo_path": "integration/fx-team", 17:21:11 INFO - "revision": "92d96352192c049c6c3c66e61f3d3c8f4545aaab", 17:21:11 INFO - "stage_platform": "linux64-pgo", 17:21:11 INFO - "builduid": "54d00c2fd1c84cc79c913eb78d62c3c7", 17:21:11 INFO - "slavebuilddir": "test" 17:21:11 INFO - } 17:21:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 17:21:11 INFO - Running post-action listener: _resource_record_post_action 17:21:11 INFO - [mozharness: 2016-09-24 00:21:11.847958Z] Finished read-buildbot-config step (success) 17:21:11 INFO - [mozharness: 2016-09-24 00:21:11.848048Z] Running download-and-extract step. 17:21:11 INFO - Running pre-action listener: _resource_record_pre_action 17:21:11 INFO - Running main action method: download_and_extract 17:21:11 INFO - mkdir: /builds/slave/test/build/tests 17:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:11 INFO - trying https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:21:11 INFO - Downloading https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/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 17:21:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/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 17:21:12 INFO - Downloaded 1361 bytes. 17:21:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:21:12 INFO - Using the following test package requirements: 17:21:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:21:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:21:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:21:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:12 INFO - u'jsshell-linux-x86_64.zip'], 17:21:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:21:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:21:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:21:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:21:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:21:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:21:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:21:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:21:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:21:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:21:12 INFO - Fetch https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:21:13 INFO - Expected file size: 21948401 17:21:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:21:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:21:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:21:18 INFO - Fetch https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:21:19 INFO - Expected file size: 21948401 17:21:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 17:21:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:21:24 INFO - Fetch https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 17:21:24 INFO - Expected file size: 14414059 17:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:25 INFO - trying https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:21:25 INFO - Downloading https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/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 17:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/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 17:21:28 INFO - Downloaded 59685593 bytes. 17:21:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:21:28 INFO - mkdir: /builds/slave/test/properties 17:21:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:21:28 INFO - Writing to file /builds/slave/test/properties/build_url 17:21:28 INFO - Contents: 17:21:28 INFO - build_url:https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:21:28 INFO - Running post-action listener: _resource_record_post_action 17:21:28 INFO - Running post-action listener: set_extra_try_arguments 17:21:28 INFO - [mozharness: 2016-09-24 00:21:28.906605Z] Finished download-and-extract step (success) 17:21:28 INFO - [mozharness: 2016-09-24 00:21:28.906832Z] Running populate-webroot step. 17:21:28 INFO - Running pre-action listener: _resource_record_pre_action 17:21:28 INFO - Running main action method: populate_webroot 17:21:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:21:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:21:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:21:28 INFO - '--tppagecycles', 17:21:28 INFO - '7'], 17:21:28 INFO - 'tests': ['tsvgm']}}, 17:21:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:21:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:21:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:21:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:21:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:21:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:21:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:28 INFO - 'talos_options': ['--disable-e10s'], 17:21:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:21:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:21:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:28 INFO - 'talos_options': ['--disable-e10s'], 17:21:28 INFO - 'tests': ['damp', 'tps']}, 17:21:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:28 INFO - 'tests': ['damp', 'tps']}, 17:21:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:21:28 INFO - 'tests': ['dromaeo_dom']}, 17:21:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:21:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:21:28 INFO - 'tests': ['basic_compositor_video']}, 17:21:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:21:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:21:28 INFO - 'tests': ['a11yr', 17:21:28 INFO - 'ts_paint', 17:21:28 INFO - 'tpaint', 17:21:28 INFO - 'sessionrestore', 17:21:28 INFO - 'sessionrestore_no_auto_restore', 17:21:28 INFO - 'tabpaint']}, 17:21:28 INFO - 'other-e10s': {'tests': ['a11yr', 17:21:28 INFO - 'ts_paint', 17:21:28 INFO - 'tpaint', 17:21:28 INFO - 'sessionrestore', 17:21:28 INFO - 'sessionrestore_no_auto_restore', 17:21:28 INFO - 'tabpaint']}, 17:21:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:21:28 INFO - 'ts_paint', 17:21:28 INFO - 'tpaint', 17:21:28 INFO - 'sessionrestore', 17:21:28 INFO - 'sessionrestore_no_auto_restore', 17:21:28 INFO - 'tabpaint']}, 17:21:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:21:28 INFO - 'ts_paint', 17:21:28 INFO - 'tpaint', 17:21:28 INFO - 'sessionrestore', 17:21:28 INFO - 'sessionrestore_no_auto_restore', 17:21:28 INFO - 'tabpaint']}, 17:21:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:21:28 INFO - 'tests': ['a11yr', 17:21:28 INFO - 'ts_paint', 17:21:28 INFO - 'tpaint', 17:21:28 INFO - 'sessionrestore', 17:21:28 INFO - 'sessionrestore_no_auto_restore', 17:21:28 INFO - 'tabpaint']}, 17:21:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:21:28 INFO - 'tests': ['a11yr', 17:21:28 INFO - 'ts_paint', 17:21:28 INFO - 'tpaint', 17:21:28 INFO - 'sessionrestore', 17:21:28 INFO - 'sessionrestore_no_auto_restore', 17:21:28 INFO - 'tabpaint']}, 17:21:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:21:28 INFO - 'tests': ['tsvgx', 17:21:28 INFO - 'tsvgr_opacity', 17:21:28 INFO - 'tart', 17:21:28 INFO - 'tscrollx', 17:21:28 INFO - 'cart']}, 17:21:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:21:28 INFO - 'tsvgr_opacity', 17:21:28 INFO - 'tart', 17:21:28 INFO - 'tscrollx', 17:21:28 INFO - 'cart']}, 17:21:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:28 INFO - 'talos_options': ['--disable-e10s'], 17:21:28 INFO - 'tests': ['tp5o']}, 17:21:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:28 INFO - 'tests': ['tp5o']}, 17:21:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:28 INFO - 'talos_options': ['--disable-e10s', 17:21:28 INFO - '--xperf_path', 17:21:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:21:28 INFO - 'tests': ['tp5n']}, 17:21:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:21:28 INFO - 'talos_options': ['--xperf_path', 17:21:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:21:28 INFO - 'tests': ['tp5n']}}, 17:21:28 INFO - 'talos.zip': {'path': '', 17:21:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:21:28 INFO - Running post-action listener: _resource_record_post_action 17:21:28 INFO - [mozharness: 2016-09-24 00:21:28.927471Z] Finished populate-webroot step (success) 17:21:28 INFO - [mozharness: 2016-09-24 00:21:28.927561Z] Running create-virtualenv step. 17:21:28 INFO - Running pre-action listener: _resource_record_pre_action 17:21:28 INFO - Running main action method: create_virtualenv 17:21:28 INFO - Creating virtualenv /builds/slave/test/build/venv 17:21: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 17:21:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:21:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:21:29 INFO - Using real prefix '/usr' 17:21:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:21:29 INFO - Installing distribute.............................................................................................................................................................................................done. 17:21:31 INFO - Installing pip.................done. 17:21:31 INFO - Return code: 0 17:21:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e27268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18967b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1925790>, '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 0x1926690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1926b20>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', '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 17:21:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:21:31 INFO - Using env: {'DISPLAY': ':0', 17:21:31 INFO - 'HOME': '/home/cltbld', 17:21:31 INFO - 'LANG': 'en_US.UTF-8', 17:21:31 INFO - 'LANGUAGE': 'en_US:en', 17:21:31 INFO - 'LOGNAME': 'cltbld', 17:21:31 INFO - 'MAIL': '/var/mail/cltbld', 17:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:31 INFO - 'MOZ_NO_REMOTE': '1', 17:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:31 INFO - 'NO_EM_RESTART': '1', 17:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:31 INFO - 'PWD': '/builds/slave/test', 17:21:31 INFO - 'SHELL': '/bin/bash', 17:21:31 INFO - 'SHLVL': '1', 17:21:31 INFO - 'TERM': 'linux', 17:21:31 INFO - 'TMOUT': '86400', 17:21:31 INFO - 'USER': 'cltbld', 17:21:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', 17:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:31 INFO - '_': '/tools/buildbot/bin/python'} 17:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:21:31 INFO - Cleaning up... 17:21:31 INFO - Return code: 0 17:21:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e27268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18967b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1925790>, '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 0x1926690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1926b20>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', '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 17:21:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:21:31 INFO - Using env: {'DISPLAY': ':0', 17:21:31 INFO - 'HOME': '/home/cltbld', 17:21:31 INFO - 'LANG': 'en_US.UTF-8', 17:21:31 INFO - 'LANGUAGE': 'en_US:en', 17:21:31 INFO - 'LOGNAME': 'cltbld', 17:21:31 INFO - 'MAIL': '/var/mail/cltbld', 17:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:31 INFO - 'MOZ_NO_REMOTE': '1', 17:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:31 INFO - 'NO_EM_RESTART': '1', 17:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:31 INFO - 'PWD': '/builds/slave/test', 17:21:31 INFO - 'SHELL': '/bin/bash', 17:21:31 INFO - 'SHLVL': '1', 17:21:31 INFO - 'TERM': 'linux', 17:21:31 INFO - 'TMOUT': '86400', 17:21:31 INFO - 'USER': 'cltbld', 17:21:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', 17:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:31 INFO - '_': '/tools/buildbot/bin/python'} 17:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:31 INFO - Downloading/unpacking psutil>=3.1.1 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:21:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:21:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:21:33 INFO - Installing collected packages: psutil 17:21:33 INFO - Running setup.py install for psutil 17:21:33 INFO - building 'psutil._psutil_linux' extension 17:21: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 17:21:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:21:34 INFO - building 'psutil._psutil_posix' extension 17:21:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:21:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:21:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:21:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:21:34 INFO - Successfully installed psutil 17:21:34 INFO - Cleaning up... 17:21:34 INFO - Return code: 0 17:21:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e27268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18967b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1925790>, '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 0x1926690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1926b20>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', '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 17:21:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:21:34 INFO - Using env: {'DISPLAY': ':0', 17:21:34 INFO - 'HOME': '/home/cltbld', 17:21:34 INFO - 'LANG': 'en_US.UTF-8', 17:21:34 INFO - 'LANGUAGE': 'en_US:en', 17:21:34 INFO - 'LOGNAME': 'cltbld', 17:21:34 INFO - 'MAIL': '/var/mail/cltbld', 17:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:34 INFO - 'MOZ_NO_REMOTE': '1', 17:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:34 INFO - 'NO_EM_RESTART': '1', 17:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:34 INFO - 'PWD': '/builds/slave/test', 17:21:34 INFO - 'SHELL': '/bin/bash', 17:21:34 INFO - 'SHLVL': '1', 17:21:34 INFO - 'TERM': 'linux', 17:21:34 INFO - 'TMOUT': '86400', 17:21:34 INFO - 'USER': 'cltbld', 17:21:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', 17:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:34 INFO - '_': '/tools/buildbot/bin/python'} 17:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:21:36 INFO - Installing collected packages: mozsystemmonitor 17:21:36 INFO - Running setup.py install for mozsystemmonitor 17:21:36 INFO - Successfully installed mozsystemmonitor 17:21:36 INFO - Cleaning up... 17:21:36 INFO - Return code: 0 17:21:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e27268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18967b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1925790>, '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 0x1926690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1926b20>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', '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 17:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:21:36 INFO - Using env: {'DISPLAY': ':0', 17:21:36 INFO - 'HOME': '/home/cltbld', 17:21:36 INFO - 'LANG': 'en_US.UTF-8', 17:21:36 INFO - 'LANGUAGE': 'en_US:en', 17:21:36 INFO - 'LOGNAME': 'cltbld', 17:21:36 INFO - 'MAIL': '/var/mail/cltbld', 17:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:36 INFO - 'MOZ_NO_REMOTE': '1', 17:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:36 INFO - 'NO_EM_RESTART': '1', 17:21:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:36 INFO - 'PWD': '/builds/slave/test', 17:21:36 INFO - 'SHELL': '/bin/bash', 17:21:36 INFO - 'SHLVL': '1', 17:21:36 INFO - 'TERM': 'linux', 17:21:36 INFO - 'TMOUT': '86400', 17:21:36 INFO - 'USER': 'cltbld', 17:21:36 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', 17:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:36 INFO - '_': '/tools/buildbot/bin/python'} 17:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:36 INFO - Downloading/unpacking jsonschema==2.5.1 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:21:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21:39 INFO - Downloading functools32-3.2.3-2.tar.gz 17:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:21:39 INFO - warning: no files found matching '*.txt' 17:21:39 INFO - no previously-included directories found matching 'build' 17:21:39 INFO - no previously-included directories found matching 'dist' 17:21:39 INFO - no previously-included directories found matching '.git*' 17:21:39 INFO - Installing collected packages: jsonschema, functools32 17:21:39 INFO - Running setup.py install for functools32 17:21:39 INFO - warning: no files found matching '*.txt' 17:21:39 INFO - no previously-included directories found matching 'build' 17:21:39 INFO - no previously-included directories found matching 'dist' 17:21:39 INFO - no previously-included directories found matching '.git*' 17:21:39 INFO - Successfully installed jsonschema functools32 17:21:39 INFO - Cleaning up... 17:21:39 INFO - Return code: 0 17:21:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e27268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18967b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1925790>, '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 0x1926690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1926b20>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', '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 17:21:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:21:39 INFO - Using env: {'DISPLAY': ':0', 17:21:39 INFO - 'HOME': '/home/cltbld', 17:21:39 INFO - 'LANG': 'en_US.UTF-8', 17:21:39 INFO - 'LANGUAGE': 'en_US:en', 17:21:39 INFO - 'LOGNAME': 'cltbld', 17:21:39 INFO - 'MAIL': '/var/mail/cltbld', 17:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:39 INFO - 'MOZ_NO_REMOTE': '1', 17:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:39 INFO - 'NO_EM_RESTART': '1', 17:21:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:39 INFO - 'PWD': '/builds/slave/test', 17:21:39 INFO - 'SHELL': '/bin/bash', 17:21:39 INFO - 'SHLVL': '1', 17:21:39 INFO - 'TERM': 'linux', 17:21:39 INFO - 'TMOUT': '86400', 17:21:39 INFO - 'USER': 'cltbld', 17:21:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', 17:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:39 INFO - '_': '/tools/buildbot/bin/python'} 17:21:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:21:39 INFO - Cleaning up... 17:21:39 INFO - Return code: 0 17:21:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e27268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18967b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1925790>, '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 0x1926690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1926b20>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', '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 17:21:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:21:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:21:39 INFO - Using env: {'DISPLAY': ':0', 17:21:39 INFO - 'HOME': '/home/cltbld', 17:21:39 INFO - 'LANG': 'en_US.UTF-8', 17:21:39 INFO - 'LANGUAGE': 'en_US:en', 17:21:39 INFO - 'LOGNAME': 'cltbld', 17:21:39 INFO - 'MAIL': '/var/mail/cltbld', 17:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:39 INFO - 'MOZ_NO_REMOTE': '1', 17:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:39 INFO - 'NO_EM_RESTART': '1', 17:21:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:39 INFO - 'PWD': '/builds/slave/test', 17:21:39 INFO - 'SHELL': '/bin/bash', 17:21:39 INFO - 'SHLVL': '1', 17:21:39 INFO - 'TERM': 'linux', 17:21:39 INFO - 'TMOUT': '86400', 17:21:39 INFO - 'USER': 'cltbld', 17:21:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', 17:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:39 INFO - '_': '/tools/buildbot/bin/python'} 17:21:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:39 INFO - Downloading/unpacking blobuploader==1.2.4 17:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:41 INFO - Downloading blobuploader-1.2.4.tar.gz 17:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:21:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21: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 17:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:21:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:42 INFO - Downloading docopt-0.6.1.tar.gz 17:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:21:42 INFO - Installing collected packages: blobuploader, requests, docopt 17:21:42 INFO - Running setup.py install for blobuploader 17:21:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:21:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:21:42 INFO - Running setup.py install for requests 17:21:42 INFO - Running setup.py install for docopt 17:21:42 INFO - Successfully installed blobuploader requests docopt 17:21:42 INFO - Cleaning up... 17:21:43 INFO - Return code: 0 17:21:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:21:43 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')]} 17:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:43 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')]} 17:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:43 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 0x7f0e27268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18967b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1925790>, '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 0x1926690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1926b20>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', '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 17:21:43 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 17:21:43 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 17:21:43 INFO - Using env: {'DISPLAY': ':0', 17:21:43 INFO - 'HOME': '/home/cltbld', 17:21:43 INFO - 'LANG': 'en_US.UTF-8', 17:21:43 INFO - 'LANGUAGE': 'en_US:en', 17:21:43 INFO - 'LOGNAME': 'cltbld', 17:21:43 INFO - 'MAIL': '/var/mail/cltbld', 17:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:43 INFO - 'MOZ_NO_REMOTE': '1', 17:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:43 INFO - 'NO_EM_RESTART': '1', 17:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:43 INFO - 'PWD': '/builds/slave/test', 17:21:43 INFO - 'SHELL': '/bin/bash', 17:21:43 INFO - 'SHLVL': '1', 17:21:43 INFO - 'TERM': 'linux', 17:21:43 INFO - 'TMOUT': '86400', 17:21:43 INFO - 'USER': 'cltbld', 17:21:43 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', 17:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:43 INFO - '_': '/tools/buildbot/bin/python'} 17:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:21:43 INFO - Running setup.py (path:/tmp/pip-3sWRJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:21:43 INFO - Running setup.py (path:/tmp/pip-LRdmb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:21:43 INFO - Running setup.py (path:/tmp/pip-JYwwKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:21:43 INFO - Running setup.py (path:/tmp/pip-lHm_cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:21:43 INFO - Running setup.py (path:/tmp/pip-0Y3qbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:21:43 INFO - Running setup.py (path:/tmp/pip-HKqeTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:21:43 INFO - Running setup.py (path:/tmp/pip-EzGZpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:21:43 INFO - Running setup.py (path:/tmp/pip-2Y3RgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:21:43 INFO - Running setup.py (path:/tmp/pip-HQgEfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:21:43 INFO - Running setup.py (path:/tmp/pip-Fp16iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:21:43 INFO - Running setup.py (path:/tmp/pip-ry3ye7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:21:44 INFO - Running setup.py (path:/tmp/pip-0oo76M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:21:44 INFO - Running setup.py (path:/tmp/pip-SRoL69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:21:44 INFO - Running setup.py (path:/tmp/pip-sjO0gJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:44 INFO - Running setup.py (path:/tmp/pip-W4LL8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:21:44 INFO - Running setup.py (path:/tmp/pip-F3A5jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:21:44 INFO - Running setup.py (path:/tmp/pip-EtnzgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:21:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:21:44 INFO - Running setup.py install for manifestparser 17:21:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:21:44 INFO - Running setup.py install for mozcrash 17:21:44 INFO - Running setup.py install for mozdebug 17:21:44 INFO - Running setup.py install for mozdevice 17:21:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:21:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:21:44 INFO - Running setup.py install for mozfile 17:21:45 INFO - Running setup.py install for mozhttpd 17:21:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:21:45 INFO - Running setup.py install for mozinfo 17:21:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:21:45 INFO - Running setup.py install for mozInstall 17:21:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:21:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:21:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:21:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:21:45 INFO - Running setup.py install for mozleak 17:21:45 INFO - Running setup.py install for mozlog 17:21:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:21:45 INFO - Running setup.py install for moznetwork 17:21:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:21:45 INFO - Running setup.py install for mozprocess 17:21:45 INFO - Running setup.py install for mozprofile 17:21:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:21:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:21:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:21:45 INFO - Running setup.py install for mozrunner 17:21:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:21:45 INFO - Running setup.py install for mozscreenshot 17:21:46 INFO - Running setup.py install for moztest 17:21:46 INFO - Running setup.py install for mozversion 17:21:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:21:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:21:46 INFO - Cleaning up... 17:21:46 INFO - Return code: 0 17:21:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e27268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18967b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1925790>, '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 0x1926690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1926b20>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', '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 17:21:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:21:46 INFO - Using env: {'DISPLAY': ':0', 17:21:46 INFO - 'HOME': '/home/cltbld', 17:21:46 INFO - 'LANG': 'en_US.UTF-8', 17:21:46 INFO - 'LANGUAGE': 'en_US:en', 17:21:46 INFO - 'LOGNAME': 'cltbld', 17:21:46 INFO - 'MAIL': '/var/mail/cltbld', 17:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:46 INFO - 'MOZ_NO_REMOTE': '1', 17:21:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:46 INFO - 'NO_EM_RESTART': '1', 17:21:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:46 INFO - 'PWD': '/builds/slave/test', 17:21:46 INFO - 'SHELL': '/bin/bash', 17:21:46 INFO - 'SHLVL': '1', 17:21:46 INFO - 'TERM': 'linux', 17:21:46 INFO - 'TMOUT': '86400', 17:21:46 INFO - 'USER': 'cltbld', 17:21:46 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', 17:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:46 INFO - '_': '/tools/buildbot/bin/python'} 17:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:21:46 INFO - Running setup.py (path:/tmp/pip-JvzsLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:21:46 INFO - Running setup.py (path:/tmp/pip-iAfVdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:21:46 INFO - Running setup.py (path:/tmp/pip-MkcOAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:21:46 INFO - Running setup.py (path:/tmp/pip-DhmbbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:21:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:21:46 INFO - Running setup.py (path:/tmp/pip-pOmaMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:21: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)) 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:21:46 INFO - Running setup.py (path:/tmp/pip-u4lHIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:21: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)) 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:21:46 INFO - Running setup.py (path:/tmp/pip-WKfiER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:21: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)) 17:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:21:46 INFO - Running setup.py (path:/tmp/pip-lcYmyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:21:47 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)) 17:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:21:47 INFO - Running setup.py (path:/tmp/pip-kpMjVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:21:47 INFO - Running setup.py (path:/tmp/pip-pqBnnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:21:47 INFO - Running setup.py (path:/tmp/pip-6uQaFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:21:47 INFO - Running setup.py (path:/tmp/pip-72iwkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:21:47 INFO - Running setup.py (path:/tmp/pip-OPfRNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:21:47 INFO - Running setup.py (path:/tmp/pip-D_YkOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:47 INFO - Running setup.py (path:/tmp/pip-OBPDGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:21:47 INFO - Running setup.py (path:/tmp/pip-ofNG56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:21:47 INFO - Running setup.py (path:/tmp/pip-ts05yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:21:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:21:49 INFO - Downloading blessings-1.6.tar.gz 17:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:21:49 INFO - Installing collected packages: blessings 17:21:49 INFO - Running setup.py install for blessings 17:21:49 INFO - Successfully installed blessings 17:21:49 INFO - Cleaning up... 17:21:49 INFO - Return code: 0 17:21:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:21:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:21:50 INFO - Reading from file tmpfile_stdout 17:21:50 INFO - Current package versions: 17:21:50 INFO - argparse == 1.2.1 17:21:50 INFO - blessings == 1.6 17:21:50 INFO - blobuploader == 1.2.4 17:21:50 INFO - docopt == 0.6.1 17:21:50 INFO - functools32 == 3.2.3-2 17:21:50 INFO - jsonschema == 2.5.1 17:21:50 INFO - manifestparser == 1.1 17:21:50 INFO - mozInstall == 1.12 17:21:50 INFO - mozcrash == 0.17 17:21:50 INFO - mozdebug == 0.1 17:21:50 INFO - mozdevice == 0.48 17:21:50 INFO - mozfile == 1.2 17:21:50 INFO - mozhttpd == 0.7 17:21:50 INFO - mozinfo == 0.9 17:21:50 INFO - mozleak == 0.1 17:21:50 INFO - mozlog == 3.4 17:21:50 INFO - moznetwork == 0.27 17:21:50 INFO - mozprocess == 0.23 17:21:50 INFO - mozprofile == 0.28 17:21:50 INFO - mozrunner == 6.12 17:21:50 INFO - mozscreenshot == 0.1 17:21:50 INFO - mozsystemmonitor == 0.3 17:21:50 INFO - moztest == 0.7 17:21:50 INFO - mozversion == 1.4 17:21:50 INFO - psutil == 3.1.1 17:21:50 INFO - requests == 1.2.3 17:21:50 INFO - wsgiref == 0.1.2 17:21:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:50 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 0x7f0e27268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18967b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1925790>, '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 0x1926690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1926b20>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', '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 17:21:50 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 17:21:50 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 17:21:50 INFO - Using env: {'DISPLAY': ':0', 17:21:50 INFO - 'HOME': '/home/cltbld', 17:21:50 INFO - 'LANG': 'en_US.UTF-8', 17:21:50 INFO - 'LANGUAGE': 'en_US:en', 17:21:50 INFO - 'LOGNAME': 'cltbld', 17:21:50 INFO - 'MAIL': '/var/mail/cltbld', 17:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:50 INFO - 'MOZ_NO_REMOTE': '1', 17:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:50 INFO - 'NO_EM_RESTART': '1', 17:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:50 INFO - 'PWD': '/builds/slave/test', 17:21:50 INFO - 'SHELL': '/bin/bash', 17:21:50 INFO - 'SHLVL': '1', 17:21:50 INFO - 'TERM': 'linux', 17:21:50 INFO - 'TMOUT': '86400', 17:21:50 INFO - 'USER': 'cltbld', 17:21:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', 17:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:50 INFO - '_': '/tools/buildbot/bin/python'} 17:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:21:50 INFO - Cleaning up... 17:21:50 INFO - Return code: 0 17:21:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:21:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e27268f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18967b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1925790>, '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 0x1926690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1926b20>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', '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 17:21:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:21:50 INFO - Using env: {'DISPLAY': ':0', 17:21:50 INFO - 'HOME': '/home/cltbld', 17:21:50 INFO - 'LANG': 'en_US.UTF-8', 17:21:50 INFO - 'LANGUAGE': 'en_US:en', 17:21:50 INFO - 'LOGNAME': 'cltbld', 17:21:50 INFO - 'MAIL': '/var/mail/cltbld', 17:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:21:50 INFO - 'MOZ_NO_REMOTE': '1', 17:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:21:50 INFO - 'NO_EM_RESTART': '1', 17:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:21:50 INFO - 'PWD': '/builds/slave/test', 17:21:50 INFO - 'SHELL': '/bin/bash', 17:21:50 INFO - 'SHLVL': '1', 17:21:50 INFO - 'TERM': 'linux', 17:21:50 INFO - 'TMOUT': '86400', 17:21:50 INFO - 'USER': 'cltbld', 17:21:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', 17:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:21:50 INFO - '_': '/tools/buildbot/bin/python'} 17:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:21:50 INFO - Cleaning up... 17:21:50 INFO - Return code: 0 17:21:50 INFO - Running post-action listener: _resource_record_post_action 17:21:50 INFO - Running post-action listener: _start_resource_monitoring 17:21:50 INFO - Starting resource monitoring. 17:21:50 INFO - [mozharness: 2016-09-24 00:21:50.592616Z] Finished create-virtualenv step (success) 17:21:50 INFO - [mozharness: 2016-09-24 00:21:50.593080Z] Running install step. 17:21:50 INFO - Running pre-action listener: _resource_record_pre_action 17:21:50 INFO - Running main action method: install 17:21:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:21:50 INFO - Reading from file tmpfile_stdout 17:21:50 INFO - Detecting whether we're running mozinstall >=1.0... 17:21:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:21:50 INFO - Reading from file tmpfile_stdout 17:21:50 INFO - Output received: 17:21:50 INFO - Usage: mozinstall [options] installer 17:21:50 INFO - Options: 17:21:50 INFO - -h, --help show this help message and exit 17:21:50 INFO - -d DEST, --destination=DEST 17:21:50 INFO - Directory to install application into. [default: 17:21:50 INFO - "/builds/slave/test"] 17:21:50 INFO - --app=APP Application being installed. [default: firefox] 17:21:50 INFO - mkdir: /builds/slave/test/build/application 17:21:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:22:07 INFO - Reading from file tmpfile_stdout 17:22:07 INFO - Output received: 17:22:07 INFO - /builds/slave/test/build/application/firefox/firefox 17:22:07 INFO - Running post-action listener: _resource_record_post_action 17:22:07 INFO - [mozharness: 2016-09-24 00:22:07.897697Z] Finished install step (success) 17:22:07 INFO - [mozharness: 2016-09-24 00:22:07.897942Z] Running run-tests step. 17:22:07 INFO - Running pre-action listener: _resource_record_pre_action 17:22:07 INFO - Running main action method: run_tests 17:22:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:22:07 INFO - Python 2.7.3 17:22:07 INFO - Return code: 0 17:22:07 INFO - grabbing minidump binary from tooltool 17:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:22:07 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 0x1925790>, '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 0x1926690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1926b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:22:07 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 17:22:07 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 17:22:07 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 17:22:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:22:07 INFO - Return code: 0 17:22:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:22:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:22:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:22:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:22:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:22:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:22:07 INFO - Using env: {'DISPLAY': ':0', 17:22:07 INFO - 'HOME': '/home/cltbld', 17:22:07 INFO - 'LANG': 'en_US.UTF-8', 17:22:07 INFO - 'LANGUAGE': 'en_US:en', 17:22:07 INFO - 'LOGNAME': 'cltbld', 17:22:07 INFO - 'MAIL': '/var/mail/cltbld', 17:22:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:22:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:22:07 INFO - 'MOZ_NO_REMOTE': '1', 17:22:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:22:07 INFO - 'NO_EM_RESTART': '1', 17:22:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:22:07 INFO - 'PWD': '/builds/slave/test', 17:22:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:22:07 INFO - 'SHELL': '/bin/bash', 17:22:07 INFO - 'SHLVL': '1', 17:22:07 INFO - 'TERM': 'linux', 17:22:07 INFO - 'TMOUT': '86400', 17:22:07 INFO - 'USER': 'cltbld', 17:22:07 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977', 17:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:22:07 INFO - '_': '/tools/buildbot/bin/python'} 17:22:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:22:08 INFO - mozversion application_buildid: 20160923153005 17:22:08 INFO - mozversion application_changeset: 92d96352192c049c6c3c66e61f3d3c8f4545aaab 17:22:08 INFO - mozversion application_display_name: Nightly 17:22:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:22:08 INFO - mozversion application_name: Firefox 17:22:08 INFO - mozversion application_remotingname: firefox 17:22:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:22:08 INFO - mozversion application_vendor: Mozilla 17:22:08 INFO - mozversion application_version: 52.0a1 17:22:08 INFO - mozversion platform_buildid: 20160923153005 17:22:08 INFO - mozversion platform_changeset: 92d96352192c049c6c3c66e61f3d3c8f4545aaab 17:22:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:22:08 INFO - mozversion platform_version: 52.0a1 17:22:08 INFO - using testdate: 1474676528 17:22:08 INFO - actual date: 1474676528 17:22:08 INFO - starting webserver on 'localhost:36453' 17:22:08 INFO - SUITE-START | Running 2 tests 17:22:08 INFO - TEST-START | dromaeo_css 17:22:08 INFO - operating with platform_type : linux_ 17:22:08 INFO - Initialising browser for dromaeo_css test... 17:22:08 INFO - TEST-INFO | started process 5632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt1Qchq/profile http://localhost:36453/getInfo.html) 17:22:12 INFO - PROCESS | 5632 | __metrics Screen width/height:1600/1200 17:22:12 INFO - PROCESS | 5632 | colorDepth:24 17:22:12 INFO - PROCESS | 5632 | Browser inner width/height: 1024/697 17:22:12 INFO - PROCESS | 5632 | __metrics 17:22:13 ERROR - PROCESS | 5632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 17:22:13 INFO - TEST-INFO | 5632: exit 0 17:22:13 INFO - Browser initialized. 17:22:13 INFO - Running cycle 1/1 for dromaeo_css test... 17:22:13 INFO - TEST-INFO | started process 5753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt1Qchq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:22:26 INFO - PROCESS | 5753 | RSS: Main: 184909824 17:22:26 INFO - PROCESS | 5753 | 17:23:15 INFO - PROCESS | 5753 | 1474676595702 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] 17:25:25 INFO - PROCESS | 5753 | Cycle 1(1): loaded http://localhost:36453/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36453/tests/dromaeo/cssquery-ext.html) 17:25:26 INFO - PROCESS | 5753 | RSS: Main: 199655424 17:25:26 INFO - PROCESS | 5753 | 17:28:28 INFO - PROCESS | 5753 | Cycle 1(1): loaded http://localhost:36453/tests/dromaeo/cssquery-ext.html (next: http://localhost:36453/tests/dromaeo/cssquery-jquery.html) 17:28:29 INFO - PROCESS | 5753 | RSS: Main: 196726784 17:28:29 INFO - PROCESS | 5753 | 17:31:31 INFO - PROCESS | 5753 | Cycle 1(1): loaded http://localhost:36453/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36453/tests/dromaeo/cssquery-mootools.html) 17:31:31 INFO - PROCESS | 5753 | RSS: Main: 198348800 17:31:31 INFO - PROCESS | 5753 | 17:34:33 INFO - PROCESS | 5753 | Cycle 1(1): loaded http://localhost:36453/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36453/tests/dromaeo/cssquery-prototype.html) 17:34:34 INFO - PROCESS | 5753 | RSS: Main: 195059712 17:34:34 INFO - PROCESS | 5753 | 17:37:36 INFO - PROCESS | 5753 | Cycle 1(1): loaded http://localhost:36453/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36453/tests/dromaeo/cssquery-yui.html) 17:37:37 INFO - PROCESS | 5753 | RSS: Main: 198852608 17:37:37 INFO - PROCESS | 5753 | 17:40:39 INFO - PROCESS | 5753 | Cycle 1(1): loaded http://localhost:36453/tests/dromaeo/cssquery-yui.html (next: http://localhost:36453/tests/dromaeo/cssquery-dojo.html) 17:40:39 INFO - PROCESS | 5753 | RSS: Main: 199323648 17:40:39 INFO - PROCESS | 5753 | 17:40:39 INFO - PROCESS | 5753 | __start_tp_report 17:40:39 INFO - PROCESS | 5753 | _x_x_mozilla_page_load 17:40:39 INFO - PROCESS | 5753 | _x_x_mozilla_page_load_details 17:40:39 INFO - PROCESS | 5753 | |i|pagename|runs| 17:40:39 INFO - PROCESS | 5753 | |0;dojo.html;3022.471067563176;3024.576559281701;3050.23744063984;3057.0217530390278;3061.127578640088;5205.843824685261;5225.790968361261;5249.05517006939;5327.387350454699;5335;5273.446288139748;5295.443978382272;5326.7070311132875;5379.246905433242;5390.380106287778;4838.63710221733;4860.8055677772845;4884.951150488503;4906.386701662293;4959.032988567231;4867.610591152699;4894.3147959285725;4919.286703428019;4926.778294976734;4978.950210497903;4752.904941901177;4781.115493633654;4887.706737595738;4896.730679812609;4945.431275403339;4810.735409552473;4841.225403935388;4868.367112275417;4946.208606622923;4946.431160416562;4822.083804077214;4831.202851529493;4837.927431088537;4852.878678033077;4864.343313652647;5283.1546952487415;5328.92006619901;5332.946670533283;5333.120035194227;5345.3852806926925;5531.889362212733;5613.971930140323;5633.183188437653;5688;5716.428357164292;5598.748056337475;5600.579956503238;5602.579806514487;5603.159526071081;5619.522340601054;5243.4232234454175;5279.894402111975;5286.264938312005;5288.603354748371;5373.623846330719;5718.399568045378;5737.741801618937;5769.68266745333;5772.480476757112;5787.276590426197;5512.6692398456225;5547.306586676666;5553.222548843165;5560.499555040065;5570.777168913279;5557.44425557441;5565.749541270652;5637.859053523613;5638.069718496484;5642.746076426489;5481.890362192734;5493.2034854946605;5494.203340515603;5501.477359650827;5556.16657501378;5520.806771763049;5525.889482210414;5526;5526.861828454241;5534.059209934321;4296.037481140306;4309.41822853917;4311.051568654891;4328.48058233014;4357.041450880801;3881.1073453105378;3893.8637147699696;3941.9014524637114;3975.8210880510446;4025.4766880305374;5468.37113731918;5490.121580547173;5504.972475137599;5507.284053073075;5517.69652669107;5746.597738158289;5761.135829625506;5764.913526297109;5765.04876695349;5830.941690583039;5221.738913054332;5226.738663066832;5283.418823929364;5341.4925582069645;5368.248445217672;4881.072596206709;4896.706197628154;4907.509249075064;4954.702717836942;4967.031428871408;5789.131630255495;5844.736986835687;5846.912296315559;5853.502452291517;5869.090291004815;5549.972250138885;5608.457674139644;5657.405972373006;5678.230291543075;5754.798582049608;5831.533477321889;5836.503897168788;5899;5900.793472228452;5912;5613.775448981995;5613.859653508695;5614.915776263278;5625.774969001194;5629.831105066854;5614.438556144353;5658.519025882846;5707.143928410605;5738.971305143447;5747.281589801275;5603.915941260802;5606.467385598362;5616.129499927518;5654;5681.034224181816;5586.86032849182;5587.0502014656795;5598.440155984369;5602.13166959122;5609.270794796814;5381;5421.105517589711;5445.292112025411;5526.281583394133;5546.140348246028;5624;5631.183478395692;5640.294963129609;5640.605157638925;5686;5464.972675136599;5468.945310546844;5470.863228419162;5486.807961721321;5490.423505531861 17:40:39 INFO - PROCESS | 5753 | |1;ext.html;541.3115833363811;578.6412424296935;583.2621733507115;593.5192494079793;594.4827999640313;42171.78914105429;43320.13359732807;43582;47071;47128.29307560389;44378.77810610951;44389.112217755624;44734.552654473446;44776.55223447773;44847.77576112115;8860.246879015276;9062.728118156467;9074.63701451941;9080.228180604656;9083.863742043875;8866.157715017096;8889.777755556099;8908.109189081104;8921.910780892205;8956.910430895705;8941.59762810675;8942.239909607692;8991.235744961654;8995.730128096167;9009.369344145913;8942.73171804847;9003.59483823223;9010.549472526347;9017.098290170996;9027.458352498837;8905;8912.643494260286;8979.955100224523;8995.460272383612;9016.909830901672;41477.792611036755;41641;41828;42012;42126;3164.6360668523184;3661.286049220403;3852.653261206477;4124;4125.855595054159;31051.534226986612;31384.37231255362;31480.527792083136;31610;31810.681893181005;4309.5905888940815;4428.512863585003;4474.955250447519;4631.374764406795;4654.650901182425;339404;339938;340221.0701555283;341901;342930;34628.65371346305;35738;35868;58805.41194588085;59083.40916590779;38164.8091759545;38318;38346.233075338336;38413.423798643045;38516.229675406335;14171.362288697033;14194.006419550533;14232.28838558068;14252.429902803979;14300.570982870531;12154.635360939186;12333.629991100102;12336.444859981322;12362.258264504158;12365.77416065117;8629.13708629132;8637.827243455096;8647.178518040777;8772.38593298463;8791.07693692153;3372.15696075981;3430.091025878144;3435.6465820912254;3443.1908501502126;3465.2722928185362;963.0658261486348;966.8694726212012;978.0073225675944;1024.416082832778;1045.4772613693153;31568.526472102938;31612;31943.20141996422;32374.19064523406;32645;973.4062222044547;1059.6662051453768;1110.3227031510771;1110.7556337605713;1170.8536432945882;16211.432599859185;16294.918525407535;16379;16507.596854267522;16910.15449227534;543175;544945;547204;548524;550197;56714.7164264176;56810.046593476945;57718.134227986615;57811;57902.42097579055;1262.236347010064;1280.7246442015012;1285.4922305689201;1298.3508245877063;1299.3957809618573;29714.405711886073;29924;29989.850050749606;30593.365799137297;30619.693803061684;49197;49279.26081108858;49522;49525.75237123791;49550.25674614956;336224;338229;424144;425033.24634289584;426154;28164.71835281621;28608.85695571592;28667.56998645064;29038.854805725838;29039.85480072586;46855;47058.76470617625;47099.52900471089;47432;47636.5236347646;39405.408918865665;39956.93372079651;40342.19315613613;41475.37786933259;42202.788986054875;38082.42876356912;40330.395044073775;40342.59657403506;41206.587934120274;42250;40730.1853962925;40773.592264078165;40785.79607102064;40832.38751418672;40992.385114222714;35547.64452355547;37881.81059094687;38007.429888552244;38019.42970855495;38395.23209535738;28405.43189136247;28597.571036434885;28615.570766438937;28750;29022.709772902846 17:40:39 INFO - PROCESS | 5753 | |2;jquery.html;386.8549294014744;392.2703770985967;394.3670408993564;394.7079161420548;419.2830260254964;14459.710805783878;18087.18607662655;18749.156287967042;19828.702569461453;19903.900480497596;18339.17473713683;18345.54136146597;19004.334848280312;19252.22991080355;19565.608687826236;5606.187102870082;5607.158926161078;5721.570882183832;5750.7412166452405;5755.194272801811;5433.918491222615;5599.188117722948;5754.568407369443;5760.884782304352;5769.336526299488;5707.058335374658;5799.304083509985;5812.389699081599;5857.150713146591;5880.147378630096;5748.338941021794;5790.855228619276;5799.739011744482;5809.2738407699035;5852.092925596539;5621.409751976065;5656.8020119295625;5664.376918538957;5679.630823996468;5679.687617181054;13104.934475327658;13703.657408564766;13788.724225515534;13927.651808704763;14337.35481903317;2014.7783743788173;2029.8477614178996;2087.3946555498887;2694.932626684329;2705.9052933147245;9434.764130896714;9929.3545919515;10208.285420020602;10254.641087561975;10624.575016999312;1812.4472036029006;1848.4454663600866;1858.7769467663966;1887.37716553537;1963.3030274252578;79340.60329698373;81385.18614813835;82364.58817705873;82658.58670706669;85627;10868.67393978182;10952.4523773811;10974.378455109794;11092.667219983414;11196;13781;15399.769003464957;15401.614959625875;15423.768643470357;15438.073715576877;7397.556146631219;7417.258274172647;7645.923540764521;7781.105172905075;7792.532448053135;6908.745134163397;7105.96447017772;7224.349808517153;7436.1820199777985;7444.441666875006;4286.5070516890955;4676.843130886706;4735.479097299294;4786.497417771154;4817.975910120497;1888.830005299502;1921.7604645003894;1934.5453818352676;1945.192745010833;1973.8716983396034;813.495632707725;898.3172788680519;905.5110240470204;919.9586018629178;1050.8318669012922;17663.38178163758;18112.36606718785;18442.446726598224;18449.631007379776;18513.889166649773;914.7895983923602;931.9347645664739;946.6497395963538;960.7790208252142;1035.5857656937135;9971.252156088321;10344.741381465523;10524.842127368096;10571.418571978462;10577.576896924036;433494;438361;441326;448203;451177;88369;88460;89721.55139224262;91058.54470727737;92160;992.6624947517879;996.1471662707359;996.3211987800579;999.8701467342003;1001.4191768774093;15922.840771592137;16366.836331637007;16419.26113324927;17460.91269543644;17530.211140498453;39265.80367098146;42827;43082.78458607687;43934;44493.33260001038;52973.20540191823;52990.205146923596;54309.45690543044;59592.404075958686;61106.38893611007;7678.616069196406;7715.498492597963;7863.095743989515;7866.252705992922;7884.487508311941;9649.276304277068;10743.87980072951;11354.091672666333;11447;11874.881251187378;9864.506774661095;10309.432981186106;10347.172226222036;10418.166546676399;10640.201984851323;9917.702468925943;9918.40489570628;10007.149392301735;10016.849747253942;10182.592696292362;10035.849462257926;10101.545430455793;10197.643082492077;10210.132138768287;10225.642102526375;7705.922940770744;7825.334846538108;7914.802129946567;8074.717384891501;8134.67461301565;7729.768106956801;9906.603735850773;10278.897211027794;10286.588536458457;10621 17:40:39 INFO - PROCESS | 5753 | |3;mootools.html;1464.7363474574577;1480.5632338460152;1614.2251719174797;1698.1763844535405;1722.3110755697728;7823.608819559027;8114.269715725598;8248.54632995185;8992.100789921005;9004.774880627987;7938.841223175533;8350.582470876463;8354.164583541642;8360.790980225498;8628.09405012474;2172;2232.5311684546264;2235.117128734149;2243.876586787726;2244.304265677637;2259.152817693365;2282.8402011859175;2316.5714342846545;2319.9560197910923;2329.755375685554;2232.8325375596814;2263.7509873913855;2268.8638681679067;2284.680144779724;2292.1748170658548;2178.0307763045453;2182.181681869291;2191.024993877725;2194.2868567715554;2196.417949243452;2204.691343211952;2216.2797090945505;2217.645176771725;2218.267971569378;2231.843770936035;8494.575271236476;8649.827003459895;8699.826003479959;8752.21230089295;8763.386562940597;4808.711477311373;4921.704697718148;4932.457429682732;4936.333594964705;4945.208766597363;3214.582104326446;3284.950725739116;3394.422948098804;3401.370746411897;3404.3531728971666;1111.8182903059019;1140.3044143072718;1155.659080571225;1159.3739380734394;1173.8591369035685;11393.601223957121;11448.255863368855;11544.942275288653;11634.650960471115;11646.94176529112;4320.935185972213;4396.802143903532;4449.9777501112285;4604.40142781443;4606.907861842745;9941.602335906628;9944.35361701487;9952.452615106238;9969.651062212788;9972.850407243897;4939.407271127488;4964;4972.676776009548;4973.90052198954;4976.850694479172;4198.4961804583645;4218.873433796991;4476.597106260452;4555.453345598549;4558.9772051139535;3952.8616498422994;3975.224831157954;3995.2808494471274;4022.557518672944;4083.4079058536345;1293.2434525802323;1316.1576590981779;1327.74772793169;1328.4287756264898;1331.7735984882593;883.7481317824389;970.5972021611094;979.9853002204973;987.2250283527396;987.5802783816993;5731.942680573141;5899.292084949748;5901.76392944286;5917.142014407887;6027.221969519002;445.5277405949704;446.91955448019667;447.68885624491315;450.93461448089846;462.5767422808093;4112.732672376286;4124.1133156370925;4126.587341265849;4132.958670413317;4166.749995000249;10429.478526073817;10633.096186824052;10726;10738.946305268424;10757.515911783988;10622.097121744584;10638.308509946828;10656.467176641137;10661;10675.252732308663;7543.698252069966;7991.560464174526;7998.64006119726;8023.879641805378;8080.4343695940715;5921.6743079131065;5952.672603006876;5981.3719559445635;6007.639541627342;6117.602355847033;9461.479618620766;9514.143727064597;9786.951065244628;9865.556049977624;9873.802523949624;10062.39625622465;10074.597016119273;10115.140213081677;10134.493275336352;10135.49322533885;6799.762008329685;6902.206246281541;7157.606331651809;7186.964065179641;7287.380572651384;8574.657013719381;8625.525596092275;8648.481091134552;8661.263792577702;8662.177093176138;7103.538270012433;7240.637968101679;7318.451116166202;7332.486725929134;7374.631268436449;7039.824004399726;7131.928680713127;7245.094363204599;7305.196428392979;7319.487635865438;6737;6756.662166891538;6766.323367663194;6816.693248803915;6817.693203805741;4922.507749225192;5099.821506247264;5103.668261562986;5109.3613298337705;5133.8716532087;4989.875253118701;5064.620153488429;5153.3558305211845;5159.767810448464;5223.817166399158 17:40:39 INFO - PROCESS | 5753 | |4;prototype.html;310.52799744388517;314.6790273920602;315.2701496036675;327.30121191256666;333.77303433665105;5341.664583854036;5439.374471935724;5467.425920278373;5467.535259502937;5473.343198816143;5338.786448542053;5390.407055223922;5390.595705322097;5417.756200970956;5428.212909128184;4050.9189816203734;4094.6724262058965;4150.398192262121;4207.43199668044;4220.704550681454;4170.416141740159;4185.874423767292;4209.884380639133;4220.016592201676;4236.491621005468;4162.43807086044;4171.332586786115;4182.937255941163;4189.895252618694;4225.978870105645;4015.31739604268;4168.187203495319;4196.636093269669;4218.810153543067;4249.596288352617;3658.3597870372846;3661.3958696814993;3671.3942199537046;3672.981635091834;3676.74262801604;5203.219517072432;5225.817096401645;5235.240890070919;5260.947390526084;5266.815661451869;4679.9938013326955;4779.880502987453;4781.784819683088;4802.639802014828;4802.903941921177;5605.831825045255;5612.887742245173;5620.634658747168;5627.493525582676;5634.295713035871;4061.8578349757618;4074.1647962167685;4075.8369665213654;4078.3270760324513;4084.223997440477;5639.182318563826;5786.421357864222;5798.681072541009;5832.358440571534;5866.266716660418;4124.772622783663;4132.793360331972;4141.674664107457;4143.585641435832;4155.522114956819;4178.35235538492;4218.6625069994325;4225.978870105691;4250.617444430016;4257.6168144867115;4602.4477062752685;4806.639502037291;4809.687370320918;4811.49479304668;4839.57232616379;5679.517241034476;5701.800436984769;5705.74324155414;5712.542996560265;5726.914096288559;1471.8454562270808;1477.8669919707063;1480.1193289992436;1487.620656732548;1493.828209755892;909.3816204980544;939.8167357365385;960.2126256469768;972.3290929258931;979.6081567372966;5379.865503362447;5458.208559758813;5471.863203419866;5477.110396913059;5504.972475137599;5821.476067153976;5836.445537673914;5837.489879351834;5837.824865254049;5884.529237660977;5253.609607628597;5409.594280428983;5500.779968801283;5523.309586301712;5545.417731138253;3101.4882544380375;3109.7201251886986;3117.986654337304;3135.263213144909;3146.57521234635;5904.5571582131515;6044.637321760709;6045.78839740607;6052.303985041688;6057.092016014941;5868.735906884201;5887.617304875255;5903.616264942765;5908.316129902957;5949.791757288474;5991.880162396727;6030.155778191057;6034.24571928509;6041.879162416727;6070.939290607126;5712.914546236202;5713.885722285614;5749.367569567428;5756.395578464201;5897.085951677497;5707.8858422832145;5715.171300161536;5743.195952566561;5743.396943321059;5766.365699773106;5812.244408227072;5998.640081595118;6054.878902421839;6055.455009049207;6059.3637668045985;4201.663866890703;4234.386014027887;4244.214820258262;4244.427002354642;4269.637080848162;6013.9699301503215;6048.274207095001;6056.3035250946705;6058.939410605837;6070.210872586712;5667.319921609434;5742.741576628978;5757.539396848326;5874.148248503858;5912.231409916683;5743.540516758733;5744.167095771007;5746.023176059996;5790.812883358817;5796.927628356978;5766.3368712598585;5779.792215320369;5785.739641716217;5806.187133801187;5833.82498525045;5302.549283310807;5769.278840144982;5771.653700777967;5783.334916484489;5816.447437493432;5655.462731040545;5666.32004159487;5668.157848699272;5675.858103547444;5712.542996560348 17:40:39 INFO - PROCESS | 5753 | |5;yui.html;721.9422446204303;727.3126895084148;791.5962858941938;842.6587232170971;852.8720691896218;15031.17328546931;15654;15711.21443927802;15761.527154185378;15822.525324240276;13396.196228226288;13478.932605336984;13484.797728034062;13492.392842322095;13520.729585408286;647.6761619190405;670.3028849996023;757.4319260554585;760.0765070439415;783.4241832253289;789.0649580247425;789.8459800338936;790.2453157234855;792.6750032486682;792.7899106736719;824.9092599814015;828.6478246745139;828.6850996621275;828.9958550207241;829.531314807135;823.279630323467;827.0984626756834;828.8383765165765;831.4720152703017;831.575896292895;607.4957785038451;608.8356143841182;609.0954931926086;609.4088733928082;609.7926704920349;14036.719265614733;14215.431382744679;14229.857701422958;14240.715185696228;14298.785518217235;12494.250344979331;12639.43122559487;13201.471941122343;13305.20168789866;13595.932020339835;10550.31422957513;10718.73203169927;10719.83920241197;10757.246992710514;10769.407682577455;3374.5444365010653;3385.6783605557434;3420.96579034209;3421.1105112670884;3427.1946092668204;76967;77361.61319193424;78051.6097419515;79228.20771792266;79731.22956474783;9018.684346047858;9077.591508382138;9414.105659962293;9461.19579835708;9534.09426104519;18485.907570462332;23138.652920206212;23144.76855231426;23455.296341109795;23500.412489687893;7009.964950175318;7095.0421693070775;7222.205557388683;7429.7771066867;7523.435742319348;4126.360414135754;4151.7924103794685;4182.038131229773;4223.1553689261655;4261.232978063917;3438.570178727659;3547.379208638478;3574.356615809127;3585.3008663310925;3614.6566076222716;594.9196858424058;595.943385378397;602.3645054467491;602.9547783916224;608.3126067543736;586.6626689653381;663.9136912201479;693.3205458650551;730.9195988441268;752.7102065704634;8560.871586926201;8912.8663070054;8989.370744047854;9029.367944243972;9147;606.6299557270062;645.5029627187133;714.9571025738472;725.7314793526429;751.6091632351147;4281.807318670605;4426.889327766768;4431.224535706238;4634.165850146938;4713.410823647044;115542;115769;120395;121540;123101;90810.54594727117;94895;96066.51966740121;97678;98394;73577.89633155506;79756;81255;86700.5664971671;86774.56612716896;9680.370775899544;9683.271940302893;9882.962288959556;9917.65288214909;9920.454375009154;36653.08367290839;37720.81139594394;45993.54006459893;49246.50753492562;49889;67999.66000169968;72540;74264;76247;76797;12509.749805003667;12768.425420855898;13084.345782710636;13101.082924195214;13145;14241.715165696834;14481.710365792414;14557.563273101823;14896.255187240811;15323.77014344808;13073.934630327169;13349.866501335251;13448.93275533616;13500;13512.93243533776;12975.286359250333;13232.206067635972;13471.326433678081;13698.219231499841;13914.51299204523;11961.162718609614;12193.51225950952;12313.199642023239;12667;12929.870701293243;11302.321860688386;11602.593909213138;11982.880171198176;12107.394630268274;12127.151099422956;11515.712107197052;11779.823302650295;11837.053035757292;11860.644180674593;11965.581204657796 17:40:39 INFO - PROCESS | 5753 | __end_tp_report 17:40:39 INFO - PROCESS | 5753 | __start_cc_report 17:40:39 INFO - PROCESS | 5753 | _x_x_mozilla_cycle_collect,286 17:40:39 INFO - PROCESS | 5753 | __end_cc_report 17:40:39 INFO - PROCESS | 5753 | __startTimestamp1474677639900__endTimestamp 17:40:39 INFO - PROCESS | 5753 | 17:40:39 INFO - PROCESS | 5753 | ------- Summary: start ------- 17:40:39 INFO - PROCESS | 5753 | Number of tests: 6 17:40:39 INFO - PROCESS | 5753 | 17:40:39 INFO - PROCESS | 5753 | [#0] dojo.html Cycles:165 Average:5274.99 Median:5494.20 stddev:586.31 (10.7%) stddev-sans-first:560.85 17:40:39 INFO - PROCESS | 5753 | Values: 3022.5 3024.6 3050.2 3057.0 3061.1 5205.8 5225.8 5249.1 5327.4 5335.0 5273.4 5295.4 5326.7 5379.2 5390.4 4838.6 4860.8 4885.0 4906.4 4959.0 4867.6 4894.3 4919.3 4926.8 4979.0 4752.9 4781.1 4887.7 4896.7 4945.4 4810.7 4841.2 4868.4 4946.2 4946.4 4822.1 4831.2 4837.9 4852.9 4864.3 5283.2 5328.9 5332.9 5333.1 5345.4 5531.9 5614.0 5633.2 5688.0 5716.4 5598.7 5600.6 5602.6 5603.2 5619.5 5243.4 5279.9 5286.3 5288.6 5373.6 5718.4 5737.7 5769.7 5772.5 5787.3 5512.7 5547.3 5553.2 5560.5 5570.8 5557.4 5565.7 5637.9 5638.1 5642.7 5481.9 5493.2 5494.2 5501.5 5556.2 5520.8 5525.9 5526.0 5526.9 5534.1 4296.0 4309.4 4311.1 4328.5 4357.0 3881.1 3893.9 3941.9 3975.8 4025.5 5468.4 5490.1 5505.0 5507.3 5517.7 5746.6 5761.1 5764.9 5765.0 5830.9 5221.7 5226.7 5283.4 5341.5 5368.2 4881.1 4896.7 4907.5 4954.7 4967.0 5789.1 5844.7 5846.9 5853.5 5869.1 5550.0 5608.5 5657.4 5678.2 5754.8 5831.5 5836.5 5899.0 5900.8 5912.0 5613.8 5613.9 5614.9 5625.8 5629.8 5614.4 5658.5 5707.1 5739.0 5747.3 5603.9 5606.5 5616.1 5654.0 5681.0 5586.9 5587.1 5598.4 5602.1 5609.3 5381.0 5421.1 5445.3 5526.3 5546.1 5624.0 5631.2 5640.3 5640.6 5686.0 5465.0 5468.9 5470.9 5486.8 5490.4 17:40:39 INFO - PROCESS | 5753 | 17:40:39 INFO - PROCESS | 5753 | [#1] ext.html Cycles:180 Average:57464.83 Median:22665.29 stddev:115751.64 (510.7%) stddev-sans-first:115997.45 17:40:39 INFO - PROCESS | 5753 | Values: 541.3 578.6 583.3 593.5 594.5 42171.8 43320.1 43582.0 47071.0 47128.3 44378.8 44389.1 44734.6 44776.6 44847.8 8860.2 9062.7 9074.6 9080.2 9083.9 8866.2 8889.8 8908.1 8921.9 8956.9 8941.6 8942.2 8991.2 8995.7 9009.4 8942.7 9003.6 9010.5 9017.1 9027.5 8905.0 8912.6 8980.0 8995.5 9016.9 41477.8 41641.0 41828.0 42012.0 42126.0 3164.6 3661.3 3852.7 4124.0 4125.9 31051.5 31384.4 31480.5 31610.0 31810.7 4309.6 4428.5 4475.0 4631.4 4654.7 339404.0 339938.0 340221.1 341901.0 342930.0 34628.7 35738.0 35868.0 58805.4 59083.4 38164.8 38318.0 38346.2 38413.4 38516.2 14171.4 14194.0 14232.3 14252.4 14300.6 12154.6 12333.6 12336.4 12362.3 12365.8 8629.1 8637.8 8647.2 8772.4 8791.1 3372.2 3430.1 3435.6 3443.2 3465.3 963.1 966.9 978.0 1024.4 1045.5 31568.5 31612.0 31943.2 32374.2 32645.0 973.4 1059.7 1110.3 1110.8 1170.9 16211.4 16294.9 16379.0 16507.6 16910.2 543175.0 544945.0 547204.0 548524.0 550197.0 56714.7 56810.0 57718.1 57811.0 57902.4 1262.2 1280.7 1285.5 1298.4 1299.4 29714.4 29924.0 29989.9 30593.4 30619.7 49197.0 49279.3 49522.0 49525.8 49550.3 336224.0 338229.0 424144.0 425033.2 426154.0 28164.7 28608.9 28667.6 29038.9 29039.9 46855.0 47058.8 47099.5 47432.0 47636.5 39405.4 39956.9 40342.2 41475.4 42202.8 38082.4 40330.4 40342.6 41206.6 42250.0 40730.2 40773.6 40785.8 40832.4 40992.4 35547.6 37881.8 38007.4 38019.4 38395.2 28405.4 28597.6 28615.6 28750.0 29022.7 17:40:39 INFO - PROCESS | 5753 | 17:40:39 INFO - PROCESS | 5753 | [#2] jquery.html Cycles:180 Average:26960.96 Median:242630.00 stddev:73342.92 (30.2%) stddev-sans-first:73521.52 17:40:39 INFO - PROCESS | 5753 | Values: 386.9 392.3 394.4 394.7 419.3 14459.7 18087.2 18749.2 19828.7 19903.9 18339.2 18345.5 19004.3 19252.2 19565.6 5606.2 5607.2 5721.6 5750.7 5755.2 5433.9 5599.2 5754.6 5760.9 5769.3 5707.1 5799.3 5812.4 5857.2 5880.1 5748.3 5790.9 5799.7 5809.3 5852.1 5621.4 5656.8 5664.4 5679.6 5679.7 13104.9 13703.7 13788.7 13927.7 14337.4 2014.8 2029.8 2087.4 2694.9 2705.9 9434.8 9929.4 10208.3 10254.6 10624.6 1812.4 1848.4 1858.8 1887.4 1963.3 79340.6 81385.2 82364.6 82658.6 85627.0 10868.7 10952.5 10974.4 11092.7 11196.0 13781.0 15399.8 15401.6 15423.8 15438.1 7397.6 7417.3 7645.9 7781.1 7792.5 6908.7 7106.0 7224.3 7436.2 7444.4 4286.5 4676.8 4735.5 4786.5 4818.0 1888.8 1921.8 1934.5 1945.2 1973.9 813.5 898.3 905.5 920.0 1050.8 17663.4 18112.4 18442.4 18449.6 18513.9 914.8 931.9 946.6 960.8 1035.6 9971.3 10344.7 10524.8 10571.4 10577.6 433494.0 438361.0 441326.0 448203.0 451177.0 88369.0 88460.0 89721.6 91058.5 92160.0 992.7 996.1 996.3 999.9 1001.4 15922.8 16366.8 16419.3 17460.9 17530.2 39265.8 42827.0 43082.8 43934.0 44493.3 52973.2 52990.2 54309.5 59592.4 61106.4 7678.6 7715.5 7863.1 7866.3 7884.5 9649.3 10743.9 11354.1 11447.0 11874.9 9864.5 10309.4 10347.2 10418.2 10640.2 9917.7 9918.4 10007.1 10016.8 10182.6 10035.8 10101.5 10197.6 10210.1 10225.6 7705.9 7825.3 7914.8 8074.7 8134.7 7729.8 9906.6 10278.9 10286.6 10621.0 17:40:39 INFO - PROCESS | 5753 | 17:40:39 INFO - PROCESS | 5753 | [#3] mootools.html Cycles:180 Average:5608.87 Median:4865.21 stddev:3189.33 (65.6%) stddev-sans-first:3183.07 17:40:39 INFO - PROCESS | 5753 | Values: 1464.7 1480.6 1614.2 1698.2 1722.3 7823.6 8114.3 8248.5 8992.1 9004.8 7938.8 8350.6 8354.2 8360.8 8628.1 2172.0 2232.5 2235.1 2243.9 2244.3 2259.2 2282.8 2316.6 2320.0 2329.8 2232.8 2263.8 2268.9 2284.7 2292.2 2178.0 2182.2 2191.0 2194.3 2196.4 2204.7 2216.3 2217.6 2218.3 2231.8 8494.6 8649.8 8699.8 8752.2 8763.4 4808.7 4921.7 4932.5 4936.3 4945.2 3214.6 3285.0 3394.4 3401.4 3404.4 1111.8 1140.3 1155.7 1159.4 1173.9 11393.6 11448.3 11544.9 11634.7 11646.9 4320.9 4396.8 4450.0 4604.4 4606.9 9941.6 9944.4 9952.5 9969.7 9972.9 4939.4 4964.0 4972.7 4973.9 4976.9 4198.5 4218.9 4476.6 4555.5 4559.0 3952.9 3975.2 3995.3 4022.6 4083.4 1293.2 1316.2 1327.7 1328.4 1331.8 883.7 970.6 980.0 987.2 987.6 5731.9 5899.3 5901.8 5917.1 6027.2 445.5 446.9 447.7 450.9 462.6 4112.7 4124.1 4126.6 4133.0 4166.7 10429.5 10633.1 10726.0 10738.9 10757.5 10622.1 10638.3 10656.5 10661.0 10675.3 7543.7 7991.6 7998.6 8023.9 8080.4 5921.7 5952.7 5981.4 6007.6 6117.6 9461.5 9514.1 9787.0 9865.6 9873.8 10062.4 10074.6 10115.1 10134.5 10135.5 6799.8 6902.2 7157.6 7187.0 7287.4 8574.7 8625.5 8648.5 8661.3 8662.2 7103.5 7240.6 7318.5 7332.5 7374.6 7039.8 7131.9 7245.1 7305.2 7319.5 6737.0 6756.7 6766.3 6816.7 6817.7 4922.5 5099.8 5103.7 5109.4 5133.9 4989.9 5064.6 5153.4 5159.8 5223.8 17:40:39 INFO - PROCESS | 5753 | 17:40:39 INFO - PROCESS | 5753 | [#4] prototype.html Cycles:180 Average:4795.02 Median:5475.23 stddev:1419.09 (25.9%) stddev-sans-first:1382.58 17:40:39 INFO - PROCESS | 5753 | Values: 310.5 314.7 315.3 327.3 333.8 5341.7 5439.4 5467.4 5467.5 5473.3 5338.8 5390.4 5390.6 5417.8 5428.2 4050.9 4094.7 4150.4 4207.4 4220.7 4170.4 4185.9 4209.9 4220.0 4236.5 4162.4 4171.3 4182.9 4189.9 4226.0 4015.3 4168.2 4196.6 4218.8 4249.6 3658.4 3661.4 3671.4 3673.0 3676.7 5203.2 5225.8 5235.2 5260.9 5266.8 4680.0 4779.9 4781.8 4802.6 4802.9 5605.8 5612.9 5620.6 5627.5 5634.3 4061.9 4074.2 4075.8 4078.3 4084.2 5639.2 5786.4 5798.7 5832.4 5866.3 4124.8 4132.8 4141.7 4143.6 4155.5 4178.4 4218.7 4226.0 4250.6 4257.6 4602.4 4806.6 4809.7 4811.5 4839.6 5679.5 5701.8 5705.7 5712.5 5726.9 1471.8 1477.9 1480.1 1487.6 1493.8 909.4 939.8 960.2 972.3 979.6 5379.9 5458.2 5471.9 5477.1 5505.0 5821.5 5836.4 5837.5 5837.8 5884.5 5253.6 5409.6 5500.8 5523.3 5545.4 3101.5 3109.7 3118.0 3135.3 3146.6 5904.6 6044.6 6045.8 6052.3 6057.1 5868.7 5887.6 5903.6 5908.3 5949.8 5991.9 6030.2 6034.2 6041.9 6070.9 5712.9 5713.9 5749.4 5756.4 5897.1 5707.9 5715.2 5743.2 5743.4 5766.4 5812.2 5998.6 6054.9 6055.5 6059.4 4201.7 4234.4 4244.2 4244.4 4269.6 6014.0 6048.3 6056.3 6058.9 6070.2 5667.3 5742.7 5757.5 5874.1 5912.2 5743.5 5744.2 5746.0 5790.8 5796.9 5766.3 5779.8 5785.7 5806.2 5833.8 5302.5 5769.3 5771.7 5783.3 5816.4 5655.5 5666.3 5668.2 5675.9 5712.5 17:40:39 INFO - PROCESS | 5753 | 17:40:39 INFO - PROCESS | 5753 | [#5] yui.html Cycles:180 Average:20264.87 Median:25313.85 stddev:29784.27 (117.7%) stddev-sans-first:29831.67 17:40:39 INFO - PROCESS | 5753 | Values: 721.9 727.3 791.6 842.7 852.9 15031.2 15654.0 15711.2 15761.5 15822.5 13396.2 13478.9 13484.8 13492.4 13520.7 647.7 670.3 757.4 760.1 783.4 789.1 789.8 790.2 792.7 792.8 824.9 828.6 828.7 829.0 829.5 823.3 827.1 828.8 831.5 831.6 607.5 608.8 609.1 609.4 609.8 14036.7 14215.4 14229.9 14240.7 14298.8 12494.3 12639.4 13201.5 13305.2 13595.9 10550.3 10718.7 10719.8 10757.2 10769.4 3374.5 3385.7 3421.0 3421.1 3427.2 76967.0 77361.6 78051.6 79228.2 79731.2 9018.7 9077.6 9414.1 9461.2 9534.1 18485.9 23138.7 23144.8 23455.3 23500.4 7010.0 7095.0 7222.2 7429.8 7523.4 4126.4 4151.8 4182.0 4223.2 4261.2 3438.6 3547.4 3574.4 3585.3 3614.7 594.9 595.9 602.4 603.0 608.3 586.7 663.9 693.3 730.9 752.7 8560.9 8912.9 8989.4 9029.4 9147.0 606.6 645.5 715.0 725.7 751.6 4281.8 4426.9 4431.2 4634.2 4713.4 115542.0 115769.0 120395.0 121540.0 123101.0 90810.5 94895.0 96066.5 97678.0 98394.0 73577.9 79756.0 81255.0 86700.6 86774.6 9680.4 9683.3 9883.0 9917.7 9920.5 36653.1 37720.8 45993.5 49246.5 49889.0 67999.7 72540.0 74264.0 76247.0 76797.0 12509.7 12768.4 13084.3 13101.1 13145.0 14241.7 14481.7 14557.6 14896.3 15323.8 13073.9 13349.9 13448.9 13500.0 13512.9 12975.3 13232.2 13471.3 13698.2 13914.5 11961.2 12193.5 12313.2 12667.0 12929.9 11302.3 11602.6 11982.9 12107.4 12127.2 11515.7 11779.8 11837.1 11860.6 11965.6 17:40:39 INFO - PROCESS | 5753 | -------- Summary: end -------- 17:40:39 INFO - PROCESS | 5753 | 17:40:40 INFO - TEST-INFO | 5753: exit 0 17:40:40 INFO - TEST-OK | dromaeo_css | took 1112740ms 17:40:40 INFO - TEST-START | kraken 17:40:40 INFO - operating with platform_type : linux_ 17:40:40 INFO - Initialising browser for kraken test... 17:40:40 INFO - TEST-INFO | started process 6114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppHxS2p/profile http://localhost:36453/getInfo.html) 17:40:45 INFO - PROCESS | 6114 | __metrics Screen width/height:1600/1200 17:40:45 INFO - PROCESS | 6114 | colorDepth:24 17:40:45 INFO - PROCESS | 6114 | Browser inner width/height: 1024/697 17:40:45 INFO - PROCESS | 6114 | __metrics 17:40:45 ERROR - PROCESS | 6114 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 17:40:46 INFO - TEST-INFO | 6114: exit 0 17:40:46 INFO - Browser initialized. 17:40:46 INFO - Running cycle 1/1 for kraken test... 17:40:46 INFO - TEST-INFO | started process 6240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppHxS2p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:40:58 INFO - PROCESS | 6240 | RSS: Main: 184782848 17:40:58 INFO - PROCESS | 6240 | 17:41:01 INFO - PROCESS | 6240 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36453/tests/kraken/driver.html?testName=audio-beat-detection) 17:41:02 INFO - PROCESS | 6240 | RSS: Main: 198258688 17:41:02 INFO - PROCESS | 6240 | 17:41:04 INFO - PROCESS | 6240 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36453/tests/kraken/driver.html?testName=audio-dft) 17:41:05 INFO - PROCESS | 6240 | RSS: Main: 196202496 17:41:05 INFO - PROCESS | 6240 | 17:41:08 INFO - PROCESS | 6240 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36453/tests/kraken/driver.html?testName=audio-fft) 17:41:08 INFO - PROCESS | 6240 | RSS: Main: 192004096 17:41:08 INFO - PROCESS | 6240 | 17:41:11 INFO - PROCESS | 6240 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36453/tests/kraken/driver.html?testName=audio-oscillator) 17:41:11 INFO - PROCESS | 6240 | RSS: Main: 192909312 17:41:11 INFO - PROCESS | 6240 | 17:41:13 INFO - PROCESS | 6240 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36453/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:41:14 INFO - PROCESS | 6240 | RSS: Main: 193130496 17:41:14 INFO - PROCESS | 6240 | 17:41:17 INFO - PROCESS | 6240 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36453/tests/kraken/driver.html?testName=imaging-darkroom) 17:41:18 INFO - PROCESS | 6240 | RSS: Main: 193368064 17:41:18 INFO - PROCESS | 6240 | 17:41:21 INFO - PROCESS | 6240 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36453/tests/kraken/driver.html?testName=imaging-desaturate) 17:41:22 INFO - PROCESS | 6240 | RSS: Main: 191426560 17:41:22 INFO - PROCESS | 6240 | 17:41:25 INFO - PROCESS | 6240 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36453/tests/kraken/driver.html?testName=json-parse-financial) 17:41:25 INFO - PROCESS | 6240 | RSS: Main: 192503808 17:41:25 INFO - PROCESS | 6240 | 17:41:27 INFO - PROCESS | 6240 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36453/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:41:27 INFO - PROCESS | 6240 | RSS: Main: 192995328 17:41:27 INFO - PROCESS | 6240 | 17:41:29 INFO - PROCESS | 6240 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36453/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:41:30 INFO - PROCESS | 6240 | RSS: Main: 192823296 17:41:30 INFO - PROCESS | 6240 | 17:41:32 INFO - PROCESS | 6240 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36453/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:41:33 INFO - PROCESS | 6240 | RSS: Main: 193675264 17:41:33 INFO - PROCESS | 6240 | 17:41:35 INFO - PROCESS | 6240 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36453/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:41:36 INFO - PROCESS | 6240 | RSS: Main: 193257472 17:41:36 INFO - PROCESS | 6240 | 17:41:39 INFO - PROCESS | 6240 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36453/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:41:39 INFO - PROCESS | 6240 | RSS: Main: 193814528 17:41:39 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36453/tests/kraken/driver.html?testName=ai-astar) 17:41:41 INFO - PROCESS | 6240 | RSS: Main: 195309568 17:41:41 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | __start_tp_report 17:41:41 INFO - PROCESS | 6240 | _x_x_mozilla_page_load 17:41:41 INFO - PROCESS | 6240 | _x_x_mozilla_page_load_details 17:41:41 INFO - PROCESS | 6240 | |i|pagename|runs| 17:41:41 INFO - PROCESS | 6240 | |0;ai-astar;104;110;112;111;113;112;112;111;112;113 17:41:41 INFO - PROCESS | 6240 | |1;audio-beat-detection;151;121;120;163;120;122;125;124;150;122 17:41:41 INFO - PROCESS | 6240 | |2;audio-dft;163;163;164;166;176;166;164;164;163;162 17:41:41 INFO - PROCESS | 6240 | |3;audio-fft;76;76;75;115;76;76;76;76;102;77 17:41:41 INFO - PROCESS | 6240 | |4;audio-oscillator;82;85;121;82;83;82;100;84;83;120 17:41:41 INFO - PROCESS | 6240 | |5;imaging-gaussian-blur;118;118;118;117;119;118;117;117;118;118 17:41:41 INFO - PROCESS | 6240 | |6;imaging-darkroom;147;149;146;147;149;148;148;147;147;147 17:41:41 INFO - PROCESS | 6240 | |7;imaging-desaturate;97;97;97;96;97;96;97;95;96;95 17:41:41 INFO - PROCESS | 6240 | |8;json-parse-financial;51;51;53;52;63;53;52;53;52;52 17:41:41 INFO - PROCESS | 6240 | |9;json-stringify-tinderbox;60;60;60;59;61;60;60;60;60;62 17:41:41 INFO - PROCESS | 6240 | |10;stanford-crypto-aes;79;81;80;90;87;79;80;80;79;79 17:41:41 INFO - PROCESS | 6240 | |11;stanford-crypto-ccm;126;124;132;124;143;134;126;132;167;139 17:41:41 INFO - PROCESS | 6240 | |12;stanford-crypto-pbkdf2;169;168;163;161;162;162;166;164;162;170 17:41:41 INFO - PROCESS | 6240 | |13;stanford-crypto-sha256-iterative;66;65;64;64;64;64;70;64;64;65 17:41:41 INFO - PROCESS | 6240 | __end_tp_report 17:41:41 INFO - PROCESS | 6240 | __start_cc_report 17:41:41 INFO - PROCESS | 6240 | _x_x_mozilla_cycle_collect,768 17:41:41 INFO - PROCESS | 6240 | __end_cc_report 17:41:41 INFO - PROCESS | 6240 | __startTimestamp1474677701821__endTimestamp 17:41:41 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | ------- Summary: start ------- 17:41:41 INFO - PROCESS | 6240 | Number of tests: 14 17:41:41 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.62 (2.3%) stddev-sans-first:0.97 17:41:41 INFO - PROCESS | 6240 | Values: 104.0 110.0 112.0 111.0 113.0 112.0 112.0 111.0 112.0 113.0 17:41:41 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | [#1] audio-beat-detection Cycles:10 Average:131.80 Median:124.50 stddev:16.22 (13.0%) stddev-sans-first:15.64 17:41:41 INFO - PROCESS | 6240 | Values: 151.0 121.0 120.0 163.0 120.0 122.0 125.0 124.0 150.0 122.0 17:41:41 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:4.04 (2.5%) stddev-sans-first:4.21 17:41:41 INFO - PROCESS | 6240 | Values: 163.0 163.0 164.0 166.0 176.0 166.0 164.0 164.0 163.0 162.0 17:41:41 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:14.05 (18.5%) stddev-sans-first:14.70 17:41:41 INFO - PROCESS | 6240 | Values: 76.0 76.0 75.0 115.0 76.0 76.0 76.0 76.0 102.0 77.0 17:41:41 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:82.50 stddev:15.86 (19.2%) stddev-sans-first:16.39 17:41:41 INFO - PROCESS | 6240 | Values: 82.0 85.0 121.0 82.0 83.0 82.0 100.0 84.0 83.0 120.0 17:41:41 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 17:41:41 INFO - PROCESS | 6240 | Values: 118.0 118.0 118.0 117.0 119.0 118.0 117.0 117.0 118.0 118.0 17:41:41 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 17:41:41 INFO - PROCESS | 6240 | Values: 147.0 149.0 146.0 147.0 149.0 148.0 148.0 147.0 147.0 147.0 17:41:41 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.83 17:41:41 INFO - PROCESS | 6240 | Values: 97.0 97.0 97.0 96.0 97.0 96.0 97.0 95.0 96.0 95.0 17:41:41 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:52.50 stddev:3.52 (6.7%) stddev-sans-first:3.64 17:41:41 INFO - PROCESS | 6240 | Values: 51.0 51.0 53.0 52.0 63.0 53.0 52.0 53.0 52.0 52.0 17:41:41 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 17:41:41 INFO - PROCESS | 6240 | Values: 60.0 60.0 60.0 59.0 61.0 60.0 60.0 60.0 60.0 62.0 17:41:41 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:80.00 stddev:3.86 (4.8%) stddev-sans-first:4.00 17:41:41 INFO - PROCESS | 6240 | Values: 79.0 81.0 80.0 90.0 87.0 79.0 80.0 80.0 79.0 79.0 17:41:41 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:133.00 stddev:13.02 (9.8%) stddev-sans-first:13.43 17:41:41 INFO - PROCESS | 6240 | Values: 126.0 124.0 132.0 124.0 143.0 134.0 126.0 132.0 167.0 139.0 17:41:41 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.00 stddev:3.30 (2.0%) stddev-sans-first:3.11 17:41:41 INFO - PROCESS | 6240 | Values: 169.0 168.0 163.0 161.0 162.0 162.0 166.0 164.0 162.0 170.0 17:41:41 INFO - PROCESS | 6240 | 17:41:41 INFO - PROCESS | 6240 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:64.50 stddev:1.89 (2.9%) stddev-sans-first:1.96 17:41:41 INFO - PROCESS | 6240 | Values: 66.0 65.0 64.0 64.0 64.0 64.0 70.0 64.0 64.0 65.0 17:41:41 INFO - PROCESS | 6240 | -------- Summary: end -------- 17:41:41 INFO - PROCESS | 6240 | 17:41:42 INFO - PROCESS | 6240 | 17:41:42 INFO - PROCESS | 6240 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 17:41:42 INFO - PROCESS | 6240 | 17:41:42 INFO - PROCESS | 6240 | 17:41:42 INFO - PROCESS | 6240 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 17:41:42 INFO - PROCESS | 6240 | 17:41:42 INFO - PROCESS | 6240 | 17:41:42 INFO - PROCESS | 6240 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 17:41:42 INFO - PROCESS | 6240 | 17:41:42 INFO - PROCESS | 6240 | 17:41:42 INFO - PROCESS | 6240 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 17:41:42 INFO - PROCESS | 6240 | 17:41:42 INFO - PROCESS | 6240 | 17:41:42 INFO - PROCESS | 6240 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 17:41:42 INFO - PROCESS | 6240 | 17:41:42 INFO - TEST-INFO | 6240: exit 0 17:41:43 INFO - TEST-OK | kraken | took 62080ms 17:41:43 INFO - SUITE-END | took 1174s 17:41:43 INFO - Completed test suite (00:19:35) 17:41:43 INFO - javascript benchmark 17:41:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7009.639824240078, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3022.471067563176, 3024.576559281701, 3050.23744063984, 3057.0217530390278, 3061.127578640088, 5205.843824685261, 5225.790968361261, 5249.05517006939, 5327.387350454699, 5335.0, 5273.446288139748, 5295.443978382272, 5326.7070311132875, 5379.246905433242, 5390.380106287778, 4838.63710221733, 4860.8055677772845, 4884.951150488503, 4906.386701662293, 4959.032988567231, 4867.610591152699, 4894.3147959285725, 4919.286703428019, 4926.778294976734, 4978.950210497903, 4752.904941901177, 4781.115493633654, 4887.706737595738, 4896.730679812609, 4945.431275403339, 4810.735409552473, 4841.225403935388, 4868.367112275417, 4946.208606622923, 4946.431160416562, 4822.083804077214, 4831.202851529493, 4837.927431088537, 4852.878678033077, 4864.343313652647, 5283.1546952487415, 5328.92006619901, 5332.946670533283, 5333.120035194227, 5345.3852806926925, 5531.889362212733, 5613.971930140323, 5633.183188437653, 5688.0, 5716.428357164292, 5598.748056337475, 5600.579956503238, 5602.579806514487, 5603.159526071081, 5619.522340601054, 5243.4232234454175, 5279.894402111975, 5286.264938312005, 5288.603354748371, 5373.623846330719, 5718.399568045378, 5737.741801618937, 5769.68266745333, 5772.480476757112, 5787.276590426197, 5512.6692398456225, 5547.306586676666, 5553.222548843165, 5560.499555040065, 5570.777168913279, 5557.44425557441, 5565.749541270652, 5637.859053523613, 5638.069718496484, 5642.746076426489, 5481.890362192734, 5493.2034854946605, 5494.203340515603, 5501.477359650827, 5556.16657501378, 5520.806771763049, 5525.889482210414, 5526.0, 5526.861828454241, 5534.059209934321, 4296.037481140306, 4309.41822853917, 4311.051568654891, 4328.48058233014, 4357.041450880801, 3881.1073453105378, 3893.8637147699696, 3941.9014524637114, 3975.8210880510446, 4025.4766880305374, 5468.37113731918, 5490.121580547173, 5504.972475137599, 5507.284053073075, 5517.69652669107, 5746.597738158289, 5761.135829625506, 5764.913526297109, 5765.04876695349, 5830.941690583039, 5221.738913054332, 5226.738663066832, 5283.418823929364, 5341.4925582069645, 5368.248445217672, 4881.072596206709, 4896.706197628154, 4907.509249075064, 4954.702717836942, 4967.031428871408, 5789.131630255495, 5844.736986835687, 5846.912296315559, 5853.502452291517, 5869.090291004815, 5549.972250138885, 5608.457674139644, 5657.405972373006, 5678.230291543075, 5754.798582049608, 5831.533477321889, 5836.503897168788, 5899.0, 5900.793472228452, 5912.0, 5613.775448981995, 5613.859653508695, 5614.915776263278, 5625.774969001194, 5629.831105066854, 5614.438556144353, 5658.519025882846, 5707.143928410605, 5738.971305143447, 5747.281589801275, 5603.915941260802, 5606.467385598362, 5616.129499927518, 5654.0, 5681.034224181816, 5586.86032849182, 5587.0502014656795, 5598.440155984369, 5602.13166959122, 5609.270794796814, 5381.0, 5421.105517589711, 5445.292112025411, 5526.281583394133, 5546.140348246028, 5624.0, 5631.183478395692, 5640.294963129609, 5640.605157638925, 5686.0, 5464.972675136599, 5468.945310546844, 5470.863228419162, 5486.807961721321, 5490.423505531861], "value": 5235.730109467127, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.3115833363811, 578.6412424296935, 583.2621733507115, 593.5192494079793, 594.4827999640313, 42171.78914105429, 43320.13359732807, 43582.0, 47071.0, 47128.29307560389, 44378.77810610951, 44389.112217755624, 44734.552654473446, 44776.55223447773, 44847.77576112115, 8860.246879015276, 9062.728118156467, 9074.63701451941, 9080.228180604656, 9083.863742043875, 8866.157715017096, 8889.777755556099, 8908.109189081104, 8921.910780892205, 8956.910430895705, 8941.59762810675, 8942.239909607692, 8991.235744961654, 8995.730128096167, 9009.369344145913, 8942.73171804847, 9003.59483823223, 9010.549472526347, 9017.098290170996, 9027.458352498837, 8905.0, 8912.643494260286, 8979.955100224523, 8995.460272383612, 9016.909830901672, 41477.792611036755, 41641.0, 41828.0, 42012.0, 42126.0, 3164.6360668523184, 3661.286049220403, 3852.653261206477, 4124.0, 4125.855595054159, 31051.534226986612, 31384.37231255362, 31480.527792083136, 31610.0, 31810.681893181005, 4309.5905888940815, 4428.512863585003, 4474.955250447519, 4631.374764406795, 4654.650901182425, 339404.0, 339938.0, 340221.0701555283, 341901.0, 342930.0, 34628.65371346305, 35738.0, 35868.0, 58805.41194588085, 59083.40916590779, 38164.8091759545, 38318.0, 38346.233075338336, 38413.423798643045, 38516.229675406335, 14171.362288697033, 14194.006419550533, 14232.28838558068, 14252.429902803979, 14300.570982870531, 12154.635360939186, 12333.629991100102, 12336.444859981322, 12362.258264504158, 12365.77416065117, 8629.13708629132, 8637.827243455096, 8647.178518040777, 8772.38593298463, 8791.07693692153, 3372.15696075981, 3430.091025878144, 3435.6465820912254, 3443.1908501502126, 3465.2722928185362, 963.0658261486348, 966.8694726212012, 978.0073225675944, 1024.416082832778, 1045.4772613693153, 31568.526472102938, 31612.0, 31943.20141996422, 32374.19064523406, 32645.0, 973.4062222044547, 1059.6662051453768, 1110.3227031510771, 1110.7556337605713, 1170.8536432945882, 16211.432599859185, 16294.918525407535, 16379.0, 16507.596854267522, 16910.15449227534, 543175.0, 544945.0, 547204.0, 548524.0, 550197.0, 56714.7164264176, 56810.046593476945, 57718.134227986615, 57811.0, 57902.42097579055, 1262.236347010064, 1280.7246442015012, 1285.4922305689201, 1298.3508245877063, 1299.3957809618573, 29714.405711886073, 29924.0, 29989.850050749606, 30593.365799137297, 30619.693803061684, 49197.0, 49279.26081108858, 49522.0, 49525.75237123791, 49550.25674614956, 336224.0, 338229.0, 424144.0, 425033.24634289584, 426154.0, 28164.71835281621, 28608.85695571592, 28667.56998645064, 29038.854805725838, 29039.85480072586, 46855.0, 47058.76470617625, 47099.52900471089, 47432.0, 47636.5236347646, 39405.408918865665, 39956.93372079651, 40342.19315613613, 41475.37786933259, 42202.788986054875, 38082.42876356912, 40330.395044073775, 40342.59657403506, 41206.587934120274, 42250.0, 40730.1853962925, 40773.592264078165, 40785.79607102064, 40832.38751418672, 40992.385114222714, 35547.64452355547, 37881.81059094687, 38007.429888552244, 38019.42970855495, 38395.23209535738, 28405.43189136247, 28597.571036434885, 28615.570766438937, 28750.0, 29022.709772902846], "value": 18695.396545976393, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.8549294014744, 392.2703770985967, 394.3670408993564, 394.7079161420548, 419.2830260254964, 14459.710805783878, 18087.18607662655, 18749.156287967042, 19828.702569461453, 19903.900480497596, 18339.17473713683, 18345.54136146597, 19004.334848280312, 19252.22991080355, 19565.608687826236, 5606.187102870082, 5607.158926161078, 5721.570882183832, 5750.7412166452405, 5755.194272801811, 5433.918491222615, 5599.188117722948, 5754.568407369443, 5760.884782304352, 5769.336526299488, 5707.058335374658, 5799.304083509985, 5812.389699081599, 5857.150713146591, 5880.147378630096, 5748.338941021794, 5790.855228619276, 5799.739011744482, 5809.2738407699035, 5852.092925596539, 5621.409751976065, 5656.8020119295625, 5664.376918538957, 5679.630823996468, 5679.687617181054, 13104.934475327658, 13703.657408564766, 13788.724225515534, 13927.651808704763, 14337.35481903317, 2014.7783743788173, 2029.8477614178996, 2087.3946555498887, 2694.932626684329, 2705.9052933147245, 9434.764130896714, 9929.3545919515, 10208.285420020602, 10254.641087561975, 10624.575016999312, 1812.4472036029006, 1848.4454663600866, 1858.7769467663966, 1887.37716553537, 1963.3030274252578, 79340.60329698373, 81385.18614813835, 82364.58817705873, 82658.58670706669, 85627.0, 10868.67393978182, 10952.4523773811, 10974.378455109794, 11092.667219983414, 11196.0, 13781.0, 15399.769003464957, 15401.614959625875, 15423.768643470357, 15438.073715576877, 7397.556146631219, 7417.258274172647, 7645.923540764521, 7781.105172905075, 7792.532448053135, 6908.745134163397, 7105.96447017772, 7224.349808517153, 7436.1820199777985, 7444.441666875006, 4286.5070516890955, 4676.843130886706, 4735.479097299294, 4786.497417771154, 4817.975910120497, 1888.830005299502, 1921.7604645003894, 1934.5453818352676, 1945.192745010833, 1973.8716983396034, 813.495632707725, 898.3172788680519, 905.5110240470204, 919.9586018629178, 1050.8318669012922, 17663.38178163758, 18112.36606718785, 18442.446726598224, 18449.631007379776, 18513.889166649773, 914.7895983923602, 931.9347645664739, 946.6497395963538, 960.7790208252142, 1035.5857656937135, 9971.252156088321, 10344.741381465523, 10524.842127368096, 10571.418571978462, 10577.576896924036, 433494.0, 438361.0, 441326.0, 448203.0, 451177.0, 88369.0, 88460.0, 89721.55139224262, 91058.54470727737, 92160.0, 992.6624947517879, 996.1471662707359, 996.3211987800579, 999.8701467342003, 1001.4191768774093, 15922.840771592137, 16366.836331637007, 16419.26113324927, 17460.91269543644, 17530.211140498453, 39265.80367098146, 42827.0, 43082.78458607687, 43934.0, 44493.33260001038, 52973.20540191823, 52990.205146923596, 54309.45690543044, 59592.404075958686, 61106.38893611007, 7678.616069196406, 7715.498492597963, 7863.095743989515, 7866.252705992922, 7884.487508311941, 9649.276304277068, 10743.87980072951, 11354.091672666333, 11447.0, 11874.881251187378, 9864.506774661095, 10309.432981186106, 10347.172226222036, 10418.166546676399, 10640.201984851323, 9917.702468925943, 9918.40489570628, 10007.149392301735, 10016.849747253942, 10182.592696292362, 10035.849462257926, 10101.545430455793, 10197.643082492077, 10210.132138768287, 10225.642102526375, 7705.922940770744, 7825.334846538108, 7914.802129946567, 8074.717384891501, 8134.67461301565, 7729.768106956801, 9906.603735850773, 10278.897211027794, 10286.588536458457, 10621.0], "value": 8690.0541931643, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.7363474574577, 1480.5632338460152, 1614.2251719174797, 1698.1763844535405, 1722.3110755697728, 7823.608819559027, 8114.269715725598, 8248.54632995185, 8992.100789921005, 9004.774880627987, 7938.841223175533, 8350.582470876463, 8354.164583541642, 8360.790980225498, 8628.09405012474, 2172.0, 2232.5311684546264, 2235.117128734149, 2243.876586787726, 2244.304265677637, 2259.152817693365, 2282.8402011859175, 2316.5714342846545, 2319.9560197910923, 2329.755375685554, 2232.8325375596814, 2263.7509873913855, 2268.8638681679067, 2284.680144779724, 2292.1748170658548, 2178.0307763045453, 2182.181681869291, 2191.024993877725, 2194.2868567715554, 2196.417949243452, 2204.691343211952, 2216.2797090945505, 2217.645176771725, 2218.267971569378, 2231.843770936035, 8494.575271236476, 8649.827003459895, 8699.826003479959, 8752.21230089295, 8763.386562940597, 4808.711477311373, 4921.704697718148, 4932.457429682732, 4936.333594964705, 4945.208766597363, 3214.582104326446, 3284.950725739116, 3394.422948098804, 3401.370746411897, 3404.3531728971666, 1111.8182903059019, 1140.3044143072718, 1155.659080571225, 1159.3739380734394, 1173.8591369035685, 11393.601223957121, 11448.255863368855, 11544.942275288653, 11634.650960471115, 11646.94176529112, 4320.935185972213, 4396.802143903532, 4449.9777501112285, 4604.40142781443, 4606.907861842745, 9941.602335906628, 9944.35361701487, 9952.452615106238, 9969.651062212788, 9972.850407243897, 4939.407271127488, 4964.0, 4972.676776009548, 4973.90052198954, 4976.850694479172, 4198.4961804583645, 4218.873433796991, 4476.597106260452, 4555.453345598549, 4558.9772051139535, 3952.8616498422994, 3975.224831157954, 3995.2808494471274, 4022.557518672944, 4083.4079058536345, 1293.2434525802323, 1316.1576590981779, 1327.74772793169, 1328.4287756264898, 1331.7735984882593, 883.7481317824389, 970.5972021611094, 979.9853002204973, 987.2250283527396, 987.5802783816993, 5731.942680573141, 5899.292084949748, 5901.76392944286, 5917.142014407887, 6027.221969519002, 445.5277405949704, 446.91955448019667, 447.68885624491315, 450.93461448089846, 462.5767422808093, 4112.732672376286, 4124.1133156370925, 4126.587341265849, 4132.958670413317, 4166.749995000249, 10429.478526073817, 10633.096186824052, 10726.0, 10738.946305268424, 10757.515911783988, 10622.097121744584, 10638.308509946828, 10656.467176641137, 10661.0, 10675.252732308663, 7543.698252069966, 7991.560464174526, 7998.64006119726, 8023.879641805378, 8080.4343695940715, 5921.6743079131065, 5952.672603006876, 5981.3719559445635, 6007.639541627342, 6117.602355847033, 9461.479618620766, 9514.143727064597, 9786.951065244628, 9865.556049977624, 9873.802523949624, 10062.39625622465, 10074.597016119273, 10115.140213081677, 10134.493275336352, 10135.49322533885, 6799.762008329685, 6902.206246281541, 7157.606331651809, 7186.964065179641, 7287.380572651384, 8574.657013719381, 8625.525596092275, 8648.481091134552, 8661.263792577702, 8662.177093176138, 7103.538270012433, 7240.637968101679, 7318.451116166202, 7332.486725929134, 7374.631268436449, 7039.824004399726, 7131.928680713127, 7245.094363204599, 7305.196428392979, 7319.487635865438, 6737.0, 6756.662166891538, 6766.323367663194, 6816.693248803915, 6817.693203805741, 4922.507749225192, 5099.821506247264, 5103.668261562986, 5109.3613298337705, 5133.8716532087, 4989.875253118701, 5064.620153488429, 5153.3558305211845, 5159.767810448464, 5223.817166399158], "value": 4434.599660041023, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.52799744388517, 314.6790273920602, 315.2701496036675, 327.30121191256666, 333.77303433665105, 5341.664583854036, 5439.374471935724, 5467.425920278373, 5467.535259502937, 5473.343198816143, 5338.786448542053, 5390.407055223922, 5390.595705322097, 5417.756200970956, 5428.212909128184, 4050.9189816203734, 4094.6724262058965, 4150.398192262121, 4207.43199668044, 4220.704550681454, 4170.416141740159, 4185.874423767292, 4209.884380639133, 4220.016592201676, 4236.491621005468, 4162.43807086044, 4171.332586786115, 4182.937255941163, 4189.895252618694, 4225.978870105645, 4015.31739604268, 4168.187203495319, 4196.636093269669, 4218.810153543067, 4249.596288352617, 3658.3597870372846, 3661.3958696814993, 3671.3942199537046, 3672.981635091834, 3676.74262801604, 5203.219517072432, 5225.817096401645, 5235.240890070919, 5260.947390526084, 5266.815661451869, 4679.9938013326955, 4779.880502987453, 4781.784819683088, 4802.639802014828, 4802.903941921177, 5605.831825045255, 5612.887742245173, 5620.634658747168, 5627.493525582676, 5634.295713035871, 4061.8578349757618, 4074.1647962167685, 4075.8369665213654, 4078.3270760324513, 4084.223997440477, 5639.182318563826, 5786.421357864222, 5798.681072541009, 5832.358440571534, 5866.266716660418, 4124.772622783663, 4132.793360331972, 4141.674664107457, 4143.585641435832, 4155.522114956819, 4178.35235538492, 4218.6625069994325, 4225.978870105691, 4250.617444430016, 4257.6168144867115, 4602.4477062752685, 4806.639502037291, 4809.687370320918, 4811.49479304668, 4839.57232616379, 5679.517241034476, 5701.800436984769, 5705.74324155414, 5712.542996560265, 5726.914096288559, 1471.8454562270808, 1477.8669919707063, 1480.1193289992436, 1487.620656732548, 1493.828209755892, 909.3816204980544, 939.8167357365385, 960.2126256469768, 972.3290929258931, 979.6081567372966, 5379.865503362447, 5458.208559758813, 5471.863203419866, 5477.110396913059, 5504.972475137599, 5821.476067153976, 5836.445537673914, 5837.489879351834, 5837.824865254049, 5884.529237660977, 5253.609607628597, 5409.594280428983, 5500.779968801283, 5523.309586301712, 5545.417731138253, 3101.4882544380375, 3109.7201251886986, 3117.986654337304, 3135.263213144909, 3146.57521234635, 5904.5571582131515, 6044.637321760709, 6045.78839740607, 6052.303985041688, 6057.092016014941, 5868.735906884201, 5887.617304875255, 5903.616264942765, 5908.316129902957, 5949.791757288474, 5991.880162396727, 6030.155778191057, 6034.24571928509, 6041.879162416727, 6070.939290607126, 5712.914546236202, 5713.885722285614, 5749.367569567428, 5756.395578464201, 5897.085951677497, 5707.8858422832145, 5715.171300161536, 5743.195952566561, 5743.396943321059, 5766.365699773106, 5812.244408227072, 5998.640081595118, 6054.878902421839, 6055.455009049207, 6059.3637668045985, 4201.663866890703, 4234.386014027887, 4244.214820258262, 4244.427002354642, 4269.637080848162, 6013.9699301503215, 6048.274207095001, 6056.3035250946705, 6058.939410605837, 6070.210872586712, 5667.319921609434, 5742.741576628978, 5757.539396848326, 5874.148248503858, 5912.231409916683, 5743.540516758733, 5744.167095771007, 5746.023176059996, 5790.812883358817, 5796.927628356978, 5766.3368712598585, 5779.792215320369, 5785.739641716217, 5806.187133801187, 5833.82498525045, 5302.549283310807, 5769.278840144982, 5771.653700777967, 5783.334916484489, 5816.447437493432, 5655.462731040545, 5666.32004159487, 5668.157848699272, 5675.858103547444, 5712.542996560348], "value": 4336.46316383526, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.9422446204303, 727.3126895084148, 791.5962858941938, 842.6587232170971, 852.8720691896218, 15031.17328546931, 15654.0, 15711.21443927802, 15761.527154185378, 15822.525324240276, 13396.196228226288, 13478.932605336984, 13484.797728034062, 13492.392842322095, 13520.729585408286, 647.6761619190405, 670.3028849996023, 757.4319260554585, 760.0765070439415, 783.4241832253289, 789.0649580247425, 789.8459800338936, 790.2453157234855, 792.6750032486682, 792.7899106736719, 824.9092599814015, 828.6478246745139, 828.6850996621275, 828.9958550207241, 829.531314807135, 823.279630323467, 827.0984626756834, 828.8383765165765, 831.4720152703017, 831.575896292895, 607.4957785038451, 608.8356143841182, 609.0954931926086, 609.4088733928082, 609.7926704920349, 14036.719265614733, 14215.431382744679, 14229.857701422958, 14240.715185696228, 14298.785518217235, 12494.250344979331, 12639.43122559487, 13201.471941122343, 13305.20168789866, 13595.932020339835, 10550.31422957513, 10718.73203169927, 10719.83920241197, 10757.246992710514, 10769.407682577455, 3374.5444365010653, 3385.6783605557434, 3420.96579034209, 3421.1105112670884, 3427.1946092668204, 76967.0, 77361.61319193424, 78051.6097419515, 79228.20771792266, 79731.22956474783, 9018.684346047858, 9077.591508382138, 9414.105659962293, 9461.19579835708, 9534.09426104519, 18485.907570462332, 23138.652920206212, 23144.76855231426, 23455.296341109795, 23500.412489687893, 7009.964950175318, 7095.0421693070775, 7222.205557388683, 7429.7771066867, 7523.435742319348, 4126.360414135754, 4151.7924103794685, 4182.038131229773, 4223.1553689261655, 4261.232978063917, 3438.570178727659, 3547.379208638478, 3574.356615809127, 3585.3008663310925, 3614.6566076222716, 594.9196858424058, 595.943385378397, 602.3645054467491, 602.9547783916224, 608.3126067543736, 586.6626689653381, 663.9136912201479, 693.3205458650551, 730.9195988441268, 752.7102065704634, 8560.871586926201, 8912.8663070054, 8989.370744047854, 9029.367944243972, 9147.0, 606.6299557270062, 645.5029627187133, 714.9571025738472, 725.7314793526429, 751.6091632351147, 4281.807318670605, 4426.889327766768, 4431.224535706238, 4634.165850146938, 4713.410823647044, 115542.0, 115769.0, 120395.0, 121540.0, 123101.0, 90810.54594727117, 94895.0, 96066.51966740121, 97678.0, 98394.0, 73577.89633155506, 79756.0, 81255.0, 86700.5664971671, 86774.56612716896, 9680.370775899544, 9683.271940302893, 9882.962288959556, 9917.65288214909, 9920.454375009154, 36653.08367290839, 37720.81139594394, 45993.54006459893, 49246.50753492562, 49889.0, 67999.66000169968, 72540.0, 74264.0, 76247.0, 76797.0, 12509.749805003667, 12768.425420855898, 13084.345782710636, 13101.082924195214, 13145.0, 14241.715165696834, 14481.710365792414, 14557.563273101823, 14896.255187240811, 15323.77014344808, 13073.934630327169, 13349.866501335251, 13448.93275533616, 13500.0, 13512.93243533776, 12975.286359250333, 13232.206067635972, 13471.326433678081, 13698.219231499841, 13914.51299204523, 11961.162718609614, 12193.51225950952, 12313.199642023239, 12667.0, 12929.870701293243, 11302.321860688386, 11602.593909213138, 11982.880171198176, 12107.394630268274, 12127.151099422956, 11515.712107197052, 11779.823302650295, 11837.053035757292, 11860.644180674593, 11965.581204657796], "value": 7251.157571645721, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1503.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 112.0, 111.0, 113.0, 112.0, 112.0, 111.0, 112.0, 113.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 120.0, 163.0, 120.0, 122.0, 125.0, 124.0, 150.0, 122.0], "value": 131.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 166.0, 176.0, 166.0, 164.0, 164.0, 163.0, 162.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 115.0, 76.0, 76.0, 76.0, 76.0, 102.0, 77.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 121.0, 82.0, 83.0, 82.0, 100.0, 84.0, 83.0, 120.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 119.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 146.0, 147.0, 149.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0, 95.0, 96.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 53.0, 52.0, 63.0, 53.0, 52.0, 53.0, 52.0, 52.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 61.0, 60.0, 60.0, 60.0, 60.0, 62.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 80.0, 90.0, 87.0, 79.0, 80.0, 80.0, 79.0, 79.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 124.0, 132.0, 124.0, 143.0, 134.0, 126.0, 132.0, 167.0, 139.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 163.0, 161.0, 162.0, 162.0, 166.0, 164.0, 162.0, 170.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 64.0, 64.0, 64.0, 70.0, 64.0, 64.0, 65.0], "value": 65.0, "unit": "score"}]}]} 17:41:43 INFO - Return code: 0 17:41:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:41:43 ERROR - # TBPL SUCCESS # 17:41:43 INFO - Running post-action listener: _resource_record_post_action 17:41:43 INFO - [mozharness: 2016-09-24 00:41:43.643429Z] Finished run-tests step (success) 17:41:43 INFO - Running post-run listener: _resource_record_post_run 17:41:43 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392482816; Read time: 16; Write time: 249668 17:41:43 INFO - TinderboxPrint: CPU usage
13.3% 17:41:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:41:43 INFO - TinderboxPrint: I/O write bytes / time
392,482,816 / 249,668 17:41:43 INFO - TinderboxPrint: CPU idle
8,246.1 (86.7%) 17:41:43 INFO - TinderboxPrint: CPU user
1,206.9 (12.7%) 17:41:43 INFO - TinderboxPrint: Swap in / out
0 / 0 17:41:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103718912; Read time: 0; Write time: 78352 17:41:43 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 288763904; Read time: 0; Write time: 171316 17:41:44 INFO - Running post-run listener: _upload_blobber_files 17:41:44 INFO - Blob upload gear active. 17:41:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:41:44 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 17:41:44 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:41:44 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:41:44 INFO - (blobuploader) - INFO - Open directory for files ... 17:41:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:41:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:41:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:41:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:41:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:41:45 INFO - (blobuploader) - INFO - Done attempting. 17:41:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:41:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:41:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:41:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:41:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:41:49 INFO - (blobuploader) - INFO - Done attempting. 17:41:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:41:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:41:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:41:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:41:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:41:50 INFO - (blobuploader) - INFO - Done attempting. 17:41:50 INFO - (blobuploader) - INFO - Iteration through files over. 17:41:50 INFO - Return code: 0 17:41:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:41:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:41:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b4c46f0f82e5dd41e850e6ad0876a061d367e2c9d961a863fadda3bbb0a233bb6c6620e5b4cb193706191cb77183657917d8cb5d51e16705470375d989ed7d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4698c701bcd4ff553e8880803764cfee7e4d3600729d2efc0eb40745c21b29a1a13d72946572a64d367df600925adcdcba9aa72a4e755e712b34e30bb760ad82", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b26b9944afb356fd83e5e525821c0bc4ebe37608f5024c856a2070a4c51257a992e128b1761d0500fec154f3839eb4bb56cd8b2d7dcb77a7f81e3e641f40eb0"} 17:41:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:41:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:41:50 INFO - Contents: 17:41:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b4c46f0f82e5dd41e850e6ad0876a061d367e2c9d961a863fadda3bbb0a233bb6c6620e5b4cb193706191cb77183657917d8cb5d51e16705470375d989ed7d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4698c701bcd4ff553e8880803764cfee7e4d3600729d2efc0eb40745c21b29a1a13d72946572a64d367df600925adcdcba9aa72a4e755e712b34e30bb760ad82", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b26b9944afb356fd83e5e525821c0bc4ebe37608f5024c856a2070a4c51257a992e128b1761d0500fec154f3839eb4bb56cd8b2d7dcb77a7f81e3e641f40eb0"} 17:41:50 INFO - Running post-run listener: copy_logs_to_upload_dir 17:41:50 INFO - Copying logs to upload dir... 17:41:50 INFO - mkdir: /builds/slave/test/build/upload/logs 17:41:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.566212 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-23 17:41:49.750858) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 17:41:49.754026) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b4c46f0f82e5dd41e850e6ad0876a061d367e2c9d961a863fadda3bbb0a233bb6c6620e5b4cb193706191cb77183657917d8cb5d51e16705470375d989ed7d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4698c701bcd4ff553e8880803764cfee7e4d3600729d2efc0eb40745c21b29a1a13d72946572a64d367df600925adcdcba9aa72a4e755e712b34e30bb760ad82", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b26b9944afb356fd83e5e525821c0bc4ebe37608f5024c856a2070a4c51257a992e128b1761d0500fec154f3839eb4bb56cd8b2d7dcb77a7f81e3e641f40eb0"} build_url:https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011476 build_url: 'https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b4c46f0f82e5dd41e850e6ad0876a061d367e2c9d961a863fadda3bbb0a233bb6c6620e5b4cb193706191cb77183657917d8cb5d51e16705470375d989ed7d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4698c701bcd4ff553e8880803764cfee7e4d3600729d2efc0eb40745c21b29a1a13d72946572a64d367df600925adcdcba9aa72a4e755e712b34e30bb760ad82", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3b26b9944afb356fd83e5e525821c0bc4ebe37608f5024c856a2070a4c51257a992e128b1761d0500fec154f3839eb4bb56cd8b2d7dcb77a7f81e3e641f40eb0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 17:41:49.778950) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:41:49.779256) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1474676392.722588-1498333977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:41:49.862427) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 17:41:49.862752) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 17:41:49.863042) ========= ========= Total master_lag: 0.16 =========