builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1474677034.16 results: success (0) buildid: 20160923153005 builduid: 54d00c2fd1c84cc79c913eb78d62c3c7 revision: 92d96352192c049c6c3c66e61f3d3c8f4545aaab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 17:30:34.162504) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 17:30:34.163452) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 17:30:34.164262) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 17:30:34.202449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:30:34.202739) ========= 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=20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-23 17:30:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-09-23 17:30:34 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.405841 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:30:34.622300) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:30:34.622618) ========= 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=20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017258 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:30:34.671819) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:30:34.672184) ========= 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=20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-23 17:30:34,961 truncating revision to first 12 chars 2016-09-23 17:30:34,961 Setting DEBUG logging. 2016-09-23 17:30:34,961 attempt 1/10 2016-09-23 17:30:34,961 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:30:35,261 unpacking tar archive at: fx-team-92d96352192c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619518 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:30:35.307835) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 17:30:35.308098) ========= script_repo_revision: 92d96352192c049c6c3c66e61f3d3c8f4545aaab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 17:30:35.308475) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 17:30:35.308733) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 17:30:35.327178) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-09-23 17:30:35.327438) ========= /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=20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:30:35 INFO - MultiFileLogger online at 20160923 17:30:35 in /builds/slave/test 17:30:35 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:30:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:30:35 INFO - {'append_to_log': False, 17:30:35 INFO - 'base_work_dir': '/builds/slave/test', 17:30:35 INFO - 'blob_upload_branch': 'Fx-Team', 17:30:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:30:35 INFO - 'branch': 'Fx-Team', 17:30:35 INFO - 'buildbot_json_path': 'buildprops.json', 17:30:35 INFO - 'config_files': ('talos/linux_config.py',), 17:30:35 INFO - 'default_actions': ('clobber', 17:30:35 INFO - 'read-buildbot-config', 17:30:35 INFO - 'download-and-extract', 17:30:35 INFO - 'populate-webroot', 17:30:35 INFO - 'create-virtualenv', 17:30:35 INFO - 'install', 17:30:35 INFO - 'run-tests'), 17:30:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:30:35 INFO - 'download_minidump_stackwalk': True, 17:30:35 INFO - 'download_symbols': 'ondemand', 17:30:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:30:35 INFO - 'tooltool.py': '/tools/tooltool.py', 17:30:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:30:35 INFO - '/tools/misc-python/virtualenv.py')}, 17:30:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:30:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:30:35 INFO - 'installer_path': 'installer.exe', 17:30:35 INFO - 'log_level': 'info', 17:30:35 INFO - 'log_name': 'talos', 17:30:35 INFO - 'log_to_console': True, 17:30:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:30:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:30:35 INFO - 'opt_config_files': (), 17:30:35 INFO - 'pip_index': False, 17:30:35 INFO - 'sps_profile': False, 17:30:35 INFO - 'sps_profile_interval': 0, 17:30:35 INFO - 'suite': 'dromaeojs-e10s', 17:30:35 INFO - 'system_bits': '32', 17:30:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:30:35 INFO - 'title': 'talos-linux64-ix-015', 17:30:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:30:35 INFO - 'use_talos_json': True, 17:30:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:30:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:30:35 INFO - 'work_dir': 'build'} 17:30:35 INFO - [mozharness: 2016-09-24 00:30:35.717880Z] Running clobber step. 17:30:35 INFO - Running pre-action listener: _resource_record_pre_action 17:30:35 INFO - Running main action method: clobber 17:30:35 INFO - rmtree: /builds/slave/test/build 17:30:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:30:36 INFO - Running post-action listener: _resource_record_post_action 17:30:36 INFO - [mozharness: 2016-09-24 00:30:36.690868Z] Finished clobber step (success) 17:30:36 INFO - [mozharness: 2016-09-24 00:30:36.690969Z] Running read-buildbot-config step. 17:30:36 INFO - Running pre-action listener: _resource_record_pre_action 17:30:36 INFO - Running main action method: read_buildbot_config 17:30:36 INFO - Using buildbot properties: 17:30:36 INFO - { 17:30:36 INFO - "project": "", 17:30:36 INFO - "product": "firefox", 17:30:36 INFO - "script_repo_revision": "production", 17:30:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:30:36 INFO - "repository": "", 17:30:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:30:36 INFO - "buildid": "20160923153005", 17:30:36 INFO - "pgo_build": "True", 17:30:36 INFO - "basedir": "/builds/slave/test", 17:30:36 INFO - "buildnumber": 767, 17:30:36 INFO - "slavename": "talos-linux64-ix-015", 17:30:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:30:36 INFO - "platform": "ubuntu64_hw", 17:30:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:30:36 INFO - "branch": "fx-team", 17:30:36 INFO - "repo_path": "integration/fx-team", 17:30:36 INFO - "revision": "92d96352192c049c6c3c66e61f3d3c8f4545aaab", 17:30:36 INFO - "stage_platform": "linux64-pgo", 17:30:36 INFO - "builduid": "54d00c2fd1c84cc79c913eb78d62c3c7", 17:30:36 INFO - "slavebuilddir": "test" 17:30:36 INFO - } 17:30:36 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:30:36 INFO - Running post-action listener: _resource_record_post_action 17:30:36 INFO - [mozharness: 2016-09-24 00:30:36.693443Z] Finished read-buildbot-config step (success) 17:30:36 INFO - [mozharness: 2016-09-24 00:30:36.693532Z] Running download-and-extract step. 17:30:36 INFO - Running pre-action listener: _resource_record_pre_action 17:30:36 INFO - Running main action method: download_and_extract 17:30:36 INFO - mkdir: /builds/slave/test/build/tests 17:30: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:30:36 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:30:36 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:30:36 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:30:37 INFO - Downloaded 1361 bytes. 17:30:37 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:30:37 INFO - Using the following test package requirements: 17:30:37 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:30:37 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:30:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:30:37 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:30:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:30:37 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:30:37 INFO - u'jsshell-linux-x86_64.zip'], 17:30:37 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:30:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:30:37 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:30:37 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:30:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:30:37 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:30:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:30:37 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:30:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:30:37 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:30:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:30:37 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:30:37 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:30:37 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:30:37 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:30:37 INFO - Expected file size: 21948401 17:30:42 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:30:42 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:30:42 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:30:42 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:30:42 INFO - Expected file size: 21948401 17:30:47 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:30:47 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:30:47 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:30:48 INFO - Expected file size: 14414059 17:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:48 INFO - trying https://queue.taskcluster.net/v1/task/DALlG2H-RT6i7pBfyonGtw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:30:48 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:30:48 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:30:50 INFO - Downloaded 59685593 bytes. 17:30:50 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:30:50 INFO - mkdir: /builds/slave/test/properties 17:30:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:30:50 INFO - Writing to file /builds/slave/test/properties/build_url 17:30:50 INFO - Contents: 17:30:50 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:30:51 INFO - Running post-action listener: _resource_record_post_action 17:30:51 INFO - Running post-action listener: set_extra_try_arguments 17:30:51 INFO - [mozharness: 2016-09-24 00:30:51.071095Z] Finished download-and-extract step (success) 17:30:51 INFO - [mozharness: 2016-09-24 00:30:51.071323Z] Running populate-webroot step. 17:30:51 INFO - Running pre-action listener: _resource_record_pre_action 17:30:51 INFO - Running main action method: populate_webroot 17:30:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:30:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:30:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:30:51 INFO - '--tppagecycles', 17:30:51 INFO - '7'], 17:30:51 INFO - 'tests': ['tsvgm']}}, 17:30:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:30:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:30:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:30:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:30:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:30:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:30:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:30:51 INFO - 'talos_options': ['--disable-e10s'], 17:30:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:30:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:30:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:30:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:30:51 INFO - 'talos_options': ['--disable-e10s'], 17:30:51 INFO - 'tests': ['damp', 'tps']}, 17:30:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:30:51 INFO - 'tests': ['damp', 'tps']}, 17:30:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:30:51 INFO - 'tests': ['dromaeo_dom']}, 17:30:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:30:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:30:51 INFO - 'tests': ['basic_compositor_video']}, 17:30:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:30:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:30:51 INFO - 'tests': ['a11yr', 17:30:51 INFO - 'ts_paint', 17:30:51 INFO - 'tpaint', 17:30:51 INFO - 'sessionrestore', 17:30:51 INFO - 'sessionrestore_no_auto_restore', 17:30:51 INFO - 'tabpaint']}, 17:30:51 INFO - 'other-e10s': {'tests': ['a11yr', 17:30:51 INFO - 'ts_paint', 17:30:51 INFO - 'tpaint', 17:30:51 INFO - 'sessionrestore', 17:30:51 INFO - 'sessionrestore_no_auto_restore', 17:30:51 INFO - 'tabpaint']}, 17:30:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:30:51 INFO - 'ts_paint', 17:30:51 INFO - 'tpaint', 17:30:51 INFO - 'sessionrestore', 17:30:51 INFO - 'sessionrestore_no_auto_restore', 17:30:51 INFO - 'tabpaint']}, 17:30:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:30:51 INFO - 'ts_paint', 17:30:51 INFO - 'tpaint', 17:30:51 INFO - 'sessionrestore', 17:30:51 INFO - 'sessionrestore_no_auto_restore', 17:30:51 INFO - 'tabpaint']}, 17:30:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:30:51 INFO - 'tests': ['a11yr', 17:30:51 INFO - 'ts_paint', 17:30:51 INFO - 'tpaint', 17:30:51 INFO - 'sessionrestore', 17:30:51 INFO - 'sessionrestore_no_auto_restore', 17:30:51 INFO - 'tabpaint']}, 17:30:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:30:51 INFO - 'tests': ['a11yr', 17:30:51 INFO - 'ts_paint', 17:30:51 INFO - 'tpaint', 17:30:51 INFO - 'sessionrestore', 17:30:51 INFO - 'sessionrestore_no_auto_restore', 17:30:51 INFO - 'tabpaint']}, 17:30:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:30:51 INFO - 'tests': ['tsvgx', 17:30:51 INFO - 'tsvgr_opacity', 17:30:51 INFO - 'tart', 17:30:51 INFO - 'tscrollx', 17:30:51 INFO - 'cart']}, 17:30:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:30:51 INFO - 'tsvgr_opacity', 17:30:51 INFO - 'tart', 17:30:51 INFO - 'tscrollx', 17:30:51 INFO - 'cart']}, 17:30:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:30:51 INFO - 'talos_options': ['--disable-e10s'], 17:30:51 INFO - 'tests': ['tp5o']}, 17:30:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:30:51 INFO - 'tests': ['tp5o']}, 17:30:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:30:51 INFO - 'talos_options': ['--disable-e10s', 17:30:51 INFO - '--xperf_path', 17:30:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:30:51 INFO - 'tests': ['tp5n']}, 17:30:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:30:51 INFO - 'talos_options': ['--xperf_path', 17:30:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:30:51 INFO - 'tests': ['tp5n']}}, 17:30:51 INFO - 'talos.zip': {'path': '', 17:30:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:30:51 INFO - Running post-action listener: _resource_record_post_action 17:30:51 INFO - [mozharness: 2016-09-24 00:30:51.095339Z] Finished populate-webroot step (success) 17:30:51 INFO - [mozharness: 2016-09-24 00:30:51.095429Z] Running create-virtualenv step. 17:30:51 INFO - Running pre-action listener: _resource_record_pre_action 17:30:51 INFO - Running main action method: create_virtualenv 17:30:51 INFO - Creating virtualenv /builds/slave/test/build/venv 17:30:51 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:30:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:30:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:30:51 INFO - Using real prefix '/usr' 17:30:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:30:51 INFO - Installing distribute.............................................................................................................................................................................................done. 17:30:53 INFO - Installing pip.................done. 17:30:53 INFO - Return code: 0 17:30:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:30:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c13d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2599790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596930>, '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 0x2597830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', '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:30:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:30:53 INFO - Using env: {'DISPLAY': ':0', 17:30:53 INFO - 'HOME': '/home/cltbld', 17:30:53 INFO - 'LANG': 'en_US.UTF-8', 17:30:53 INFO - 'LANGUAGE': 'en_US:en', 17:30:53 INFO - 'LOGNAME': 'cltbld', 17:30:53 INFO - 'MAIL': '/var/mail/cltbld', 17:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:53 INFO - 'MOZ_NO_REMOTE': '1', 17:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:53 INFO - 'NO_EM_RESTART': '1', 17:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:53 INFO - 'PWD': '/builds/slave/test', 17:30:53 INFO - 'SHELL': '/bin/bash', 17:30:53 INFO - 'SHLVL': '1', 17:30:53 INFO - 'TERM': 'linux', 17:30:53 INFO - 'TMOUT': '86400', 17:30:53 INFO - 'USER': 'cltbld', 17:30:53 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', 17:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:53 INFO - '_': '/tools/buildbot/bin/python'} 17:30:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:53 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:30:53 INFO - Cleaning up... 17:30:53 INFO - Return code: 0 17:30:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:30:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe3c13d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2599790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596930>, '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 0x2597830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', '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:30:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:30:53 INFO - Using env: {'DISPLAY': ':0', 17:30:53 INFO - 'HOME': '/home/cltbld', 17:30:53 INFO - 'LANG': 'en_US.UTF-8', 17:30:53 INFO - 'LANGUAGE': 'en_US:en', 17:30:53 INFO - 'LOGNAME': 'cltbld', 17:30:53 INFO - 'MAIL': '/var/mail/cltbld', 17:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:53 INFO - 'MOZ_NO_REMOTE': '1', 17:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:53 INFO - 'NO_EM_RESTART': '1', 17:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:53 INFO - 'PWD': '/builds/slave/test', 17:30:53 INFO - 'SHELL': '/bin/bash', 17:30:53 INFO - 'SHLVL': '1', 17:30:53 INFO - 'TERM': 'linux', 17:30:53 INFO - 'TMOUT': '86400', 17:30:53 INFO - 'USER': 'cltbld', 17:30:53 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', 17:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:53 INFO - '_': '/tools/buildbot/bin/python'} 17:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:54 INFO - Downloading/unpacking psutil>=3.1.1 17:30:54 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:30:54 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:30:54 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:30:54 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:30:54 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:30:54 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:30:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:30:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:30:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:30:56 INFO - Installing collected packages: psutil 17:30:56 INFO - Running setup.py install for psutil 17:30:56 INFO - building 'psutil._psutil_linux' extension 17:30:56 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:30:56 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:30:56 INFO - building 'psutil._psutil_posix' extension 17:30:56 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:30:56 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:30:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:30:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:30:56 INFO - Successfully installed psutil 17:30:56 INFO - Cleaning up... 17:30:56 INFO - Return code: 0 17:30:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:30:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c13d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2599790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596930>, '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 0x2597830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', '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:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:30:56 INFO - Using env: {'DISPLAY': ':0', 17:30:56 INFO - 'HOME': '/home/cltbld', 17:30:56 INFO - 'LANG': 'en_US.UTF-8', 17:30:56 INFO - 'LANGUAGE': 'en_US:en', 17:30:56 INFO - 'LOGNAME': 'cltbld', 17:30:56 INFO - 'MAIL': '/var/mail/cltbld', 17:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:56 INFO - 'MOZ_NO_REMOTE': '1', 17:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:56 INFO - 'NO_EM_RESTART': '1', 17:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:56 INFO - 'PWD': '/builds/slave/test', 17:30:56 INFO - 'SHELL': '/bin/bash', 17:30:56 INFO - 'SHLVL': '1', 17:30:56 INFO - 'TERM': 'linux', 17:30:56 INFO - 'TMOUT': '86400', 17:30:56 INFO - 'USER': 'cltbld', 17:30:56 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', 17:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:56 INFO - '_': '/tools/buildbot/bin/python'} 17:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:30:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:30:58 INFO - Installing collected packages: mozsystemmonitor 17:30:58 INFO - Running setup.py install for mozsystemmonitor 17:30:58 INFO - Successfully installed mozsystemmonitor 17:30:58 INFO - Cleaning up... 17:30:58 INFO - Return code: 0 17:30:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:30:58 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 0x7fe3c13d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2599790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596930>, '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 0x2597830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', '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:30:58 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:30:58 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:30:58 INFO - Using env: {'DISPLAY': ':0', 17:30:58 INFO - 'HOME': '/home/cltbld', 17:30:58 INFO - 'LANG': 'en_US.UTF-8', 17:30:58 INFO - 'LANGUAGE': 'en_US:en', 17:30:58 INFO - 'LOGNAME': 'cltbld', 17:30:58 INFO - 'MAIL': '/var/mail/cltbld', 17:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:58 INFO - 'MOZ_NO_REMOTE': '1', 17:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:58 INFO - 'NO_EM_RESTART': '1', 17:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:58 INFO - 'PWD': '/builds/slave/test', 17:30:58 INFO - 'SHELL': '/bin/bash', 17:30:58 INFO - 'SHLVL': '1', 17:30:58 INFO - 'TERM': 'linux', 17:30:58 INFO - 'TMOUT': '86400', 17:30:58 INFO - 'USER': 'cltbld', 17:30:58 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', 17:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:58 INFO - '_': '/tools/buildbot/bin/python'} 17:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:30:59 INFO - Downloading/unpacking jsonschema==2.5.1 17:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:30:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:30:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:31:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:31:01 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:31:01 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:31:01 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:31:01 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:31:01 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:31:01 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:31:01 INFO - Downloading functools32-3.2.3-2.tar.gz 17:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:31:01 INFO - warning: no files found matching '*.txt' 17:31:01 INFO - no previously-included directories found matching 'build' 17:31:01 INFO - no previously-included directories found matching 'dist' 17:31:01 INFO - no previously-included directories found matching '.git*' 17:31:01 INFO - Installing collected packages: jsonschema, functools32 17:31:01 INFO - Running setup.py install for functools32 17:31:01 INFO - warning: no files found matching '*.txt' 17:31:01 INFO - no previously-included directories found matching 'build' 17:31:01 INFO - no previously-included directories found matching 'dist' 17:31:01 INFO - no previously-included directories found matching '.git*' 17:31:01 INFO - Successfully installed jsonschema functools32 17:31:01 INFO - Cleaning up... 17:31:01 INFO - Return code: 0 17:31:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:31:01 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:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:01 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:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:01 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 0x7fe3c13d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2599790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596930>, '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 0x2597830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', '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:31:01 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:31:01 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:31:01 INFO - Using env: {'DISPLAY': ':0', 17:31:01 INFO - 'HOME': '/home/cltbld', 17:31:01 INFO - 'LANG': 'en_US.UTF-8', 17:31:01 INFO - 'LANGUAGE': 'en_US:en', 17:31:01 INFO - 'LOGNAME': 'cltbld', 17:31:01 INFO - 'MAIL': '/var/mail/cltbld', 17:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:01 INFO - 'MOZ_NO_REMOTE': '1', 17:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:01 INFO - 'NO_EM_RESTART': '1', 17:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:01 INFO - 'PWD': '/builds/slave/test', 17:31:01 INFO - 'SHELL': '/bin/bash', 17:31:01 INFO - 'SHLVL': '1', 17:31:01 INFO - 'TERM': 'linux', 17:31:01 INFO - 'TMOUT': '86400', 17:31:01 INFO - 'USER': 'cltbld', 17:31:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', 17:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:01 INFO - '_': '/tools/buildbot/bin/python'} 17:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:31:01 INFO - Cleaning up... 17:31:01 INFO - Return code: 0 17:31:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:31:01 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:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:01 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:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:01 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 0x7fe3c13d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2599790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596930>, '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 0x2597830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', '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:31:01 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:31:01 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:31:01 INFO - Using env: {'DISPLAY': ':0', 17:31:01 INFO - 'HOME': '/home/cltbld', 17:31:01 INFO - 'LANG': 'en_US.UTF-8', 17:31:01 INFO - 'LANGUAGE': 'en_US:en', 17:31:01 INFO - 'LOGNAME': 'cltbld', 17:31:01 INFO - 'MAIL': '/var/mail/cltbld', 17:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:01 INFO - 'MOZ_NO_REMOTE': '1', 17:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:01 INFO - 'NO_EM_RESTART': '1', 17:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:01 INFO - 'PWD': '/builds/slave/test', 17:31:01 INFO - 'SHELL': '/bin/bash', 17:31:01 INFO - 'SHLVL': '1', 17:31:01 INFO - 'TERM': 'linux', 17:31:01 INFO - 'TMOUT': '86400', 17:31:01 INFO - 'USER': 'cltbld', 17:31:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', 17:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:01 INFO - '_': '/tools/buildbot/bin/python'} 17:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:01 INFO - Downloading/unpacking blobuploader==1.2.4 17:31:01 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:31:01 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:31:01 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:31:01 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:31:01 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:31:01 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:31:03 INFO - Downloading blobuploader-1.2.4.tar.gz 17:31:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:31:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:31:03 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:31:03 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:31:03 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:31:03 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:31:03 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:31:03 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:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:31:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:04 INFO - Downloading docopt-0.6.1.tar.gz 17:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:31:04 INFO - Installing collected packages: blobuploader, requests, docopt 17:31:04 INFO - Running setup.py install for blobuploader 17:31:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:31:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:31:04 INFO - Running setup.py install for requests 17:31:05 INFO - Running setup.py install for docopt 17:31:05 INFO - Successfully installed blobuploader requests docopt 17:31:05 INFO - Cleaning up... 17:31:05 INFO - Return code: 0 17:31:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:31:05 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:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:05 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:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:05 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 0x7fe3c13d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2599790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596930>, '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 0x2597830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', '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:31:05 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:31:05 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:31:05 INFO - Using env: {'DISPLAY': ':0', 17:31:05 INFO - 'HOME': '/home/cltbld', 17:31:05 INFO - 'LANG': 'en_US.UTF-8', 17:31:05 INFO - 'LANGUAGE': 'en_US:en', 17:31:05 INFO - 'LOGNAME': 'cltbld', 17:31:05 INFO - 'MAIL': '/var/mail/cltbld', 17:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:05 INFO - 'MOZ_NO_REMOTE': '1', 17:31:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:05 INFO - 'NO_EM_RESTART': '1', 17:31:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:05 INFO - 'PWD': '/builds/slave/test', 17:31:05 INFO - 'SHELL': '/bin/bash', 17:31:05 INFO - 'SHLVL': '1', 17:31:05 INFO - 'TERM': 'linux', 17:31:05 INFO - 'TMOUT': '86400', 17:31:05 INFO - 'USER': 'cltbld', 17:31:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', 17:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:05 INFO - '_': '/tools/buildbot/bin/python'} 17:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:31:05 INFO - Running setup.py (path:/tmp/pip-uXa0nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:31:05 INFO - Running setup.py (path:/tmp/pip-_sAwgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:31:05 INFO - Running setup.py (path:/tmp/pip-SxLc1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:31:05 INFO - Running setup.py (path:/tmp/pip-APJGGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:31:05 INFO - Running setup.py (path:/tmp/pip-iotdFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:31:05 INFO - Running setup.py (path:/tmp/pip-hC_WxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:31:05 INFO - Running setup.py (path:/tmp/pip-q19ysa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:31:05 INFO - Running setup.py (path:/tmp/pip-HJ83xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:31:06 INFO - Running setup.py (path:/tmp/pip-3jGV15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:31:06 INFO - Running setup.py (path:/tmp/pip-9Ko4Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:31:06 INFO - Running setup.py (path:/tmp/pip-THsn4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:31:06 INFO - Running setup.py (path:/tmp/pip-MI8Lbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:31:06 INFO - Running setup.py (path:/tmp/pip-IYd7jG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:31:06 INFO - Running setup.py (path:/tmp/pip-u855L2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:06 INFO - Running setup.py (path:/tmp/pip-uUcHIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:31:06 INFO - Running setup.py (path:/tmp/pip-jL5kao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:31:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:31:06 INFO - Running setup.py (path:/tmp/pip-H3PTTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:31:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:31:06 INFO - Running setup.py install for manifestparser 17:31:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:31:06 INFO - Running setup.py install for mozcrash 17:31:06 INFO - Running setup.py install for mozdebug 17:31:06 INFO - Running setup.py install for mozdevice 17:31:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:31:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:31:07 INFO - Running setup.py install for mozfile 17:31:07 INFO - Running setup.py install for mozhttpd 17:31:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:31:07 INFO - Running setup.py install for mozinfo 17:31:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:31:07 INFO - Running setup.py install for mozInstall 17:31:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:31:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:31:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:31:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:31:07 INFO - Running setup.py install for mozleak 17:31:07 INFO - Running setup.py install for mozlog 17:31:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:31:07 INFO - Running setup.py install for moznetwork 17:31:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:31:07 INFO - Running setup.py install for mozprocess 17:31:07 INFO - Running setup.py install for mozprofile 17:31:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:31:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:31:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:31:08 INFO - Running setup.py install for mozrunner 17:31:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:31:08 INFO - Running setup.py install for mozscreenshot 17:31:08 INFO - Running setup.py install for moztest 17:31:08 INFO - Running setup.py install for mozversion 17:31:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:31:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:31:08 INFO - Cleaning up... 17:31:08 INFO - Return code: 0 17:31:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:31:08 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:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:08 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:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:08 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 0x7fe3c13d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2599790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596930>, '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 0x2597830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', '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:31:08 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:31:08 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:31:08 INFO - Using env: {'DISPLAY': ':0', 17:31:08 INFO - 'HOME': '/home/cltbld', 17:31:08 INFO - 'LANG': 'en_US.UTF-8', 17:31:08 INFO - 'LANGUAGE': 'en_US:en', 17:31:08 INFO - 'LOGNAME': 'cltbld', 17:31:08 INFO - 'MAIL': '/var/mail/cltbld', 17:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:08 INFO - 'MOZ_NO_REMOTE': '1', 17:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:08 INFO - 'NO_EM_RESTART': '1', 17:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:08 INFO - 'PWD': '/builds/slave/test', 17:31:08 INFO - 'SHELL': '/bin/bash', 17:31:08 INFO - 'SHLVL': '1', 17:31:08 INFO - 'TERM': 'linux', 17:31:08 INFO - 'TMOUT': '86400', 17:31:08 INFO - 'USER': 'cltbld', 17:31:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', 17:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:08 INFO - '_': '/tools/buildbot/bin/python'} 17:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:31:08 INFO - Running setup.py (path:/tmp/pip-BXrXbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:31:08 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:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:31:08 INFO - Running setup.py (path:/tmp/pip-vl0Ne8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:31:08 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:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:31:08 INFO - Running setup.py (path:/tmp/pip-Oas4Z0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:31:08 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:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:31:08 INFO - Running setup.py (path:/tmp/pip-MY0zW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:31:08 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:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:31:08 INFO - Running setup.py (path:/tmp/pip-ALjQqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:31:09 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:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:31:09 INFO - Running setup.py (path:/tmp/pip-2wrZK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:31:09 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:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:31:09 INFO - Running setup.py (path:/tmp/pip-HNKjcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:31:09 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:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:31:09 INFO - Running setup.py (path:/tmp/pip-g8y7H3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:31:09 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:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:31:09 INFO - Running setup.py (path:/tmp/pip-TyjLUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:31:09 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:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:31:09 INFO - Running setup.py (path:/tmp/pip-iUTqwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:31:09 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:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:31:09 INFO - Running setup.py (path:/tmp/pip-utoDTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:31:09 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:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:31:09 INFO - Running setup.py (path:/tmp/pip-Ui7BTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:31:09 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:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:31:09 INFO - Running setup.py (path:/tmp/pip-8w27o5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:31:09 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:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:31:09 INFO - Running setup.py (path:/tmp/pip-CIgi6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:31:09 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:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:09 INFO - Running setup.py (path:/tmp/pip-nRR8Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:09 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:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:31:09 INFO - Running setup.py (path:/tmp/pip-sRS2VQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:31:09 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:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:31:09 INFO - Running setup.py (path:/tmp/pip-nIfzZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:31:09 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:31:09 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:31:09 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:31:09 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:31:09 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:31:09 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:31:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:31:09 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:31:09 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:31:09 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:31:09 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:31:09 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:31:09 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:31:11 INFO - Downloading blessings-1.6.tar.gz 17:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:31:11 INFO - Installing collected packages: blessings 17:31:11 INFO - Running setup.py install for blessings 17:31:11 INFO - Successfully installed blessings 17:31:11 INFO - Cleaning up... 17:31:12 INFO - Return code: 0 17:31:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:31:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:31:12 INFO - Reading from file tmpfile_stdout 17:31:12 INFO - Current package versions: 17:31:12 INFO - argparse == 1.2.1 17:31:12 INFO - blessings == 1.6 17:31:12 INFO - blobuploader == 1.2.4 17:31:12 INFO - docopt == 0.6.1 17:31:12 INFO - functools32 == 3.2.3-2 17:31:12 INFO - jsonschema == 2.5.1 17:31:12 INFO - manifestparser == 1.1 17:31:12 INFO - mozInstall == 1.12 17:31:12 INFO - mozcrash == 0.17 17:31:12 INFO - mozdebug == 0.1 17:31:12 INFO - mozdevice == 0.48 17:31:12 INFO - mozfile == 1.2 17:31:12 INFO - mozhttpd == 0.7 17:31:12 INFO - mozinfo == 0.9 17:31:12 INFO - mozleak == 0.1 17:31:12 INFO - mozlog == 3.4 17:31:12 INFO - moznetwork == 0.27 17:31:12 INFO - mozprocess == 0.23 17:31:12 INFO - mozprofile == 0.28 17:31:12 INFO - mozrunner == 6.12 17:31:12 INFO - mozscreenshot == 0.1 17:31:12 INFO - mozsystemmonitor == 0.3 17:31:12 INFO - moztest == 0.7 17:31:12 INFO - mozversion == 1.4 17:31:12 INFO - psutil == 3.1.1 17:31:12 INFO - requests == 1.2.3 17:31:12 INFO - wsgiref == 0.1.2 17:31:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:12 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 0x7fe3c13d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2599790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596930>, '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 0x2597830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', '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:31:12 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:31:12 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:31:12 INFO - Using env: {'DISPLAY': ':0', 17:31:12 INFO - 'HOME': '/home/cltbld', 17:31:12 INFO - 'LANG': 'en_US.UTF-8', 17:31:12 INFO - 'LANGUAGE': 'en_US:en', 17:31:12 INFO - 'LOGNAME': 'cltbld', 17:31:12 INFO - 'MAIL': '/var/mail/cltbld', 17:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:12 INFO - 'MOZ_NO_REMOTE': '1', 17:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:12 INFO - 'NO_EM_RESTART': '1', 17:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:12 INFO - 'PWD': '/builds/slave/test', 17:31:12 INFO - 'SHELL': '/bin/bash', 17:31:12 INFO - 'SHLVL': '1', 17:31:12 INFO - 'TERM': 'linux', 17:31:12 INFO - 'TMOUT': '86400', 17:31:12 INFO - 'USER': 'cltbld', 17:31:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', 17:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:12 INFO - '_': '/tools/buildbot/bin/python'} 17:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:12 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:31:12 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:31:12 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:31:12 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:31:12 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:31:12 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:31:12 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:31:12 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:31:12 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:31:12 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:31:12 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:31:12 INFO - Cleaning up... 17:31:12 INFO - Return code: 0 17:31:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:12 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 0x7fe3c13d4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2599790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2596930>, '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 0x2597830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597cc0>, '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': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', '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:31:12 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:31:12 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:31:12 INFO - Using env: {'DISPLAY': ':0', 17:31:12 INFO - 'HOME': '/home/cltbld', 17:31:12 INFO - 'LANG': 'en_US.UTF-8', 17:31:12 INFO - 'LANGUAGE': 'en_US:en', 17:31:12 INFO - 'LOGNAME': 'cltbld', 17:31:12 INFO - 'MAIL': '/var/mail/cltbld', 17:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:12 INFO - 'MOZ_NO_REMOTE': '1', 17:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:12 INFO - 'NO_EM_RESTART': '1', 17:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:12 INFO - 'PWD': '/builds/slave/test', 17:31:12 INFO - 'SHELL': '/bin/bash', 17:31:12 INFO - 'SHLVL': '1', 17:31:12 INFO - 'TERM': 'linux', 17:31:12 INFO - 'TMOUT': '86400', 17:31:12 INFO - 'USER': 'cltbld', 17:31:12 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', 17:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:12 INFO - '_': '/tools/buildbot/bin/python'} 17:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:31:12 INFO - Cleaning up... 17:31:12 INFO - Return code: 0 17:31:12 INFO - Running post-action listener: _resource_record_post_action 17:31:12 INFO - Running post-action listener: _start_resource_monitoring 17:31:12 INFO - Starting resource monitoring. 17:31:12 INFO - [mozharness: 2016-09-24 00:31:12.751676Z] Finished create-virtualenv step (success) 17:31:12 INFO - [mozharness: 2016-09-24 00:31:12.752363Z] Running install step. 17:31:12 INFO - Running pre-action listener: _resource_record_pre_action 17:31:12 INFO - Running main action method: install 17:31:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:31:12 INFO - Reading from file tmpfile_stdout 17:31:12 INFO - Detecting whether we're running mozinstall >=1.0... 17:31:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:31:13 INFO - Reading from file tmpfile_stdout 17:31:13 INFO - Output received: 17:31:13 INFO - Usage: mozinstall [options] installer 17:31:13 INFO - Options: 17:31:13 INFO - -h, --help show this help message and exit 17:31:13 INFO - -d DEST, --destination=DEST 17:31:13 INFO - Directory to install application into. [default: 17:31:13 INFO - "/builds/slave/test"] 17:31:13 INFO - --app=APP Application being installed. [default: firefox] 17:31:13 INFO - mkdir: /builds/slave/test/build/application 17:31:13 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:31:13 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:31:30 INFO - Reading from file tmpfile_stdout 17:31:30 INFO - Output received: 17:31:30 INFO - /builds/slave/test/build/application/firefox/firefox 17:31:30 INFO - Running post-action listener: _resource_record_post_action 17:31:30 INFO - [mozharness: 2016-09-24 00:31:30.016898Z] Finished install step (success) 17:31:30 INFO - [mozharness: 2016-09-24 00:31:30.017144Z] Running run-tests step. 17:31:30 INFO - Running pre-action listener: _resource_record_pre_action 17:31:30 INFO - Running main action method: run_tests 17:31:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:31:30 INFO - Python 2.7.3 17:31:30 INFO - Return code: 0 17:31:30 INFO - grabbing minidump binary from tooltool 17:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:30 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 0x2596930>, '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 0x2597830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2597cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:31:30 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:31:30 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:31:30 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:31:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:31:30 INFO - Return code: 0 17:31:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:31:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:31:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:31:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:31:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:31:30 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-015', '--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:31:30 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-015 --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:31:30 INFO - Using env: {'DISPLAY': ':0', 17:31:30 INFO - 'HOME': '/home/cltbld', 17:31:30 INFO - 'LANG': 'en_US.UTF-8', 17:31:30 INFO - 'LANGUAGE': 'en_US:en', 17:31:30 INFO - 'LOGNAME': 'cltbld', 17:31:30 INFO - 'MAIL': '/var/mail/cltbld', 17:31:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:31:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:30 INFO - 'MOZ_NO_REMOTE': '1', 17:31:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:30 INFO - 'NO_EM_RESTART': '1', 17:31:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:30 INFO - 'PWD': '/builds/slave/test', 17:31:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:31:30 INFO - 'SHELL': '/bin/bash', 17:31:30 INFO - 'SHLVL': '1', 17:31:30 INFO - 'TERM': 'linux', 17:31:30 INFO - 'TMOUT': '86400', 17:31:30 INFO - 'USER': 'cltbld', 17:31:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660', 17:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:30 INFO - '_': '/tools/buildbot/bin/python'} 17:31:30 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-015', '--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:31:30 INFO - mozversion application_buildid: 20160923153005 17:31:30 INFO - mozversion application_changeset: 92d96352192c049c6c3c66e61f3d3c8f4545aaab 17:31:30 INFO - mozversion application_display_name: Nightly 17:31:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:31:30 INFO - mozversion application_name: Firefox 17:31:30 INFO - mozversion application_remotingname: firefox 17:31:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:31:30 INFO - mozversion application_vendor: Mozilla 17:31:30 INFO - mozversion application_version: 52.0a1 17:31:30 INFO - mozversion platform_buildid: 20160923153005 17:31:30 INFO - mozversion platform_changeset: 92d96352192c049c6c3c66e61f3d3c8f4545aaab 17:31:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:31:30 INFO - mozversion platform_version: 52.0a1 17:31:30 INFO - using testdate: 1474677090 17:31:30 INFO - actual date: 1474677090 17:31:30 INFO - starting webserver on 'localhost:53747' 17:31:30 INFO - SUITE-START | Running 2 tests 17:31:30 INFO - TEST-START | dromaeo_css 17:31:30 INFO - operating with platform_type : linux_ 17:31:30 INFO - Initialising browser for dromaeo_css test... 17:31:30 INFO - TEST-INFO | started process 30138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2vzzuN/profile http://localhost:53747/getInfo.html) 17:31:34 INFO - PROCESS | 30138 | __metrics Screen width/height:1600/1200 17:31:34 INFO - PROCESS | 30138 | colorDepth:24 17:31:34 INFO - PROCESS | 30138 | Browser inner width/height: 1024/697 17:31:34 INFO - PROCESS | 30138 | __metrics 17:31:35 ERROR - PROCESS | 30138 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 17:31:36 INFO - TEST-INFO | 30138: exit 0 17:31:36 INFO - Browser initialized. 17:31:36 INFO - Running cycle 1/1 for dromaeo_css test... 17:31:36 INFO - TEST-INFO | started process 30258 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2vzzuN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:31:48 INFO - PROCESS | 30258 | RSS: Main: 185135104 17:31:48 INFO - PROCESS | 30258 | 17:32:37 INFO - PROCESS | 30258 | 1474677157846 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:34:47 INFO - PROCESS | 30258 | Cycle 1(1): loaded http://localhost:53747/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53747/tests/dromaeo/cssquery-ext.html) 17:34:48 INFO - PROCESS | 30258 | RSS: Main: 199483392 17:34:48 INFO - PROCESS | 30258 | 17:37:50 INFO - PROCESS | 30258 | Cycle 1(1): loaded http://localhost:53747/tests/dromaeo/cssquery-ext.html (next: http://localhost:53747/tests/dromaeo/cssquery-jquery.html) 17:37:51 INFO - PROCESS | 30258 | RSS: Main: 196734976 17:37:51 INFO - PROCESS | 30258 | 17:40:53 INFO - PROCESS | 30258 | Cycle 1(1): loaded http://localhost:53747/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53747/tests/dromaeo/cssquery-mootools.html) 17:40:53 INFO - PROCESS | 30258 | RSS: Main: 198258688 17:40:53 INFO - PROCESS | 30258 | 17:43:55 INFO - PROCESS | 30258 | Cycle 1(1): loaded http://localhost:53747/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53747/tests/dromaeo/cssquery-prototype.html) 17:43:56 INFO - PROCESS | 30258 | RSS: Main: 195297280 17:43:56 INFO - PROCESS | 30258 | 17:46:58 INFO - PROCESS | 30258 | Cycle 1(1): loaded http://localhost:53747/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53747/tests/dromaeo/cssquery-yui.html) 17:46:59 INFO - PROCESS | 30258 | RSS: Main: 198684672 17:46:59 INFO - PROCESS | 30258 | 17:50:02 INFO - PROCESS | 30258 | Cycle 1(1): loaded http://localhost:53747/tests/dromaeo/cssquery-yui.html (next: http://localhost:53747/tests/dromaeo/cssquery-dojo.html) 17:50:02 INFO - PROCESS | 30258 | RSS: Main: 199405568 17:50:02 INFO - PROCESS | 30258 | 17:50:02 INFO - PROCESS | 30258 | __start_tp_report 17:50:02 INFO - PROCESS | 30258 | _x_x_mozilla_page_load 17:50:02 INFO - PROCESS | 30258 | _x_x_mozilla_page_load_details 17:50:02 INFO - PROCESS | 30258 | |i|pagename|runs| 17:50:02 INFO - PROCESS | 30258 | |0;dojo.html;3067.616547931509;3075.446419644466;3097.256658401983;3102.5811515445407;3113.57966674499;5313.707746073974;5320.14877619581;5401.6758994460315;5410.134378499436;5464.289642346489;5245.370555533332;5279;5296.205569164617;5335.146376579748;5341.839744807662;4786.353842231307;4855.635827312948;4888.087472090544;4934.555889969902;5019.4227663818765;4822.879428014293;4952.479989601076;4955.727434991074;4962.776675049631;5025.195968645017;4776.713397196145;4794.161021821167;4836.371271734687;4921.557059864612;4924.532169443897;4780.1873681474235;4856.514348565151;4861.805527778884;4903.215485522299;4920.532549407836;4804.063207674505;4810.6151507879285;4815.277708343777;4827.734474603895;4872.220444728861;5247.842564723064;5266.894662106774;5280.683159010472;5313.38896026958;5380.515753582157;5703.40114288002;5731.942680573183;5758.42415758425;5784.537237021028;5854.619449735754;5793.13103034544;5794.826155215308;5811.27359080115;5813.6221145625395;5825.359210486843;5204.297419848348;5401.972990135024;5406.810761623325;5409.215663728776;5409.918851217235;5709.314882214077;5777.768889244383;5814.883702325929;5824.475797178275;5927.229460170237;5610.13042978339;5614.691191984399;5623.859403514863;5629.887402252014;5631.8592035199445;5642.971785141131;5662.235598194274;5701.030824759718;5712.371639119693;5730.684812335278;5495.340559132929;5517.641353312102;5549.361823390281;5555.194496797942;5600.187972743929;5532.944670553324;5553.527950124204;5562.276904002454;5562.527185189223;5637.46444087811;4305.677074219446;4333.544977777351;4338.566143385636;4360.171567402183;4382.693211475166;3915.334393153171;3918.5101862267215;3922.7254092213843;3928.823202955874;3940.862069827542;5477.972610137003;5482.259894914216;5496.615236933376;5546.168074788733;5574.916376254359;5701;5732.3407808101765;5744.080947048536;5744.454276843693;5746.224259724967;5351.25082488452;5352.384475785257;5435.701036443033;5499.945000549943;5519.586031047687;4923;4962.03240368132;4969.35398398206;4977.875553111201;5015.348004759431;5953.613015154001;5962.850928726816;5966.642001479925;5974.103884417372;5974.850628734316;5566.554675625859;5595.440455954372;5760.884782304414;5768.682722450138;5786.218860453785;5750.568707347049;5761.049426844691;5775.711214439345;5801.274840644751;5853.09277062056;5470.589705772162;5501.504864562208;5521.641093328921;5532.585056120726;5534.335879694462;5579.414161512983;5580.86047848807;5631.831045068655;5636.267285252891;5651.858703532444;5479.287692600096;5567.47109024642;5613.045782216951;5631.915521267102;5712;5582.525485333792;5598.552115830806;5601.915971260353;5603.719814009365;5622.803201887914;5431.402545719889;5480.753366098615;5584.46947539983;5619.943800562106;5621.550275977994;5473.67157970523;5581.9162712560155;5612.747426365905;5642.153676948491;5697.6296540724725;5497.340319161726;5509.614326997072;5528.364238112507;5534.142207957773;5536.252605898152 17:50:02 INFO - PROCESS | 30258 | |1;ext.html;543.4236603921785;567.186087963772;585.2041223935449;590;603.1796756411281;42009.15981680364;43666.34500482487;43699.12601747963;47592.28611570821;47847.28229076558;44361.334579981325;44642;44643;44834.551654483446;44865.7756711216;8838.955805220965;8974.192322690957;9001.594928228245;9004.729858104267;9012.459252444842;8844.646214151426;8852.026277109513;8861.069587693297;8870.42342247752;8907.153820387086;8860.601272942733;8869.512176830272;8931.821363572724;8939.508327042011;8972.147645973622;8890.422122562046;8910;8922.910770892273;8924.286057115416;8956.507392093432;8785.604647790864;8829.955850220707;8848.60181291837;8855.955720221358;8883.644654213824;42953.14093718139;43292.78353608243;43299.56700433019;43306.350404743636;43379.56620433787;3396.2188696599674;3475.3396854597545;3686.926261474782;4026.0280484906098;4153.252414565377;31619.683803161905;32068.6793132068;32135.51796723051;32336.6766332336;32344.838275808706;4216.367544868263;4261.446012018418;4326.9567304326865;4348.326009468537;4446.977765111186;335884;338706;338826;339314;341738;58471;58852.11721824176;58956.11565826516;59008.40991590115;59102;36880.26239475195;37655.4351684725;61202;61589.38410615926;61743;16035.679286414439;16460.42388516396;16503.83496165047;16528.586785330463;16553.172341382884;12482.687932801753;12632;12642.873571264354;12649.177803442746;12677.873221267853;19371.309085671295;19481.565445650853;19499.499897989175;19530.891764189728;19536.804631953783;7135.965285033641;7166.462515311373;7185.389241914496;7197.676104575306;7277.9272207277245;892.4020905993;1022.5602990713916;1028.3469996552244;1041.8489319048695;1052.9578816847393;31307.843460783006;31715;31821.363572728416;32061.747959148208;32647.020589382355;1004.9849252261222;1025.410389026313;1040.432964034603;1072.8498010278568;1121.820508718601;16178.514644560682;16601.584960376087;16683.24825893288;16748.916255418644;17005.404810831562;579739;583462;583772.973621584;583803;584155;59179;59311;59817;59876;59961.40038599646;1262.8926541243914;1282.179405180685;1294.5080869269618;1295.0351987769172;1302.426932149851;29907.319803642535;31241;31511.684883150876;31901.840490798328;32693;52106.35255532228;52501.21248181204;52661.7366913163;52736.73631631817;52765.20852187297;471593;472064;474558;476617;476727;28866.567001495416;29040.41919161647;43138.352924706785;44150.779246103564;44234.33648495211;42802.35796462993;47474.762626186646;47794.52205477901;48067.519324807705;49137.26294105663;40458.595414045485;42553.787231063645;42667.5733242676;43374.78312608543;43451;42684;42957.785211073744;43115.56884431116;43765.34351984659;44146.558534415526;32785.34429311353;38532.42201367038;41935.1612967745;42905;45199.774001131096;36383.636163638024;38580;38723.806380967915;39261.607383925795;39320.41019384769;28842;28859;28945.42109157847;29140.562891557067;29436.705632943398 17:50:02 INFO - PROCESS | 30258 | |2;jquery.html;389.51505375807125;391.46955874789677;393.2351576184322;395.4858683711175;413.09738221984964;14010.579682609512;18041.81958180418;18574.535636609093;19432.708509372354;19657.705134422995;17266.82733172668;17422.3902163424;17528.123593820288;18498.167582458787;18723;5668.801591944272;5740.052891272935;5758.884822303551;5779.104238842986;5814.796482123126;5690.687012214326;5699.487046165844;5741.655500669952;5742.598018138732;5762.82711518653;5695.373508914016;5999.850003749898;6027.939720602782;6091.512678985692;6098.39016098391;5814.389489103668;5871.324797648283;6038.5471089668235;6075.2405949256345;6084.726187321581;5794.5074668653215;5825.271841019872;5831.912521312183;5838;5848.41515848416;14002.509912153026;14066.718665626733;14105.153690778483;14157.504487342894;14248.430062797475;2111.4932416219995;2425.248173066355;2522.445062086338;2566.1916496303606;2909.4908391031695;10077.899221007843;10093.444860532667;10227.335223210468;10268.07587317145;10812.189085818594;1830.3502256698814;1832.9908350458295;1854.9814501854944;1938.7770406403163;1945.387203031055;80252;84581.57709211415;84788.57605711994;85776;86240.56879715624;10811.432342310321;11044.668659940215;11054.889451105546;11082.889171108185;11439.714007149722;12296.323702196287;15555.688886222211;15676.451324203827;15680.137592432298;15698.351673074163;7604.505707129019;7658.310752032233;7908.485948413335;7930.841383172305;7931.960340198262;7473.962630186814;7555.811104722316;7596.620168991528;7758.844823103619;7823.139454659983;4089.85685501012;4125.360569111793;4154.563770804082;4205.201011807747;4229.97885010573;1989.263972330247;1990.5222746540726;1993.5614164883702;2040.357287454447;2054.5582699719334;844.4975239732472;850.6002178975872;931.2410385535767;953.9427634341962;982.6904525074578;19002.71495927562;19004.524886877938;19386.5153371164;19484.80515194858;19762.308319209045;888.8533391990378;907.8683590879285;923.9584218710174;958.2669258017622;1062.9627963021412;10611.31026483276;10982.945085274683;11022.393768342818;11196.216264861545;11254.774904501865;414806;419694;475344;486593;488252;82931.87749347567;83244;86266;99212;100024;983.6704703924122;995.0944640377222;1024.9807878479533;1030.6083688198437;1038.117600039975;17230;17252.654946901243;17444.906611206738;17898.210178981997;18241.45275641733;40707.389389159776;41417.58582414137;41423.37864931968;41916.16167676568;42195.156096877276;55685;56360.436395635516;58116.418835812794;59347.70326148342;60528.09207861974;7185.53294035886;7594.544327340377;8022.157673444204;8241.31053134118;8419.915800841913;11539.538418463504;11988.400579971141;12340.50637974507;12359.938200309301;12502;10312.175025997753;10358.326708763907;10449.895501045195;10679.252452328263;10760.40817755031;10248.333858299187;10295.279330446796;10369;10500.159987201157;10602;10305.433201174008;10480.58077676915;10506.93251624846;10833.891661083288;10904.820210399996;7398.519096258726;7456.664450099867;7494.400447964259;7625.809354766176;7760.495567788075;10277.075063244343;10652.201084918506;10675.786484270116;10793.56825726962;11001.559937602406 17:50:02 INFO - PROCESS | 30258 | |3;mootools.html;1442.3221086089538;1503.5639664497294;1575.8187808402038;1750.2211515875433;1763.479773466827;7801.726939557117;8175.7138500152505;8503.829923401529;8986.326025548085;8999.145081217282;8202.343812495;8618.784530386743;8644.956775216131;8757.91242087579;8786.384953053288;2218.700475435816;2248.87631180285;2254.334971183505;2264.5810525052916;2266.093562574975;2242.955140897181;2263.106073101124;2270.7729227077243;2271.0802125139344;2274.931752047441;2222.288867562381;2229.710137682107;2230.5984922713906;2235.8099561537288;2260.547890421914;2140.908136850202;2140.9464763380884;2144.3138195777356;2151.8493705440624;2160.373491687417;2152.849300548962;2155.148716257085;2159.6112699714045;2160.8811515366647;2166.480044789255;8801.20789128975;8815.294776417872;8859;8904.643814247422;8913.866292005625;4885.389326334208;4904.337914381585;4924.60603151747;4937.35814344133;4940.5059494050665;3294.0941241158635;3297.686719761619;3401.3197360527993;3450.723942084627;3451.0854623524788;1074.1299547366657;1122.927009744372;1129.9209055366127;1136.5453818472595;1156.5489459110954;11978.940105299505;11988.28070315775;12082.456289466994;12093.57672481459;12118.81821772674;4362.454693163355;4387.956120438818;4562.634989200856;4635.675502714777;4651.5813576778255;10079.042490963348;10095.09144177013;10145.492725363702;10168.847467287997;10173.94913025445;4929.433115191727;4954.058728841581;4964.925526117111;4966.701997880139;4985.52637499437;4218.620324170839;4234.280172370704;4468.798904049326;4495.067121137877;4499.572540608702;3885.7668539887695;3910.4582021685565;3952.7628342299554;3991.960080399217;4158.147579746144;1233.4696080685212;1241.6399244219256;1251.6870782304425;1259.5906330442642;1263.265031207444;808.292743849132;858.3135433313931;970.3110791338088;974.4299584742863;980;5927.585069045212;5942.584019118706;5944.543586821256;6141.355157708465;6154.846128846814;448.1731205925063;457.1291689331828;459.3844248706749;460.9861704148881;467.9064187162581;4107.712460127762;4127.195196936568;4171.645410140172;4195.643370313496;4238.639715624145;10468.842967355497;10740.248182627298;10796.622118225825;10872.45637718111;10896;10591.099756520627;10667.519961601747;10778.838317425088;10822.18833587484;10850.131989440826;7933.286004259644;7956.562389068657;8086.231807978233;8148.714794982147;8158.224968627971;5799.855003624774;5993.011153159679;5993.910091348546;6028.306744724413;6068.4841788448475;9836.458994755358;9944.751381215527;9974;10076.899231007596;10138.290319677846;10126.392416455037;10150.593976240867;10196.694099177037;10345.120664743581;10345.482725863827;6752.763653272112;6791.388775010273;7072.611006394698;7319.670614822239;7443.81390465221;7857.607119644109;7992.5204487730925;8004.639791209293;8035.839283214186;8052.355811535181;6849.486288528281;6931.445484361138;6932.61870597122;7000.824979375353;7132.322429369202;6758.560693554903;6787.423069039187;6823.829404264933;6836.965815170893;6875.724971001304;6620;6668.266490686117;6703;6732.528722989344;6806.727730890709;4831.130396528659;4853.854384368475;4911.165101932608;4926.5073492650445;4953.0589188054155;5025.530370451352;5055.368078990126;5111.233315002779;5163.09645811989;5183.196604526304 17:50:02 INFO - PROCESS | 30258 | |4;prototype.html;312.2926571315969;320.4904202318315;325.79637726420987;331.641826827027;334.7690093835255;5540.196671482638;5560.443955604437;5606.915896261559;5624.015797235483;5635.239242702234;5427.782888684458;5461.972690136554;5465.6770872379275;5479.013777520045;5488.780448782044;4222.387753775716;4328.653707703392;4330.610245077943;4331.328644060168;4351.303791393378;4265.488141423034;4270.765107919063;4271.893202669927;4295.7852107394665;4315.338594641054;4259.233337999159;4266.2534056540135;4276.828926842938;4317.805698743564;4342.826286948518;4010.83956641734;4182.790860456996;4223.113146239293;4303.924018995252;4317.007088369661;3662.8717994870053;3679.7240206984584;3684.8341824617955;3705.1478160023075;3715.702743780491;5328.893422131536;5384.1923711443205;5399.4600539945695;5405.297311349539;5425.3489581250105;4753.857384278477;4793.832215872462;4823.180059389877;4876.268559716035;4900.966099068882;5678.43215678433;5678.630888992202;5682.971585142089;5695.259616249902;5704.714764261812;4063.227986682521;4083.612056854594;4112.115895082572;4115.156392939441;4123.97938010311;5735.910177066386;5885.705714714247;6027.065804800263;6048.455638992512;6053.303870054956;4091.652209562161;4103.138340948374;4123.546409894909;4126.855560055384;4151.6886233532605;4170.874873753793;4175.812088456027;4192.937105943413;4194.412782210493;4200.663946884242;4718.41019872516;4822.252550854623;4833;4872.78072486739;4892.902141957141;5752.424757524214;5773.740181691834;5778.537716982715;5782.479576838021;5807.88384232313;1437.856214378554;1444.2129039673403;1449.6520834999524;1454.3891565542497;1454.8870114362521;879.2570278114982;930.469632309577;932.8927173375013;952.7522844060455;959.6161535385902;4897.902041959141;4901.240307752304;4919.450373132452;4974.179260422062;4976.377952755905;5201.36157110509;5254.92117618236;5276.577873770089;5304.522592966651;5307.363116426053;4674.335628691681;4939.87650308738;4939.950600493949;4967.5777558907175;4993.251012348177;3070.9846450767604;3145.795523290979;3171.77797554169;3180.475221588412;3187.8724851006164;6171.7531298748445;6180.845478862974;6183.81448556544;6187.566870319124;6193.659348735863;5924.318703349084;6001.369856165127;6055.424734650202;6072.119542666289;6074;6114.785982490592;6119.204503414617;6135.938640613626;6159.3224745277985;6174.876502469925;5735.827925162252;5938.198343223609;5959.1657167995645;5980.611260268069;5984.551158663031;5803.47768700819;5811.622244554091;5817.883642327214;5830.854228644148;5866.384029676993;6092.238470191226;6114.205153330038;6123.8162855114415;6124.601900876429;6160.229971253593;3916.569177390542;4116.526599440983;4124.876253712393;4161;4196.202721482909;5914.34942156371;5940.227770389822;5975.880482390415;5979.40205979416;5992.142435844902;5640.379558248507;5881.411858814085;5885.352611212677;5896.8820623586425;5899.764009439575;5750.25246717924;5764.250647415809;5777.7977770777825;5819.563532734977;5842.2405087338375;5827.358990511125;5836.066229403275;5837.09525023622;5839.094940284092;5846.970765146147;5550.722463876709;5826.679532625577;5827.737751801094;5858.648481091148;5890.7054647266605;5738.598298119092;5763.337216220189;5776.335721391925;5820.6717313075105;5821.563382746395 17:50:02 INFO - PROCESS | 30258 | |5;yui.html;661.2659947458321;739.0466298474968;752.4883079505937;768.6886810841611;770.418334157711;13138.211707297556;13911.304434778245;13920.30398480077;13922.791158132624;13929.582112536627;13645.31773411328;13807.792883106762;13847.515336963208;13853.653658658539;13880.4447822087;750.1261030898996;779.1818590480002;801.3028665061405;802.1056521978011;811.4603788480654;798.0822054637156;798.4131663227523;798.7883210949103;799.2367289238763;801.8436404901047;832.9333653307751;841.5918279634373;844.586152785137;845.750503601439;846.2130218896424;837.7444879311807;839.2866063845744;842.6123982967812;845.1421806866036;848.1687945813076;603.8128180264132;610.322541978408;613.3927411862269;614.4869034356318;615.3231445410058;12781.169224000503;12818;12825.551105711254;12849.614511564669;12863.42114604845;12614.68463288416;12660.303683297416;13159.210447373092;13230.603081907559;13734.175949442966;10013.799724005552;10049.196064314838;10220.846687299696;10265.332753371007;10330.07029367353;3542.3977923753023;3602.9099272518133;3664.1022949377575;3665.083729067733;3770.359038963383;74715.62642186755;75583;77553.61223193904;78395.60802195953;78910;9670.178034866974;9679.467629280316;9681.467519286507;10418.68743937683;10793.62222322215;18828.435146945612;18875.244990200514;18890.338838140873;18898.149583268787;18914.621707565773;7526.134494533089;7620.5808680522;7851.254130857559;7889.09275433321;8035.879461808077;4066.34938409853;4195.664346852244;4198.6641068714425;4208.137331847025;4219.915601688011;3330.383878982396;3419.196488825124;3440.9483857742152;3442.345954268731;3447.0692912913873;556.866352075499;564.7853815550064;568.0853825341197;576.2393640394722;596.5317225977674;609.3297372889785;609.9329073801878;615.8183335915916;652.967351632426;698.9978044299745;8680.435771674822;9193.63225470987;9496.857547136799;9623.663171788954;9750.366226195274;670.1321788284183;687.7455341523569;697.2609034423527;717.2791344698649;731.0240828493913;4518.548145185455;4641.443026836801;4802.807887684523;4875;4914.385701787277;65657;86835.56582217175;111233.44383278032;116589.4170529142;117775;88567;89414;89796.55101724449;89886.55056724674;90106;53322;72870.63564682142;74319;87883.56058219796;91068.54465727761;8370.37222208349;8715.694950676696;8719.171678690514;8822.647094116164;8853.557322133996;51156;51757.7412112937;52095.73952130215;52880;53775.193372100235;69333;76377.61811190909;76949.61525192339;78222.6088869552;78478;11479.49024293117;11483.138764592855;11611.118272959036;11623.825642615537;11689.707757306136;12183.451744671334;12696.428660710106;13341.666458338232;13761;14073.225972571197;12942.67643308887;12959.092863499465;13304.800427993781;15070.171140587372;15126;13333.1342570475;13374.598762036765;13667.248301343521;14034.368453419826;14282.285885705882;11914.344711040976;13906.235157066458;13986.090904091201;14578.198199098728;14959.850401495845;10411.94794026025;10447.895521044997;10896.61861834832;11255.943720281346;11701.414929253673;11670.766584668429;11856.288622682667;11964.384808050801;12221.38893055326;12272.550136395104 17:50:02 INFO - PROCESS | 30258 | __end_tp_report 17:50:02 INFO - PROCESS | 30258 | __start_cc_report 17:50:02 INFO - PROCESS | 30258 | _x_x_mozilla_cycle_collect,314 17:50:02 INFO - PROCESS | 30258 | __end_cc_report 17:50:02 INFO - PROCESS | 30258 | __startTimestamp1474678202299__endTimestamp 17:50:02 INFO - PROCESS | 30258 | 17:50:02 INFO - PROCESS | 30258 | ------- Summary: start ------- 17:50:02 INFO - PROCESS | 30258 | Number of tests: 6 17:50:02 INFO - PROCESS | 30258 | 17:50:02 INFO - PROCESS | 30258 | [#0] dojo.html Cycles:165 Average:5303.04 Median:5519.59 stddev:592.92 (10.7%) stddev-sans-first:568.21 17:50:02 INFO - PROCESS | 30258 | Values: 3067.6 3075.4 3097.3 3102.6 3113.6 5313.7 5320.1 5401.7 5410.1 5464.3 5245.4 5279.0 5296.2 5335.1 5341.8 4786.4 4855.6 4888.1 4934.6 5019.4 4822.9 4952.5 4955.7 4962.8 5025.2 4776.7 4794.2 4836.4 4921.6 4924.5 4780.2 4856.5 4861.8 4903.2 4920.5 4804.1 4810.6 4815.3 4827.7 4872.2 5247.8 5266.9 5280.7 5313.4 5380.5 5703.4 5731.9 5758.4 5784.5 5854.6 5793.1 5794.8 5811.3 5813.6 5825.4 5204.3 5402.0 5406.8 5409.2 5409.9 5709.3 5777.8 5814.9 5824.5 5927.2 5610.1 5614.7 5623.9 5629.9 5631.9 5643.0 5662.2 5701.0 5712.4 5730.7 5495.3 5517.6 5549.4 5555.2 5600.2 5532.9 5553.5 5562.3 5562.5 5637.5 4305.7 4333.5 4338.6 4360.2 4382.7 3915.3 3918.5 3922.7 3928.8 3940.9 5478.0 5482.3 5496.6 5546.2 5574.9 5701.0 5732.3 5744.1 5744.5 5746.2 5351.3 5352.4 5435.7 5499.9 5519.6 4923.0 4962.0 4969.4 4977.9 5015.3 5953.6 5962.9 5966.6 5974.1 5974.9 5566.6 5595.4 5760.9 5768.7 5786.2 5750.6 5761.0 5775.7 5801.3 5853.1 5470.6 5501.5 5521.6 5532.6 5534.3 5579.4 5580.9 5631.8 5636.3 5651.9 5479.3 5567.5 5613.0 5631.9 5712.0 5582.5 5598.6 5601.9 5603.7 5622.8 5431.4 5480.8 5584.5 5619.9 5621.6 5473.7 5581.9 5612.7 5642.2 5697.6 5497.3 5509.6 5528.4 5534.1 5536.3 17:50:02 INFO - PROCESS | 30258 | 17:50:02 INFO - PROCESS | 30258 | [#1] ext.html Cycles:180 Average:62633.65 Median:43296.18 stddev:126507.35 (292.2%) stddev-sans-first:126776.34 17:50:02 INFO - PROCESS | 30258 | Values: 543.4 567.2 585.2 590.0 603.2 42009.2 43666.3 43699.1 47592.3 47847.3 44361.3 44642.0 44643.0 44834.6 44865.8 8839.0 8974.2 9001.6 9004.7 9012.5 8844.6 8852.0 8861.1 8870.4 8907.2 8860.6 8869.5 8931.8 8939.5 8972.1 8890.4 8910.0 8922.9 8924.3 8956.5 8785.6 8830.0 8848.6 8856.0 8883.6 42953.1 43292.8 43299.6 43306.4 43379.6 3396.2 3475.3 3686.9 4026.0 4153.3 31619.7 32068.7 32135.5 32336.7 32344.8 4216.4 4261.4 4327.0 4348.3 4447.0 335884.0 338706.0 338826.0 339314.0 341738.0 58471.0 58852.1 58956.1 59008.4 59102.0 36880.3 37655.4 61202.0 61589.4 61743.0 16035.7 16460.4 16503.8 16528.6 16553.2 12482.7 12632.0 12642.9 12649.2 12677.9 19371.3 19481.6 19499.5 19530.9 19536.8 7136.0 7166.5 7185.4 7197.7 7277.9 892.4 1022.6 1028.3 1041.8 1053.0 31307.8 31715.0 31821.4 32061.7 32647.0 1005.0 1025.4 1040.4 1072.8 1121.8 16178.5 16601.6 16683.2 16748.9 17005.4 579739.0 583462.0 583773.0 583803.0 584155.0 59179.0 59311.0 59817.0 59876.0 59961.4 1262.9 1282.2 1294.5 1295.0 1302.4 29907.3 31241.0 31511.7 31901.8 32693.0 52106.4 52501.2 52661.7 52736.7 52765.2 471593.0 472064.0 474558.0 476617.0 476727.0 28866.6 29040.4 43138.4 44150.8 44234.3 42802.4 47474.8 47794.5 48067.5 49137.3 40458.6 42553.8 42667.6 43374.8 43451.0 42684.0 42957.8 43115.6 43765.3 44146.6 32785.3 38532.4 41935.2 42905.0 45199.8 36383.6 38580.0 38723.8 39261.6 39320.4 28842.0 28859.0 28945.4 29140.6 29436.7 17:50:02 INFO - PROCESS | 30258 | 17:50:02 INFO - PROCESS | 30258 | [#2] jquery.html Cycles:180 Average:27603.99 Median:390.49 stddev:75857.37 (19426.1%) stddev-sans-first:76042.65 17:50:02 INFO - PROCESS | 30258 | Values: 389.5 391.5 393.2 395.5 413.1 14010.6 18041.8 18574.5 19432.7 19657.7 17266.8 17422.4 17528.1 18498.2 18723.0 5668.8 5740.1 5758.9 5779.1 5814.8 5690.7 5699.5 5741.7 5742.6 5762.8 5695.4 5999.9 6027.9 6091.5 6098.4 5814.4 5871.3 6038.5 6075.2 6084.7 5794.5 5825.3 5831.9 5838.0 5848.4 14002.5 14066.7 14105.2 14157.5 14248.4 2111.5 2425.2 2522.4 2566.2 2909.5 10077.9 10093.4 10227.3 10268.1 10812.2 1830.4 1833.0 1855.0 1938.8 1945.4 80252.0 84581.6 84788.6 85776.0 86240.6 10811.4 11044.7 11054.9 11082.9 11439.7 12296.3 15555.7 15676.5 15680.1 15698.4 7604.5 7658.3 7908.5 7930.8 7932.0 7474.0 7555.8 7596.6 7758.8 7823.1 4089.9 4125.4 4154.6 4205.2 4230.0 1989.3 1990.5 1993.6 2040.4 2054.6 844.5 850.6 931.2 953.9 982.7 19002.7 19004.5 19386.5 19484.8 19762.3 888.9 907.9 924.0 958.3 1063.0 10611.3 10982.9 11022.4 11196.2 11254.8 414806.0 419694.0 475344.0 486593.0 488252.0 82931.9 83244.0 86266.0 99212.0 100024.0 983.7 995.1 1025.0 1030.6 1038.1 17230.0 17252.7 17444.9 17898.2 18241.5 40707.4 41417.6 41423.4 41916.2 42195.2 55685.0 56360.4 58116.4 59347.7 60528.1 7185.5 7594.5 8022.2 8241.3 8419.9 11539.5 11988.4 12340.5 12359.9 12502.0 10312.2 10358.3 10449.9 10679.3 10760.4 10248.3 10295.3 10369.0 10500.2 10602.0 10305.4 10480.6 10506.9 10833.9 10904.8 7398.5 7456.7 7494.4 7625.8 7760.5 10277.1 10652.2 10675.8 10793.6 11001.6 17:50:02 INFO - PROCESS | 30258 | 17:50:02 INFO - PROCESS | 30258 | [#3] mootools.html Cycles:180 Average:5616.73 Median:2509.88 stddev:3248.69 (129.4%) stddev-sans-first:3242.66 17:50:02 INFO - PROCESS | 30258 | Values: 1442.3 1503.6 1575.8 1750.2 1763.5 7801.7 8175.7 8503.8 8986.3 8999.1 8202.3 8618.8 8645.0 8757.9 8786.4 2218.7 2248.9 2254.3 2264.6 2266.1 2243.0 2263.1 2270.8 2271.1 2274.9 2222.3 2229.7 2230.6 2235.8 2260.5 2140.9 2140.9 2144.3 2151.8 2160.4 2152.8 2155.1 2159.6 2160.9 2166.5 8801.2 8815.3 8859.0 8904.6 8913.9 4885.4 4904.3 4924.6 4937.4 4940.5 3294.1 3297.7 3401.3 3450.7 3451.1 1074.1 1122.9 1129.9 1136.5 1156.5 11978.9 11988.3 12082.5 12093.6 12118.8 4362.5 4388.0 4562.6 4635.7 4651.6 10079.0 10095.1 10145.5 10168.8 10173.9 4929.4 4954.1 4964.9 4966.7 4985.5 4218.6 4234.3 4468.8 4495.1 4499.6 3885.8 3910.5 3952.8 3992.0 4158.1 1233.5 1241.6 1251.7 1259.6 1263.3 808.3 858.3 970.3 974.4 980.0 5927.6 5942.6 5944.5 6141.4 6154.8 448.2 457.1 459.4 461.0 467.9 4107.7 4127.2 4171.6 4195.6 4238.6 10468.8 10740.2 10796.6 10872.5 10896.0 10591.1 10667.5 10778.8 10822.2 10850.1 7933.3 7956.6 8086.2 8148.7 8158.2 5799.9 5993.0 5993.9 6028.3 6068.5 9836.5 9944.8 9974.0 10076.9 10138.3 10126.4 10150.6 10196.7 10345.1 10345.5 6752.8 6791.4 7072.6 7319.7 7443.8 7857.6 7992.5 8004.6 8035.8 8052.4 6849.5 6931.4 6932.6 7000.8 7132.3 6758.6 6787.4 6823.8 6837.0 6875.7 6620.0 6668.3 6703.0 6732.5 6806.7 4831.1 4853.9 4911.2 4926.5 4953.1 5025.5 5055.4 5111.2 5163.1 5183.2 17:50:02 INFO - PROCESS | 30258 | 17:50:02 INFO - PROCESS | 30258 | [#4] prototype.html Cycles:180 Average:4805.58 Median:5444.88 stddev:1434.46 (26.3%) stddev-sans-first:1398.28 17:50:02 INFO - PROCESS | 30258 | Values: 312.3 320.5 325.8 331.6 334.8 5540.2 5560.4 5606.9 5624.0 5635.2 5427.8 5462.0 5465.7 5479.0 5488.8 4222.4 4328.7 4330.6 4331.3 4351.3 4265.5 4270.8 4271.9 4295.8 4315.3 4259.2 4266.3 4276.8 4317.8 4342.8 4010.8 4182.8 4223.1 4303.9 4317.0 3662.9 3679.7 3684.8 3705.1 3715.7 5328.9 5384.2 5399.5 5405.3 5425.3 4753.9 4793.8 4823.2 4876.3 4901.0 5678.4 5678.6 5683.0 5695.3 5704.7 4063.2 4083.6 4112.1 4115.2 4124.0 5735.9 5885.7 6027.1 6048.5 6053.3 4091.7 4103.1 4123.5 4126.9 4151.7 4170.9 4175.8 4192.9 4194.4 4200.7 4718.4 4822.3 4833.0 4872.8 4892.9 5752.4 5773.7 5778.5 5782.5 5807.9 1437.9 1444.2 1449.7 1454.4 1454.9 879.3 930.5 932.9 952.8 959.6 4897.9 4901.2 4919.5 4974.2 4976.4 5201.4 5254.9 5276.6 5304.5 5307.4 4674.3 4939.9 4940.0 4967.6 4993.3 3071.0 3145.8 3171.8 3180.5 3187.9 6171.8 6180.8 6183.8 6187.6 6193.7 5924.3 6001.4 6055.4 6072.1 6074.0 6114.8 6119.2 6135.9 6159.3 6174.9 5735.8 5938.2 5959.2 5980.6 5984.6 5803.5 5811.6 5817.9 5830.9 5866.4 6092.2 6114.2 6123.8 6124.6 6160.2 3916.6 4116.5 4124.9 4161.0 4196.2 5914.3 5940.2 5975.9 5979.4 5992.1 5640.4 5881.4 5885.4 5896.9 5899.8 5750.3 5764.3 5777.8 5819.6 5842.2 5827.4 5836.1 5837.1 5839.1 5847.0 5550.7 5826.7 5827.7 5858.6 5890.7 5738.6 5763.3 5776.3 5820.7 5821.6 17:50:02 INFO - PROCESS | 30258 | 17:50:02 INFO - PROCESS | 30258 | [#5] yui.html Cycles:180 Average:19457.19 Median:51456.87 stddev:27882.21 (54.2%) stddev-sans-first:27924.71 17:50:02 INFO - PROCESS | 30258 | Values: 661.3 739.0 752.5 768.7 770.4 13138.2 13911.3 13920.3 13922.8 13929.6 13645.3 13807.8 13847.5 13853.7 13880.4 750.1 779.2 801.3 802.1 811.5 798.1 798.4 798.8 799.2 801.8 832.9 841.6 844.6 845.8 846.2 837.7 839.3 842.6 845.1 848.2 603.8 610.3 613.4 614.5 615.3 12781.2 12818.0 12825.6 12849.6 12863.4 12614.7 12660.3 13159.2 13230.6 13734.2 10013.8 10049.2 10220.8 10265.3 10330.1 3542.4 3602.9 3664.1 3665.1 3770.4 74715.6 75583.0 77553.6 78395.6 78910.0 9670.2 9679.5 9681.5 10418.7 10793.6 18828.4 18875.2 18890.3 18898.1 18914.6 7526.1 7620.6 7851.3 7889.1 8035.9 4066.3 4195.7 4198.7 4208.1 4219.9 3330.4 3419.2 3440.9 3442.3 3447.1 556.9 564.8 568.1 576.2 596.5 609.3 609.9 615.8 653.0 699.0 8680.4 9193.6 9496.9 9623.7 9750.4 670.1 687.7 697.3 717.3 731.0 4518.5 4641.4 4802.8 4875.0 4914.4 65657.0 86835.6 111233.4 116589.4 117775.0 88567.0 89414.0 89796.6 89886.6 90106.0 53322.0 72870.6 74319.0 87883.6 91068.5 8370.4 8715.7 8719.2 8822.6 8853.6 51156.0 51757.7 52095.7 52880.0 53775.2 69333.0 76377.6 76949.6 78222.6 78478.0 11479.5 11483.1 11611.1 11623.8 11689.7 12183.5 12696.4 13341.7 13761.0 14073.2 12942.7 12959.1 13304.8 15070.2 15126.0 13333.1 13374.6 13667.2 14034.4 14282.3 11914.3 13906.2 13986.1 14578.2 14959.9 10411.9 10447.9 10896.6 11255.9 11701.4 11670.8 11856.3 11964.4 12221.4 12272.6 17:50:02 INFO - PROCESS | 30258 | -------- Summary: end -------- 17:50:02 INFO - PROCESS | 30258 | 17:50:03 INFO - TEST-INFO | 30258: exit 0 17:50:03 INFO - TEST-OK | dromaeo_css | took 1113084ms 17:50:03 INFO - TEST-START | kraken 17:50:03 INFO - operating with platform_type : linux_ 17:50:03 INFO - Initialising browser for kraken test... 17:50:03 INFO - TEST-INFO | started process 30615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBnspGh/profile http://localhost:53747/getInfo.html) 17:50:07 INFO - PROCESS | 30615 | __metrics Screen width/height:1600/1200 17:50:07 INFO - PROCESS | 30615 | colorDepth:24 17:50:07 INFO - PROCESS | 30615 | Browser inner width/height: 1024/697 17:50:07 INFO - PROCESS | 30615 | __metrics 17:50:08 ERROR - PROCESS | 30615 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 17:50:09 INFO - TEST-INFO | 30615: exit 0 17:50:09 INFO - Browser initialized. 17:50:09 INFO - Running cycle 1/1 for kraken test... 17:50:09 INFO - TEST-INFO | started process 30740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBnspGh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:50:21 INFO - PROCESS | 30740 | RSS: Main: 185827328 17:50:21 INFO - PROCESS | 30740 | 17:50:24 INFO - PROCESS | 30740 | Cycle 1(1): loaded http://localhost:53747/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53747/tests/kraken/driver.html?testName=audio-beat-detection) 17:50:25 INFO - PROCESS | 30740 | RSS: Main: 199651328 17:50:25 INFO - PROCESS | 30740 | 17:50:27 INFO - PROCESS | 30740 | Cycle 1(1): loaded http://localhost:53747/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53747/tests/kraken/driver.html?testName=audio-dft) 17:50:28 INFO - PROCESS | 30740 | RSS: Main: 197210112 17:50:28 INFO - PROCESS | 30740 | 17:50:31 INFO - PROCESS | 30740 | Cycle 1(1): loaded http://localhost:53747/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53747/tests/kraken/driver.html?testName=audio-fft) 17:50:31 INFO - PROCESS | 30740 | RSS: Main: 193052672 17:50:31 INFO - PROCESS | 30740 | 17:50:33 INFO - PROCESS | 30740 | Cycle 1(1): loaded http://localhost:53747/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53747/tests/kraken/driver.html?testName=audio-oscillator) 17:50:34 INFO - PROCESS | 30740 | RSS: Main: 193753088 17:50:34 INFO - PROCESS | 30740 | 17:50:36 INFO - PROCESS | 30740 | Cycle 1(1): loaded http://localhost:53747/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53747/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:50:37 INFO - PROCESS | 30740 | RSS: Main: 193937408 17:50:37 INFO - PROCESS | 30740 | 17:50:40 INFO - PROCESS | 30740 | Cycle 1(1): loaded http://localhost:53747/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53747/tests/kraken/driver.html?testName=imaging-darkroom) 17:50:41 INFO - PROCESS | 30740 | RSS: Main: 194031616 17:50:41 INFO - PROCESS | 30740 | 17:50:44 INFO - PROCESS | 30740 | Cycle 1(1): loaded http://localhost:53747/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53747/tests/kraken/driver.html?testName=imaging-desaturate) 17:50:45 INFO - PROCESS | 30740 | RSS: Main: 194633728 17:50:45 INFO - PROCESS | 30740 | 17:50:47 INFO - PROCESS | 30740 | Cycle 1(1): loaded http://localhost:53747/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53747/tests/kraken/driver.html?testName=json-parse-financial) 17:50:48 INFO - PROCESS | 30740 | RSS: Main: 193974272 17:50:48 INFO - PROCESS | 30740 | 17:50:50 INFO - PROCESS | 30740 | Cycle 1(1): loaded http://localhost:53747/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53747/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:50:50 INFO - PROCESS | 30740 | RSS: Main: 194408448 17:50:50 INFO - PROCESS | 30740 | 17:50:52 INFO - PROCESS | 30740 | Cycle 1(1): loaded http://localhost:53747/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53747/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:50:53 INFO - PROCESS | 30740 | RSS: Main: 194682880 17:50:53 INFO - PROCESS | 30740 | 17:50:55 INFO - PROCESS | 30740 | Cycle 1(1): loaded http://localhost:53747/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53747/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:50:55 INFO - PROCESS | 30740 | RSS: Main: 195043328 17:50:55 INFO - PROCESS | 30740 | 17:50:58 INFO - PROCESS | 30740 | Cycle 1(1): loaded http://localhost:53747/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:50:59 INFO - PROCESS | 30740 | RSS: Main: 194412544 17:50:59 INFO - PROCESS | 30740 | 17:51:02 INFO - PROCESS | 30740 | Cycle 1(1): loaded http://localhost:53747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:51:02 INFO - PROCESS | 30740 | RSS: Main: 194863104 17:51:02 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | Cycle 1(1): loaded http://localhost:53747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53747/tests/kraken/driver.html?testName=ai-astar) 17:51:04 INFO - PROCESS | 30740 | RSS: Main: 196227072 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | __start_tp_report 17:51:04 INFO - PROCESS | 30740 | _x_x_mozilla_page_load 17:51:04 INFO - PROCESS | 30740 | _x_x_mozilla_page_load_details 17:51:04 INFO - PROCESS | 30740 | |i|pagename|runs| 17:51:04 INFO - PROCESS | 30740 | |0;ai-astar;104;114;113;114;114;117;114;114;116;114 17:51:04 INFO - PROCESS | 30740 | |1;audio-beat-detection;148;124;120;162;124;121;125;120;156;120 17:51:04 INFO - PROCESS | 30740 | |2;audio-dft;163;164;163;164;166;163;163;165;161;164 17:51:04 INFO - PROCESS | 30740 | |3;audio-fft;76;77;77;118;77;76;77;76;120;79 17:51:04 INFO - PROCESS | 30740 | |4;audio-oscillator;83;82;116;84;83;82;97;83;81;105 17:51:04 INFO - PROCESS | 30740 | |5;imaging-gaussian-blur;119;119;118;117;118;117;118;118;117;119 17:51:04 INFO - PROCESS | 30740 | |6;imaging-darkroom;147;148;148;146;147;150;147;148;147;147 17:51:04 INFO - PROCESS | 30740 | |7;imaging-desaturate;96;96;96;95;96;96;96;96;96;95 17:51:04 INFO - PROCESS | 30740 | |8;json-parse-financial;50;50;50;52;53;52;52;52;51;53 17:51:04 INFO - PROCESS | 30740 | |9;json-stringify-tinderbox;60;60;61;61;61;60;59;61;60;61 17:51:04 INFO - PROCESS | 30740 | |10;stanford-crypto-aes;78;79;81;86;79;80;79;81;78;79 17:51:04 INFO - PROCESS | 30740 | |11;stanford-crypto-ccm;129;138;135;138;130;124;127;124;154;136 17:51:04 INFO - PROCESS | 30740 | |12;stanford-crypto-pbkdf2;167;163;167;168;164;166;165;163;163;161 17:51:04 INFO - PROCESS | 30740 | |13;stanford-crypto-sha256-iterative;66;66;65;66;70;66;65;64;65;66 17:51:04 INFO - PROCESS | 30740 | __end_tp_report 17:51:04 INFO - PROCESS | 30740 | __start_cc_report 17:51:04 INFO - PROCESS | 30740 | _x_x_mozilla_cycle_collect,790 17:51:04 INFO - PROCESS | 30740 | __end_cc_report 17:51:04 INFO - PROCESS | 30740 | __startTimestamp1474678264568__endTimestamp 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | ------- Summary: start ------- 17:51:04 INFO - PROCESS | 30740 | Number of tests: 14 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:3.50 (3.1%) stddev-sans-first:1.24 17:51:04 INFO - PROCESS | 30740 | Values: 104.0 114.0 113.0 114.0 114.0 117.0 114.0 114.0 116.0 114.0 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:124.50 stddev:16.54 (13.3%) stddev-sans-first:16.50 17:51:04 INFO - PROCESS | 30740 | Values: 148.0 124.0 120.0 162.0 124.0 121.0 125.0 120.0 156.0 120.0 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:1.35 (0.8%) stddev-sans-first:1.41 17:51:04 INFO - PROCESS | 30740 | Values: 163.0 164.0 163.0 164.0 166.0 163.0 163.0 165.0 161.0 164.0 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | [#3] audio-fft Cycles:10 Average:85.30 Median:77.00 stddev:17.79 (23.1%) stddev-sans-first:18.55 17:51:04 INFO - PROCESS | 30740 | Values: 76.0 77.0 77.0 118.0 77.0 76.0 77.0 76.0 120.0 79.0 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:83.00 stddev:12.20 (14.7%) stddev-sans-first:12.71 17:51:04 INFO - PROCESS | 30740 | Values: 83.0 82.0 116.0 84.0 83.0 82.0 97.0 83.0 81.0 105.0 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 17:51:04 INFO - PROCESS | 30740 | Values: 119.0 119.0 118.0 117.0 118.0 117.0 118.0 118.0 117.0 119.0 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 17:51:04 INFO - PROCESS | 30740 | Values: 147.0 148.0 148.0 146.0 147.0 150.0 147.0 148.0 147.0 147.0 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:51:04 INFO - PROCESS | 30740 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:1.18 (2.3%) stddev-sans-first:1.12 17:51:04 INFO - PROCESS | 30740 | Values: 50.0 50.0 50.0 52.0 53.0 52.0 52.0 52.0 51.0 53.0 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 17:51:04 INFO - PROCESS | 30740 | Values: 60.0 60.0 61.0 61.0 61.0 60.0 59.0 61.0 60.0 61.0 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.50 stddev:2.36 (3.0%) stddev-sans-first:2.39 17:51:04 INFO - PROCESS | 30740 | Values: 78.0 79.0 81.0 86.0 79.0 80.0 79.0 81.0 78.0 79.0 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:135.50 stddev:8.97 (6.6%) stddev-sans-first:9.37 17:51:04 INFO - PROCESS | 30740 | Values: 129.0 138.0 135.0 138.0 130.0 124.0 127.0 124.0 154.0 136.0 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.50 stddev:2.26 (1.4%) stddev-sans-first:2.24 17:51:04 INFO - PROCESS | 30740 | Values: 167.0 163.0 167.0 168.0 164.0 166.0 165.0 163.0 163.0 161.0 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.60 (2.4%) stddev-sans-first:1.69 17:51:04 INFO - PROCESS | 30740 | Values: 66.0 66.0 65.0 66.0 70.0 66.0 65.0 64.0 65.0 66.0 17:51:04 INFO - PROCESS | 30740 | -------- Summary: end -------- 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | 17:51:04 INFO - PROCESS | 30740 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 17:51:04 INFO - PROCESS | 30740 | 17:51:05 INFO - TEST-INFO | 30740: exit 0 17:51:05 INFO - TEST-OK | kraken | took 62348ms 17:51:05 INFO - SUITE-END | took 1175s 17:51:06 INFO - Completed test suite (00:19:35) 17:51:06 INFO - javascript benchmark 17:51:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7116.383005692374, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.616547931509, 3075.446419644466, 3097.256658401983, 3102.5811515445407, 3113.57966674499, 5313.707746073974, 5320.14877619581, 5401.6758994460315, 5410.134378499436, 5464.289642346489, 5245.370555533332, 5279.0, 5296.205569164617, 5335.146376579748, 5341.839744807662, 4786.353842231307, 4855.635827312948, 4888.087472090544, 4934.555889969902, 5019.4227663818765, 4822.879428014293, 4952.479989601076, 4955.727434991074, 4962.776675049631, 5025.195968645017, 4776.713397196145, 4794.161021821167, 4836.371271734687, 4921.557059864612, 4924.532169443897, 4780.1873681474235, 4856.514348565151, 4861.805527778884, 4903.215485522299, 4920.532549407836, 4804.063207674505, 4810.6151507879285, 4815.277708343777, 4827.734474603895, 4872.220444728861, 5247.842564723064, 5266.894662106774, 5280.683159010472, 5313.38896026958, 5380.515753582157, 5703.40114288002, 5731.942680573183, 5758.42415758425, 5784.537237021028, 5854.619449735754, 5793.13103034544, 5794.826155215308, 5811.27359080115, 5813.6221145625395, 5825.359210486843, 5204.297419848348, 5401.972990135024, 5406.810761623325, 5409.215663728776, 5409.918851217235, 5709.314882214077, 5777.768889244383, 5814.883702325929, 5824.475797178275, 5927.229460170237, 5610.13042978339, 5614.691191984399, 5623.859403514863, 5629.887402252014, 5631.8592035199445, 5642.971785141131, 5662.235598194274, 5701.030824759718, 5712.371639119693, 5730.684812335278, 5495.340559132929, 5517.641353312102, 5549.361823390281, 5555.194496797942, 5600.187972743929, 5532.944670553324, 5553.527950124204, 5562.276904002454, 5562.527185189223, 5637.46444087811, 4305.677074219446, 4333.544977777351, 4338.566143385636, 4360.171567402183, 4382.693211475166, 3915.334393153171, 3918.5101862267215, 3922.7254092213843, 3928.823202955874, 3940.862069827542, 5477.972610137003, 5482.259894914216, 5496.615236933376, 5546.168074788733, 5574.916376254359, 5701.0, 5732.3407808101765, 5744.080947048536, 5744.454276843693, 5746.224259724967, 5351.25082488452, 5352.384475785257, 5435.701036443033, 5499.945000549943, 5519.586031047687, 4923.0, 4962.03240368132, 4969.35398398206, 4977.875553111201, 5015.348004759431, 5953.613015154001, 5962.850928726816, 5966.642001479925, 5974.103884417372, 5974.850628734316, 5566.554675625859, 5595.440455954372, 5760.884782304414, 5768.682722450138, 5786.218860453785, 5750.568707347049, 5761.049426844691, 5775.711214439345, 5801.274840644751, 5853.09277062056, 5470.589705772162, 5501.504864562208, 5521.641093328921, 5532.585056120726, 5534.335879694462, 5579.414161512983, 5580.86047848807, 5631.831045068655, 5636.267285252891, 5651.858703532444, 5479.287692600096, 5567.47109024642, 5613.045782216951, 5631.915521267102, 5712.0, 5582.525485333792, 5598.552115830806, 5601.915971260353, 5603.719814009365, 5622.803201887914, 5431.402545719889, 5480.753366098615, 5584.46947539983, 5619.943800562106, 5621.550275977994, 5473.67157970523, 5581.9162712560155, 5612.747426365905, 5642.153676948491, 5697.6296540724725, 5497.340319161726, 5509.614326997072, 5528.364238112507, 5534.142207957773, 5536.252605898152], "value": 5263.452143258901, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.4236603921785, 567.186087963772, 585.2041223935449, 590.0, 603.1796756411281, 42009.15981680364, 43666.34500482487, 43699.12601747963, 47592.28611570821, 47847.28229076558, 44361.334579981325, 44642.0, 44643.0, 44834.551654483446, 44865.7756711216, 8838.955805220965, 8974.192322690957, 9001.594928228245, 9004.729858104267, 9012.459252444842, 8844.646214151426, 8852.026277109513, 8861.069587693297, 8870.42342247752, 8907.153820387086, 8860.601272942733, 8869.512176830272, 8931.821363572724, 8939.508327042011, 8972.147645973622, 8890.422122562046, 8910.0, 8922.910770892273, 8924.286057115416, 8956.507392093432, 8785.604647790864, 8829.955850220707, 8848.60181291837, 8855.955720221358, 8883.644654213824, 42953.14093718139, 43292.78353608243, 43299.56700433019, 43306.350404743636, 43379.56620433787, 3396.2188696599674, 3475.3396854597545, 3686.926261474782, 4026.0280484906098, 4153.252414565377, 31619.683803161905, 32068.6793132068, 32135.51796723051, 32336.6766332336, 32344.838275808706, 4216.367544868263, 4261.446012018418, 4326.9567304326865, 4348.326009468537, 4446.977765111186, 335884.0, 338706.0, 338826.0, 339314.0, 341738.0, 58471.0, 58852.11721824176, 58956.11565826516, 59008.40991590115, 59102.0, 36880.26239475195, 37655.4351684725, 61202.0, 61589.38410615926, 61743.0, 16035.679286414439, 16460.42388516396, 16503.83496165047, 16528.586785330463, 16553.172341382884, 12482.687932801753, 12632.0, 12642.873571264354, 12649.177803442746, 12677.873221267853, 19371.309085671295, 19481.565445650853, 19499.499897989175, 19530.891764189728, 19536.804631953783, 7135.965285033641, 7166.462515311373, 7185.389241914496, 7197.676104575306, 7277.9272207277245, 892.4020905993, 1022.5602990713916, 1028.3469996552244, 1041.8489319048695, 1052.9578816847393, 31307.843460783006, 31715.0, 31821.363572728416, 32061.747959148208, 32647.020589382355, 1004.9849252261222, 1025.410389026313, 1040.432964034603, 1072.8498010278568, 1121.820508718601, 16178.514644560682, 16601.584960376087, 16683.24825893288, 16748.916255418644, 17005.404810831562, 579739.0, 583462.0, 583772.973621584, 583803.0, 584155.0, 59179.0, 59311.0, 59817.0, 59876.0, 59961.40038599646, 1262.8926541243914, 1282.179405180685, 1294.5080869269618, 1295.0351987769172, 1302.426932149851, 29907.319803642535, 31241.0, 31511.684883150876, 31901.840490798328, 32693.0, 52106.35255532228, 52501.21248181204, 52661.7366913163, 52736.73631631817, 52765.20852187297, 471593.0, 472064.0, 474558.0, 476617.0, 476727.0, 28866.567001495416, 29040.41919161647, 43138.352924706785, 44150.779246103564, 44234.33648495211, 42802.35796462993, 47474.762626186646, 47794.52205477901, 48067.519324807705, 49137.26294105663, 40458.595414045485, 42553.787231063645, 42667.5733242676, 43374.78312608543, 43451.0, 42684.0, 42957.785211073744, 43115.56884431116, 43765.34351984659, 44146.558534415526, 32785.34429311353, 38532.42201367038, 41935.1612967745, 42905.0, 45199.774001131096, 36383.636163638024, 38580.0, 38723.806380967915, 39261.607383925795, 39320.41019384769, 28842.0, 28859.0, 28945.42109157847, 29140.562891557067, 29436.705632943398], "value": 20350.086903007967, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.51505375807125, 391.46955874789677, 393.2351576184322, 395.4858683711175, 413.09738221984964, 14010.579682609512, 18041.81958180418, 18574.535636609093, 19432.708509372354, 19657.705134422995, 17266.82733172668, 17422.3902163424, 17528.123593820288, 18498.167582458787, 18723.0, 5668.801591944272, 5740.052891272935, 5758.884822303551, 5779.104238842986, 5814.796482123126, 5690.687012214326, 5699.487046165844, 5741.655500669952, 5742.598018138732, 5762.82711518653, 5695.373508914016, 5999.850003749898, 6027.939720602782, 6091.512678985692, 6098.39016098391, 5814.389489103668, 5871.324797648283, 6038.5471089668235, 6075.2405949256345, 6084.726187321581, 5794.5074668653215, 5825.271841019872, 5831.912521312183, 5838.0, 5848.41515848416, 14002.509912153026, 14066.718665626733, 14105.153690778483, 14157.504487342894, 14248.430062797475, 2111.4932416219995, 2425.248173066355, 2522.445062086338, 2566.1916496303606, 2909.4908391031695, 10077.899221007843, 10093.444860532667, 10227.335223210468, 10268.07587317145, 10812.189085818594, 1830.3502256698814, 1832.9908350458295, 1854.9814501854944, 1938.7770406403163, 1945.387203031055, 80252.0, 84581.57709211415, 84788.57605711994, 85776.0, 86240.56879715624, 10811.432342310321, 11044.668659940215, 11054.889451105546, 11082.889171108185, 11439.714007149722, 12296.323702196287, 15555.688886222211, 15676.451324203827, 15680.137592432298, 15698.351673074163, 7604.505707129019, 7658.310752032233, 7908.485948413335, 7930.841383172305, 7931.960340198262, 7473.962630186814, 7555.811104722316, 7596.620168991528, 7758.844823103619, 7823.139454659983, 4089.85685501012, 4125.360569111793, 4154.563770804082, 4205.201011807747, 4229.97885010573, 1989.263972330247, 1990.5222746540726, 1993.5614164883702, 2040.357287454447, 2054.5582699719334, 844.4975239732472, 850.6002178975872, 931.2410385535767, 953.9427634341962, 982.6904525074578, 19002.71495927562, 19004.524886877938, 19386.5153371164, 19484.80515194858, 19762.308319209045, 888.8533391990378, 907.8683590879285, 923.9584218710174, 958.2669258017622, 1062.9627963021412, 10611.31026483276, 10982.945085274683, 11022.393768342818, 11196.216264861545, 11254.774904501865, 414806.0, 419694.0, 475344.0, 486593.0, 488252.0, 82931.87749347567, 83244.0, 86266.0, 99212.0, 100024.0, 983.6704703924122, 995.0944640377222, 1024.9807878479533, 1030.6083688198437, 1038.117600039975, 17230.0, 17252.654946901243, 17444.906611206738, 17898.210178981997, 18241.45275641733, 40707.389389159776, 41417.58582414137, 41423.37864931968, 41916.16167676568, 42195.156096877276, 55685.0, 56360.436395635516, 58116.418835812794, 59347.70326148342, 60528.09207861974, 7185.53294035886, 7594.544327340377, 8022.157673444204, 8241.31053134118, 8419.915800841913, 11539.538418463504, 11988.400579971141, 12340.50637974507, 12359.938200309301, 12502.0, 10312.175025997753, 10358.326708763907, 10449.895501045195, 10679.252452328263, 10760.40817755031, 10248.333858299187, 10295.279330446796, 10369.0, 10500.159987201157, 10602.0, 10305.433201174008, 10480.58077676915, 10506.93251624846, 10833.891661083288, 10904.820210399996, 7398.519096258726, 7456.664450099867, 7494.400447964259, 7625.809354766176, 7760.495567788075, 10277.075063244343, 10652.201084918506, 10675.786484270116, 10793.56825726962, 11001.559937602406], "value": 8851.37737570367, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.3221086089538, 1503.5639664497294, 1575.8187808402038, 1750.2211515875433, 1763.479773466827, 7801.726939557117, 8175.7138500152505, 8503.829923401529, 8986.326025548085, 8999.145081217282, 8202.343812495, 8618.784530386743, 8644.956775216131, 8757.91242087579, 8786.384953053288, 2218.700475435816, 2248.87631180285, 2254.334971183505, 2264.5810525052916, 2266.093562574975, 2242.955140897181, 2263.106073101124, 2270.7729227077243, 2271.0802125139344, 2274.931752047441, 2222.288867562381, 2229.710137682107, 2230.5984922713906, 2235.8099561537288, 2260.547890421914, 2140.908136850202, 2140.9464763380884, 2144.3138195777356, 2151.8493705440624, 2160.373491687417, 2152.849300548962, 2155.148716257085, 2159.6112699714045, 2160.8811515366647, 2166.480044789255, 8801.20789128975, 8815.294776417872, 8859.0, 8904.643814247422, 8913.866292005625, 4885.389326334208, 4904.337914381585, 4924.60603151747, 4937.35814344133, 4940.5059494050665, 3294.0941241158635, 3297.686719761619, 3401.3197360527993, 3450.723942084627, 3451.0854623524788, 1074.1299547366657, 1122.927009744372, 1129.9209055366127, 1136.5453818472595, 1156.5489459110954, 11978.940105299505, 11988.28070315775, 12082.456289466994, 12093.57672481459, 12118.81821772674, 4362.454693163355, 4387.956120438818, 4562.634989200856, 4635.675502714777, 4651.5813576778255, 10079.042490963348, 10095.09144177013, 10145.492725363702, 10168.847467287997, 10173.94913025445, 4929.433115191727, 4954.058728841581, 4964.925526117111, 4966.701997880139, 4985.52637499437, 4218.620324170839, 4234.280172370704, 4468.798904049326, 4495.067121137877, 4499.572540608702, 3885.7668539887695, 3910.4582021685565, 3952.7628342299554, 3991.960080399217, 4158.147579746144, 1233.4696080685212, 1241.6399244219256, 1251.6870782304425, 1259.5906330442642, 1263.265031207444, 808.292743849132, 858.3135433313931, 970.3110791338088, 974.4299584742863, 980.0, 5927.585069045212, 5942.584019118706, 5944.543586821256, 6141.355157708465, 6154.846128846814, 448.1731205925063, 457.1291689331828, 459.3844248706749, 460.9861704148881, 467.9064187162581, 4107.712460127762, 4127.195196936568, 4171.645410140172, 4195.643370313496, 4238.639715624145, 10468.842967355497, 10740.248182627298, 10796.622118225825, 10872.45637718111, 10896.0, 10591.099756520627, 10667.519961601747, 10778.838317425088, 10822.18833587484, 10850.131989440826, 7933.286004259644, 7956.562389068657, 8086.231807978233, 8148.714794982147, 8158.224968627971, 5799.855003624774, 5993.011153159679, 5993.910091348546, 6028.306744724413, 6068.4841788448475, 9836.458994755358, 9944.751381215527, 9974.0, 10076.899231007596, 10138.290319677846, 10126.392416455037, 10150.593976240867, 10196.694099177037, 10345.120664743581, 10345.482725863827, 6752.763653272112, 6791.388775010273, 7072.611006394698, 7319.670614822239, 7443.81390465221, 7857.607119644109, 7992.5204487730925, 8004.639791209293, 8035.839283214186, 8052.355811535181, 6849.486288528281, 6931.445484361138, 6932.61870597122, 7000.824979375353, 7132.322429369202, 6758.560693554903, 6787.423069039187, 6823.829404264933, 6836.965815170893, 6875.724971001304, 6620.0, 6668.266490686117, 6703.0, 6732.528722989344, 6806.727730890709, 4831.130396528659, 4853.854384368475, 4911.165101932608, 4926.5073492650445, 4953.0589188054155, 5025.530370451352, 5055.368078990126, 5111.233315002779, 5163.09645811989, 5183.196604526304], "value": 4416.20016979153, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.2926571315969, 320.4904202318315, 325.79637726420987, 331.641826827027, 334.7690093835255, 5540.196671482638, 5560.443955604437, 5606.915896261559, 5624.015797235483, 5635.239242702234, 5427.782888684458, 5461.972690136554, 5465.6770872379275, 5479.013777520045, 5488.780448782044, 4222.387753775716, 4328.653707703392, 4330.610245077943, 4331.328644060168, 4351.303791393378, 4265.488141423034, 4270.765107919063, 4271.893202669927, 4295.7852107394665, 4315.338594641054, 4259.233337999159, 4266.2534056540135, 4276.828926842938, 4317.805698743564, 4342.826286948518, 4010.83956641734, 4182.790860456996, 4223.113146239293, 4303.924018995252, 4317.007088369661, 3662.8717994870053, 3679.7240206984584, 3684.8341824617955, 3705.1478160023075, 3715.702743780491, 5328.893422131536, 5384.1923711443205, 5399.4600539945695, 5405.297311349539, 5425.3489581250105, 4753.857384278477, 4793.832215872462, 4823.180059389877, 4876.268559716035, 4900.966099068882, 5678.43215678433, 5678.630888992202, 5682.971585142089, 5695.259616249902, 5704.714764261812, 4063.227986682521, 4083.612056854594, 4112.115895082572, 4115.156392939441, 4123.97938010311, 5735.910177066386, 5885.705714714247, 6027.065804800263, 6048.455638992512, 6053.303870054956, 4091.652209562161, 4103.138340948374, 4123.546409894909, 4126.855560055384, 4151.6886233532605, 4170.874873753793, 4175.812088456027, 4192.937105943413, 4194.412782210493, 4200.663946884242, 4718.41019872516, 4822.252550854623, 4833.0, 4872.78072486739, 4892.902141957141, 5752.424757524214, 5773.740181691834, 5778.537716982715, 5782.479576838021, 5807.88384232313, 1437.856214378554, 1444.2129039673403, 1449.6520834999524, 1454.3891565542497, 1454.8870114362521, 879.2570278114982, 930.469632309577, 932.8927173375013, 952.7522844060455, 959.6161535385902, 4897.902041959141, 4901.240307752304, 4919.450373132452, 4974.179260422062, 4976.377952755905, 5201.36157110509, 5254.92117618236, 5276.577873770089, 5304.522592966651, 5307.363116426053, 4674.335628691681, 4939.87650308738, 4939.950600493949, 4967.5777558907175, 4993.251012348177, 3070.9846450767604, 3145.795523290979, 3171.77797554169, 3180.475221588412, 3187.8724851006164, 6171.7531298748445, 6180.845478862974, 6183.81448556544, 6187.566870319124, 6193.659348735863, 5924.318703349084, 6001.369856165127, 6055.424734650202, 6072.119542666289, 6074.0, 6114.785982490592, 6119.204503414617, 6135.938640613626, 6159.3224745277985, 6174.876502469925, 5735.827925162252, 5938.198343223609, 5959.1657167995645, 5980.611260268069, 5984.551158663031, 5803.47768700819, 5811.622244554091, 5817.883642327214, 5830.854228644148, 5866.384029676993, 6092.238470191226, 6114.205153330038, 6123.8162855114415, 6124.601900876429, 6160.229971253593, 3916.569177390542, 4116.526599440983, 4124.876253712393, 4161.0, 4196.202721482909, 5914.34942156371, 5940.227770389822, 5975.880482390415, 5979.40205979416, 5992.142435844902, 5640.379558248507, 5881.411858814085, 5885.352611212677, 5896.8820623586425, 5899.764009439575, 5750.25246717924, 5764.250647415809, 5777.7977770777825, 5819.563532734977, 5842.2405087338375, 5827.358990511125, 5836.066229403275, 5837.09525023622, 5839.094940284092, 5846.970765146147, 5550.722463876709, 5826.679532625577, 5827.737751801094, 5858.648481091148, 5890.7054647266605, 5738.598298119092, 5763.337216220189, 5776.335721391925, 5820.6717313075105, 5821.563382746395], "value": 4341.5709420103985, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.2659947458321, 739.0466298474968, 752.4883079505937, 768.6886810841611, 770.418334157711, 13138.211707297556, 13911.304434778245, 13920.30398480077, 13922.791158132624, 13929.582112536627, 13645.31773411328, 13807.792883106762, 13847.515336963208, 13853.653658658539, 13880.4447822087, 750.1261030898996, 779.1818590480002, 801.3028665061405, 802.1056521978011, 811.4603788480654, 798.0822054637156, 798.4131663227523, 798.7883210949103, 799.2367289238763, 801.8436404901047, 832.9333653307751, 841.5918279634373, 844.586152785137, 845.750503601439, 846.2130218896424, 837.7444879311807, 839.2866063845744, 842.6123982967812, 845.1421806866036, 848.1687945813076, 603.8128180264132, 610.322541978408, 613.3927411862269, 614.4869034356318, 615.3231445410058, 12781.169224000503, 12818.0, 12825.551105711254, 12849.614511564669, 12863.42114604845, 12614.68463288416, 12660.303683297416, 13159.210447373092, 13230.603081907559, 13734.175949442966, 10013.799724005552, 10049.196064314838, 10220.846687299696, 10265.332753371007, 10330.07029367353, 3542.3977923753023, 3602.9099272518133, 3664.1022949377575, 3665.083729067733, 3770.359038963383, 74715.62642186755, 75583.0, 77553.61223193904, 78395.60802195953, 78910.0, 9670.178034866974, 9679.467629280316, 9681.467519286507, 10418.68743937683, 10793.62222322215, 18828.435146945612, 18875.244990200514, 18890.338838140873, 18898.149583268787, 18914.621707565773, 7526.134494533089, 7620.5808680522, 7851.254130857559, 7889.09275433321, 8035.879461808077, 4066.34938409853, 4195.664346852244, 4198.6641068714425, 4208.137331847025, 4219.915601688011, 3330.383878982396, 3419.196488825124, 3440.9483857742152, 3442.345954268731, 3447.0692912913873, 556.866352075499, 564.7853815550064, 568.0853825341197, 576.2393640394722, 596.5317225977674, 609.3297372889785, 609.9329073801878, 615.8183335915916, 652.967351632426, 698.9978044299745, 8680.435771674822, 9193.63225470987, 9496.857547136799, 9623.663171788954, 9750.366226195274, 670.1321788284183, 687.7455341523569, 697.2609034423527, 717.2791344698649, 731.0240828493913, 4518.548145185455, 4641.443026836801, 4802.807887684523, 4875.0, 4914.385701787277, 65657.0, 86835.56582217175, 111233.44383278032, 116589.4170529142, 117775.0, 88567.0, 89414.0, 89796.55101724449, 89886.55056724674, 90106.0, 53322.0, 72870.63564682142, 74319.0, 87883.56058219796, 91068.54465727761, 8370.37222208349, 8715.694950676696, 8719.171678690514, 8822.647094116164, 8853.557322133996, 51156.0, 51757.7412112937, 52095.73952130215, 52880.0, 53775.193372100235, 69333.0, 76377.61811190909, 76949.61525192339, 78222.6088869552, 78478.0, 11479.49024293117, 11483.138764592855, 11611.118272959036, 11623.825642615537, 11689.707757306136, 12183.451744671334, 12696.428660710106, 13341.666458338232, 13761.0, 14073.225972571197, 12942.67643308887, 12959.092863499465, 13304.800427993781, 15070.171140587372, 15126.0, 13333.1342570475, 13374.598762036765, 13667.248301343521, 14034.368453419826, 14282.285885705882, 11914.344711040976, 13906.235157066458, 13986.090904091201, 14578.198199098728, 14959.850401495845, 10411.94794026025, 10447.895521044997, 10896.61861834832, 11255.943720281346, 11701.414929253673, 11670.766584668429, 11856.288622682667, 11964.384808050801, 12221.38893055326, 12272.550136395104], "value": 7144.412567619438, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1501.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 114.0, 114.0, 117.0, 114.0, 114.0, 116.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 124.0, 120.0, 162.0, 124.0, 121.0, 125.0, 120.0, 156.0, 120.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 164.0, 166.0, 163.0, 163.0, 165.0, 161.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 118.0, 77.0, 76.0, 77.0, 76.0, 120.0, 79.0], "value": 85.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 116.0, 84.0, 83.0, 82.0, 97.0, 83.0, 81.0, 105.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 146.0, 147.0, 150.0, 147.0, 148.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 52.0, 53.0, 52.0, 52.0, 52.0, 51.0, 53.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 61.0, 61.0, 60.0, 59.0, 61.0, 60.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 81.0, 86.0, 79.0, 80.0, 79.0, 81.0, 78.0, 79.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 138.0, 135.0, 138.0, 130.0, 124.0, 127.0, 124.0, 154.0, 136.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 167.0, 168.0, 164.0, 166.0, 165.0, 163.0, 163.0, 161.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 70.0, 66.0, 65.0, 64.0, 65.0, 66.0], "value": 65.9, "unit": "score"}]}]} 17:51:06 INFO - Return code: 0 17:51:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:51:06 ERROR - # TBPL SUCCESS # 17:51:06 INFO - Running post-action listener: _resource_record_post_action 17:51:06 INFO - [mozharness: 2016-09-24 00:51:06.345462Z] Finished run-tests step (success) 17:51:06 INFO - Running post-run listener: _resource_record_post_run 17:51:06 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392359936; Read time: 12; Write time: 246044 17:51:06 INFO - TinderboxPrint: CPU usage
13.3% 17:51:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:51:06 INFO - TinderboxPrint: I/O write bytes / time
392,359,936 / 246,044 17:51:06 INFO - TinderboxPrint: CPU idle
8,242.3 (86.6%) 17:51:06 INFO - TinderboxPrint: CPU user
1,209.3 (12.7%) 17:51:06 INFO - TinderboxPrint: Swap in / out
0 / 0 17:51:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103923712; Read time: 0; Write time: 67436 17:51:06 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 288100352; Read time: 0; Write time: 178608 17:51:06 INFO - Running post-run listener: _upload_blobber_files 17:51:06 INFO - Blob upload gear active. 17:51:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:51:06 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:51:06 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:51:06 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:51:07 INFO - (blobuploader) - INFO - Open directory for files ... 17:51:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:51:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:51:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:51:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:51:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:51:08 INFO - (blobuploader) - INFO - Done attempting. 17:51:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:51:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:51:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:51:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:51:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:51:11 INFO - (blobuploader) - INFO - Done attempting. 17:51:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:51:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:51:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:51:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:51:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:51:12 INFO - (blobuploader) - INFO - Done attempting. 17:51:12 INFO - (blobuploader) - INFO - Iteration through files over. 17:51:12 INFO - Return code: 0 17:51:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:51:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:51:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24f55ba9938d365c4a24c386b9d4c986716da2fe94e4644c72f4c2c40efcd0d927b87cbf84402527a45eead54331d1790ab622f55643d2581e1db090b473ed08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae266556d53c0879c6945e209a386e9f87945a86d590ff3eeec8c929d57a45414839ec236d52103f07fc5c46a1dc5dd50a8af012019fc002d3ba86f1ad955e7d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79c73ba614427729a98e2e22d9068b901a010809d600f82f8c859b17a55699b64decf219a650b638ab9aa8217f5bd8ae8176c0b9260aefd78759cc02a0ead85b"} 17:51:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:51:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:51:12 INFO - Contents: 17:51:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24f55ba9938d365c4a24c386b9d4c986716da2fe94e4644c72f4c2c40efcd0d927b87cbf84402527a45eead54331d1790ab622f55643d2581e1db090b473ed08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae266556d53c0879c6945e209a386e9f87945a86d590ff3eeec8c929d57a45414839ec236d52103f07fc5c46a1dc5dd50a8af012019fc002d3ba86f1ad955e7d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79c73ba614427729a98e2e22d9068b901a010809d600f82f8c859b17a55699b64decf219a650b638ab9aa8217f5bd8ae8176c0b9260aefd78759cc02a0ead85b"} 17:51:12 INFO - Running post-run listener: copy_logs_to_upload_dir 17:51:12 INFO - Copying logs to upload dir... 17:51:12 INFO - mkdir: /builds/slave/test/build/upload/logs 17:51:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.159337 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-09-23 17:51:12.512413) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 17:51:12.515559) ========= 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=20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660 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/24f55ba9938d365c4a24c386b9d4c986716da2fe94e4644c72f4c2c40efcd0d927b87cbf84402527a45eead54331d1790ab622f55643d2581e1db090b473ed08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae266556d53c0879c6945e209a386e9f87945a86d590ff3eeec8c929d57a45414839ec236d52103f07fc5c46a1dc5dd50a8af012019fc002d3ba86f1ad955e7d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79c73ba614427729a98e2e22d9068b901a010809d600f82f8c859b17a55699b64decf219a650b638ab9aa8217f5bd8ae8176c0b9260aefd78759cc02a0ead85b"} 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.011292 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/24f55ba9938d365c4a24c386b9d4c986716da2fe94e4644c72f4c2c40efcd0d927b87cbf84402527a45eead54331d1790ab622f55643d2581e1db090b473ed08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ae266556d53c0879c6945e209a386e9f87945a86d590ff3eeec8c929d57a45414839ec236d52103f07fc5c46a1dc5dd50a8af012019fc002d3ba86f1ad955e7d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79c73ba614427729a98e2e22d9068b901a010809d600f82f8c859b17a55699b64decf219a650b638ab9aa8217f5bd8ae8176c0b9260aefd78759cc02a0ead85b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 17:51:12.544902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:51:12.545678) ========= 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=20e666a3d4cfbb71505a330e000001b4-1474676961.722668-660675660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 17:51:12.625956) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 17:51:12.626332) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 17:51:12.626635) ========= ========= Total master_lag: 0.18 =========