builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1474944558.25 results: success (0) buildid: 20160926154649 builduid: d48cb954ec8d4fb0babc833687c7c9c9 revision: 92d639e21ef43fff9aef06b039a4da3666ef1f93 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 19:49:18.251449) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 19:49:18.252075) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 19:49:18.252406) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 19:49:18.283640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:49:18.284022) ========= 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=5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-26 19:49:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-09-26 19:49:19 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103360 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:49:18.414336) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:49:18.414909) ========= 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=5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016578 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:49:18.468403) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:49:18.469315) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 92d639e21ef43fff9aef06b039a4da3666ef1f93 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 92d639e21ef43fff9aef06b039a4da3666ef1f93 --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=5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-26 19:49:19,141 truncating revision to first 12 chars 2016-09-26 19:49:19,141 Setting DEBUG logging. 2016-09-26 19:49:19,141 attempt 1/10 2016-09-26 19:49:19,141 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/92d639e21ef4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 19:49:19,467 unpacking tar archive at: mozilla-aurora-92d639e21ef4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683114 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 19:49:19.172360) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 19:49:19.172726) ========= script_repo_revision: 92d639e21ef43fff9aef06b039a4da3666ef1f93 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 19:49:19.173294) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 19:49:19.173718) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 19:49:19.185224) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-09-26 19:49:19.185856) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:49:19 INFO - MultiFileLogger online at 20160926 19:49:19 in /builds/slave/test 19:49:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 19:49:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:49:19 INFO - {'append_to_log': False, 19:49:19 INFO - 'base_work_dir': '/builds/slave/test', 19:49:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:49:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:49:19 INFO - 'branch': 'Mozilla-Aurora', 19:49:19 INFO - 'buildbot_json_path': 'buildprops.json', 19:49:19 INFO - 'config_files': ('talos/linux_config.py',), 19:49:19 INFO - 'default_actions': ('clobber', 19:49:19 INFO - 'read-buildbot-config', 19:49:19 INFO - 'download-and-extract', 19:49:19 INFO - 'populate-webroot', 19:49:19 INFO - 'create-virtualenv', 19:49:19 INFO - 'install', 19:49:19 INFO - 'run-tests'), 19:49:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:49:19 INFO - 'download_minidump_stackwalk': True, 19:49:19 INFO - 'download_symbols': 'ondemand', 19:49:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:49:19 INFO - 'tooltool.py': '/tools/tooltool.py', 19:49:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:49:19 INFO - '/tools/misc-python/virtualenv.py')}, 19:49:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:49:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:49:19 INFO - 'installer_path': 'installer.exe', 19:49:19 INFO - 'log_level': 'info', 19:49:19 INFO - 'log_name': 'talos', 19:49:19 INFO - 'log_to_console': True, 19:49:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:49:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:49:19 INFO - 'opt_config_files': (), 19:49:19 INFO - 'pip_index': False, 19:49:19 INFO - 'sps_profile': False, 19:49:19 INFO - 'sps_profile_interval': 0, 19:49:19 INFO - 'suite': 'dromaeojs', 19:49:19 INFO - 'system_bits': '32', 19:49:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:49:19 INFO - 'title': 'talos-linux64-ix-011', 19:49:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:49:19 INFO - 'use_talos_json': True, 19:49:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:49:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:49:19 INFO - 'work_dir': 'build'} 19:49:19 INFO - [mozharness: 2016-09-27 02:49:19.949282Z] Running clobber step. 19:49:19 INFO - Running pre-action listener: _resource_record_pre_action 19:49:19 INFO - Running main action method: clobber 19:49:19 INFO - rmtree: /builds/slave/test/build 19:49:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:49:20 INFO - Running post-action listener: _resource_record_post_action 19:49:20 INFO - [mozharness: 2016-09-27 02:49:20.406138Z] Finished clobber step (success) 19:49:20 INFO - [mozharness: 2016-09-27 02:49:20.406239Z] Running read-buildbot-config step. 19:49:20 INFO - Running pre-action listener: _resource_record_pre_action 19:49:20 INFO - Running main action method: read_buildbot_config 19:49:20 INFO - Using buildbot properties: 19:49:20 INFO - { 19:49:20 INFO - "project": "", 19:49:20 INFO - "product": "firefox", 19:49:20 INFO - "script_repo_revision": "production", 19:49:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 19:49:20 INFO - "repository": "", 19:49:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 19:49:20 INFO - "buildid": "20160926154649", 19:49:20 INFO - "pgo_build": "True", 19:49:20 INFO - "basedir": "/builds/slave/test", 19:49:20 INFO - "buildnumber": 791, 19:49:20 INFO - "slavename": "talos-linux64-ix-011", 19:49:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:49:20 INFO - "platform": "ubuntu64_hw", 19:49:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 19:49:20 INFO - "branch": "mozilla-aurora", 19:49:20 INFO - "repo_path": "releases/mozilla-aurora", 19:49:20 INFO - "revision": "92d639e21ef43fff9aef06b039a4da3666ef1f93", 19:49:20 INFO - "stage_platform": "linux64-pgo", 19:49:20 INFO - "builduid": "d48cb954ec8d4fb0babc833687c7c9c9", 19:49:20 INFO - "slavebuilddir": "test" 19:49:20 INFO - } 19:49:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 19:49:20 INFO - Running post-action listener: _resource_record_post_action 19:49:20 INFO - [mozharness: 2016-09-27 02:49:20.408676Z] Finished read-buildbot-config step (success) 19:49:20 INFO - [mozharness: 2016-09-27 02:49:20.408767Z] Running download-and-extract step. 19:49:20 INFO - Running pre-action listener: _resource_record_pre_action 19:49:20 INFO - Running main action method: download_and_extract 19:49:20 INFO - mkdir: /builds/slave/test/build/tests 19:49:20 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')]} 19:49:20 INFO - trying https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 19:49:20 INFO - Downloading https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 19:49:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:49:21 INFO - Downloaded 1361 bytes. 19:49:21 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 19:49:21 INFO - Using the following test package requirements: 19:49:21 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 19:49:21 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:49:21 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 19:49:21 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:49:21 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 19:49:21 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:49:21 INFO - u'jsshell-linux-x86_64.zip'], 19:49:21 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:49:21 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 19:49:21 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 19:49:21 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:49:21 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 19:49:21 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:49:21 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 19:49:21 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:49:21 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 19:49:21 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 19:49:21 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 19:49:21 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:49:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 19:49:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:49:21 INFO - Fetch https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 19:49:21 INFO - Expected file size: 21898923 19:49:26 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:49:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 19:49:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:49:26 INFO - Fetch https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 19:49:26 INFO - Expected file size: 21898923 19:49:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 19:49:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:49:31 INFO - Fetch https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 19:49:31 INFO - Expected file size: 14414059 19:49:32 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')]} 19:49:32 INFO - trying https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 19:49:32 INFO - Downloading https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 19:49:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:49:33 INFO - Downloaded 63965472 bytes. 19:49:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 19:49:33 INFO - mkdir: /builds/slave/test/properties 19:49:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:49:33 INFO - Writing to file /builds/slave/test/properties/build_url 19:49:33 INFO - Contents: 19:49:33 INFO - build_url:https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 19:49:34 INFO - Running post-action listener: _resource_record_post_action 19:49:34 INFO - Running post-action listener: set_extra_try_arguments 19:49:34 INFO - [mozharness: 2016-09-27 02:49:34.166017Z] Finished download-and-extract step (success) 19:49:34 INFO - [mozharness: 2016-09-27 02:49:34.166319Z] Running populate-webroot step. 19:49:34 INFO - Running pre-action listener: _resource_record_pre_action 19:49:34 INFO - Running main action method: populate_webroot 19:49:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:49:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:49:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:49:34 INFO - '--tppagecycles', 19:49:34 INFO - '7'], 19:49:34 INFO - 'tests': ['tsvgm']}}, 19:49:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:49:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:49:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:49:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:49:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:49:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:49:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:34 INFO - 'talos_options': ['--disable-e10s'], 19:49:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:49:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:49:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:34 INFO - 'talos_options': ['--disable-e10s'], 19:49:34 INFO - 'tests': ['damp', 'tps']}, 19:49:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:34 INFO - 'tests': ['damp', 'tps']}, 19:49:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:49:34 INFO - 'tests': ['dromaeo_dom']}, 19:49:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:49:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:49:34 INFO - 'tests': ['basic_compositor_video']}, 19:49:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:49:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:49:34 INFO - 'tests': ['a11yr', 19:49:34 INFO - 'ts_paint', 19:49:34 INFO - 'tpaint', 19:49:34 INFO - 'sessionrestore', 19:49:34 INFO - 'sessionrestore_no_auto_restore', 19:49:34 INFO - 'tabpaint']}, 19:49:34 INFO - 'other-e10s': {'tests': ['a11yr', 19:49:34 INFO - 'ts_paint', 19:49:34 INFO - 'tpaint', 19:49:34 INFO - 'sessionrestore', 19:49:34 INFO - 'sessionrestore_no_auto_restore', 19:49:34 INFO - 'tabpaint']}, 19:49:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:49:34 INFO - 'ts_paint', 19:49:34 INFO - 'tpaint', 19:49:34 INFO - 'sessionrestore', 19:49:34 INFO - 'sessionrestore_no_auto_restore', 19:49:34 INFO - 'tabpaint']}, 19:49:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:49:34 INFO - 'ts_paint', 19:49:34 INFO - 'tpaint', 19:49:34 INFO - 'sessionrestore', 19:49:34 INFO - 'sessionrestore_no_auto_restore', 19:49:34 INFO - 'tabpaint']}, 19:49:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:49:34 INFO - 'tests': ['a11yr', 19:49:34 INFO - 'ts_paint', 19:49:34 INFO - 'tpaint', 19:49:34 INFO - 'sessionrestore', 19:49:34 INFO - 'sessionrestore_no_auto_restore', 19:49:34 INFO - 'tabpaint']}, 19:49:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:49:34 INFO - 'tests': ['a11yr', 19:49:34 INFO - 'ts_paint', 19:49:34 INFO - 'tpaint', 19:49:34 INFO - 'sessionrestore', 19:49:34 INFO - 'sessionrestore_no_auto_restore', 19:49:34 INFO - 'tabpaint']}, 19:49:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:49:34 INFO - 'tests': ['tsvgx', 19:49:34 INFO - 'tsvgr_opacity', 19:49:34 INFO - 'tart', 19:49:34 INFO - 'tscrollx', 19:49:34 INFO - 'cart']}, 19:49:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:49:34 INFO - 'tsvgr_opacity', 19:49:34 INFO - 'tart', 19:49:34 INFO - 'tscrollx', 19:49:34 INFO - 'cart']}, 19:49:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:34 INFO - 'talos_options': ['--disable-e10s'], 19:49:34 INFO - 'tests': ['tp5o']}, 19:49:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:34 INFO - 'tests': ['tp5o']}, 19:49:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:34 INFO - 'talos_options': ['--disable-e10s', 19:49:34 INFO - '--xperf_path', 19:49:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:49:34 INFO - 'tests': ['tp5n']}, 19:49:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:34 INFO - 'talos_options': ['--xperf_path', 19:49:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:49:34 INFO - 'tests': ['tp5n']}}, 19:49:34 INFO - 'talos.zip': {'path': '', 19:49:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:49:34 INFO - Running post-action listener: _resource_record_post_action 19:49:34 INFO - [mozharness: 2016-09-27 02:49:34.189050Z] Finished populate-webroot step (success) 19:49:34 INFO - [mozharness: 2016-09-27 02:49:34.189143Z] Running create-virtualenv step. 19:49:34 INFO - Running pre-action listener: _resource_record_pre_action 19:49:34 INFO - Running main action method: create_virtualenv 19:49:34 INFO - Creating virtualenv /builds/slave/test/build/venv 19:49:34 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 19:49:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:49:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:49:34 INFO - Using real prefix '/usr' 19:49:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:49:34 INFO - Installing distribute.............................................................................................................................................................................................done. 19:49:36 INFO - Installing pip.................done. 19:49:36 INFO - Return code: 0 19:49:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:49: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')]} 19:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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')]} 19:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe00094ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1992ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ff60>, '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 0x1990d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19911d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', '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 19:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:49:36 INFO - Using env: {'DISPLAY': ':0', 19:49:36 INFO - 'HOME': '/home/cltbld', 19:49:36 INFO - 'LANG': 'en_US.UTF-8', 19:49:36 INFO - 'LANGUAGE': 'en_US:en', 19:49:36 INFO - 'LOGNAME': 'cltbld', 19:49:36 INFO - 'MAIL': '/var/mail/cltbld', 19:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:36 INFO - 'MOZ_NO_REMOTE': '1', 19:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:36 INFO - 'NO_EM_RESTART': '1', 19:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:36 INFO - 'PWD': '/builds/slave/test', 19:49:36 INFO - 'SHELL': '/bin/bash', 19:49:36 INFO - 'SHLVL': '1', 19:49:36 INFO - 'TERM': 'linux', 19:49:36 INFO - 'TMOUT': '86400', 19:49:36 INFO - 'USER': 'cltbld', 19:49:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', 19:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:36 INFO - '_': '/tools/buildbot/bin/python'} 19:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:36 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 19:49:36 INFO - Cleaning up... 19:49:36 INFO - Return code: 0 19:49:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:49: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')]} 19:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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')]} 19:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe00094ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1992ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ff60>, '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 0x1990d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19911d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', '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 19:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:49:36 INFO - Using env: {'DISPLAY': ':0', 19:49:36 INFO - 'HOME': '/home/cltbld', 19:49:37 INFO - 'LANG': 'en_US.UTF-8', 19:49:37 INFO - 'LANGUAGE': 'en_US:en', 19:49:37 INFO - 'LOGNAME': 'cltbld', 19:49:37 INFO - 'MAIL': '/var/mail/cltbld', 19:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:37 INFO - 'MOZ_NO_REMOTE': '1', 19:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:37 INFO - 'NO_EM_RESTART': '1', 19:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:37 INFO - 'PWD': '/builds/slave/test', 19:49:37 INFO - 'SHELL': '/bin/bash', 19:49:37 INFO - 'SHLVL': '1', 19:49:37 INFO - 'TERM': 'linux', 19:49:37 INFO - 'TMOUT': '86400', 19:49:37 INFO - 'USER': 'cltbld', 19:49:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', 19:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:37 INFO - '_': '/tools/buildbot/bin/python'} 19:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:37 INFO - Downloading/unpacking psutil>=3.1.1 19:49:37 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 19:49:37 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 19:49:37 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 19:49:37 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 19:49:37 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 19:49:37 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 19:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:49:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:49:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:49:39 INFO - Installing collected packages: psutil 19:49:39 INFO - Running setup.py install for psutil 19:49:39 INFO - building 'psutil._psutil_linux' extension 19:49:39 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 19:49:39 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 19:49:39 INFO - building 'psutil._psutil_posix' extension 19:49:39 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 19:49:39 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 19:49:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:49:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:49:39 INFO - Successfully installed psutil 19:49:39 INFO - Cleaning up... 19:49:39 INFO - Return code: 0 19:49:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe00094ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1992ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ff60>, '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 0x1990d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19911d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', '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 19:49:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:49:39 INFO - Using env: {'DISPLAY': ':0', 19:49:39 INFO - 'HOME': '/home/cltbld', 19:49:39 INFO - 'LANG': 'en_US.UTF-8', 19:49:39 INFO - 'LANGUAGE': 'en_US:en', 19:49:39 INFO - 'LOGNAME': 'cltbld', 19:49:39 INFO - 'MAIL': '/var/mail/cltbld', 19:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:39 INFO - 'MOZ_NO_REMOTE': '1', 19:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:39 INFO - 'NO_EM_RESTART': '1', 19:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:39 INFO - 'PWD': '/builds/slave/test', 19:49:39 INFO - 'SHELL': '/bin/bash', 19:49:39 INFO - 'SHLVL': '1', 19:49:39 INFO - 'TERM': 'linux', 19:49:39 INFO - 'TMOUT': '86400', 19:49:39 INFO - 'USER': 'cltbld', 19:49:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', 19:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:39 INFO - '_': '/tools/buildbot/bin/python'} 19:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:49:41 INFO - Installing collected packages: mozsystemmonitor 19:49:41 INFO - Running setup.py install for mozsystemmonitor 19:49:42 INFO - Successfully installed mozsystemmonitor 19:49:42 INFO - Cleaning up... 19:49:42 INFO - Return code: 0 19:49:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:42 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 0x7fe00094ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1992ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ff60>, '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 0x1990d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19911d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', '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 19:49:42 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 19:49:42 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 19:49:42 INFO - Using env: {'DISPLAY': ':0', 19:49:42 INFO - 'HOME': '/home/cltbld', 19:49:42 INFO - 'LANG': 'en_US.UTF-8', 19:49:42 INFO - 'LANGUAGE': 'en_US:en', 19:49:42 INFO - 'LOGNAME': 'cltbld', 19:49:42 INFO - 'MAIL': '/var/mail/cltbld', 19:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:42 INFO - 'MOZ_NO_REMOTE': '1', 19:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:42 INFO - 'NO_EM_RESTART': '1', 19:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:42 INFO - 'PWD': '/builds/slave/test', 19:49:42 INFO - 'SHELL': '/bin/bash', 19:49:42 INFO - 'SHLVL': '1', 19:49:42 INFO - 'TERM': 'linux', 19:49:42 INFO - 'TMOUT': '86400', 19:49:42 INFO - 'USER': 'cltbld', 19:49:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', 19:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:42 INFO - '_': '/tools/buildbot/bin/python'} 19:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:42 INFO - Downloading/unpacking jsonschema==2.5.1 19:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:49:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:49:44 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 19:49:44 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 19:49:44 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 19:49:44 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 19:49:44 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 19:49:44 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 19:49:44 INFO - Downloading functools32-3.2.3-2.tar.gz 19:49:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:49:44 INFO - warning: no files found matching '*.txt' 19:49:44 INFO - no previously-included directories found matching 'build' 19:49:44 INFO - no previously-included directories found matching 'dist' 19:49:44 INFO - no previously-included directories found matching '.git*' 19:49:44 INFO - Installing collected packages: jsonschema, functools32 19:49:44 INFO - Running setup.py install for functools32 19:49:44 INFO - warning: no files found matching '*.txt' 19:49:44 INFO - no previously-included directories found matching 'build' 19:49:44 INFO - no previously-included directories found matching 'dist' 19:49:44 INFO - no previously-included directories found matching '.git*' 19:49:44 INFO - Successfully installed jsonschema functools32 19:49:44 INFO - Cleaning up... 19:49:44 INFO - Return code: 0 19:49:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:49:44 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')]} 19:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:44 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')]} 19:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:44 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 0x7fe00094ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1992ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ff60>, '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 0x1990d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19911d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', '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 19:49:44 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 19:49:44 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 19:49:44 INFO - Using env: {'DISPLAY': ':0', 19:49:44 INFO - 'HOME': '/home/cltbld', 19:49:44 INFO - 'LANG': 'en_US.UTF-8', 19:49:44 INFO - 'LANGUAGE': 'en_US:en', 19:49:44 INFO - 'LOGNAME': 'cltbld', 19:49:44 INFO - 'MAIL': '/var/mail/cltbld', 19:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:44 INFO - 'MOZ_NO_REMOTE': '1', 19:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:44 INFO - 'NO_EM_RESTART': '1', 19:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:44 INFO - 'PWD': '/builds/slave/test', 19:49:44 INFO - 'SHELL': '/bin/bash', 19:49:44 INFO - 'SHLVL': '1', 19:49:44 INFO - 'TERM': 'linux', 19:49:44 INFO - 'TMOUT': '86400', 19:49:44 INFO - 'USER': 'cltbld', 19:49:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', 19:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:44 INFO - '_': '/tools/buildbot/bin/python'} 19:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:49:44 INFO - Cleaning up... 19:49:44 INFO - Return code: 0 19:49:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:49:44 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')]} 19:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:44 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')]} 19:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:44 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 0x7fe00094ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1992ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ff60>, '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 0x1990d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19911d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', '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 19:49:44 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 19:49:44 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 19:49:44 INFO - Using env: {'DISPLAY': ':0', 19:49:44 INFO - 'HOME': '/home/cltbld', 19:49:44 INFO - 'LANG': 'en_US.UTF-8', 19:49:44 INFO - 'LANGUAGE': 'en_US:en', 19:49:44 INFO - 'LOGNAME': 'cltbld', 19:49:44 INFO - 'MAIL': '/var/mail/cltbld', 19:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:44 INFO - 'MOZ_NO_REMOTE': '1', 19:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:44 INFO - 'NO_EM_RESTART': '1', 19:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:44 INFO - 'PWD': '/builds/slave/test', 19:49:44 INFO - 'SHELL': '/bin/bash', 19:49:44 INFO - 'SHLVL': '1', 19:49:44 INFO - 'TERM': 'linux', 19:49:44 INFO - 'TMOUT': '86400', 19:49:44 INFO - 'USER': 'cltbld', 19:49:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', 19:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:44 INFO - '_': '/tools/buildbot/bin/python'} 19:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:45 INFO - Downloading/unpacking blobuploader==1.2.4 19:49:45 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 19:49:45 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 19:49:45 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 19:49:45 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 19:49:45 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 19:49:45 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 19:49:46 INFO - Downloading blobuploader-1.2.4.tar.gz 19:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:49:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:49:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:47 INFO - Downloading docopt-0.6.1.tar.gz 19:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:49:47 INFO - Installing collected packages: blobuploader, requests, docopt 19:49:47 INFO - Running setup.py install for blobuploader 19:49:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:49:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:49:47 INFO - Running setup.py install for requests 19:49:48 INFO - Running setup.py install for docopt 19:49:48 INFO - Successfully installed blobuploader requests docopt 19:49:48 INFO - Cleaning up... 19:49:48 INFO - Return code: 0 19:49:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:49: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')]} 19:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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')]} 19:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:48 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 0x7fe00094ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1992ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ff60>, '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 0x1990d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19911d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', '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 19:49:48 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 19:49:48 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 19:49:48 INFO - Using env: {'DISPLAY': ':0', 19:49:48 INFO - 'HOME': '/home/cltbld', 19:49:48 INFO - 'LANG': 'en_US.UTF-8', 19:49:48 INFO - 'LANGUAGE': 'en_US:en', 19:49:48 INFO - 'LOGNAME': 'cltbld', 19:49:48 INFO - 'MAIL': '/var/mail/cltbld', 19:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:48 INFO - 'MOZ_NO_REMOTE': '1', 19:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:48 INFO - 'NO_EM_RESTART': '1', 19:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:48 INFO - 'PWD': '/builds/slave/test', 19:49:48 INFO - 'SHELL': '/bin/bash', 19:49:48 INFO - 'SHLVL': '1', 19:49:48 INFO - 'TERM': 'linux', 19:49:48 INFO - 'TMOUT': '86400', 19:49:48 INFO - 'USER': 'cltbld', 19:49:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', 19:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:48 INFO - '_': '/tools/buildbot/bin/python'} 19:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:49:48 INFO - Running setup.py (path:/tmp/pip-3ehhK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:49:48 INFO - Running setup.py (path:/tmp/pip-6VgYrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:49:48 INFO - Running setup.py (path:/tmp/pip-iDtlCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:49:48 INFO - Running setup.py (path:/tmp/pip-VTFUio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:49:48 INFO - Running setup.py (path:/tmp/pip-EAzfZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:49:48 INFO - Running setup.py (path:/tmp/pip-Nun6sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:49:48 INFO - Running setup.py (path:/tmp/pip-hD44Pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:49:49 INFO - Running setup.py (path:/tmp/pip-368mZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:49:49 INFO - Running setup.py (path:/tmp/pip-Ppu32r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:49:49 INFO - Running setup.py (path:/tmp/pip-czeJcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:49:49 INFO - Running setup.py (path:/tmp/pip-U2ZA3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:49:49 INFO - Running setup.py (path:/tmp/pip-RDkpZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:49:49 INFO - Running setup.py (path:/tmp/pip-kPk0VL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:49:49 INFO - Running setup.py (path:/tmp/pip-f6QcoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:49:49 INFO - Running setup.py (path:/tmp/pip-VxRSYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:49:49 INFO - Running setup.py (path:/tmp/pip-G5hT20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:49:49 INFO - Running setup.py (path:/tmp/pip-mryZLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:49:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:49:49 INFO - Running setup.py install for manifestparser 19:49:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:49:49 INFO - Running setup.py install for mozcrash 19:49:49 INFO - Running setup.py install for mozdebug 19:49:50 INFO - Running setup.py install for mozdevice 19:49:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:49:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:49:50 INFO - Running setup.py install for mozfile 19:49:50 INFO - Running setup.py install for mozhttpd 19:49:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:49:50 INFO - Running setup.py install for mozinfo 19:49:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:49:50 INFO - Running setup.py install for mozInstall 19:49:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:49:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:49:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:49:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:49:50 INFO - Running setup.py install for mozleak 19:49:50 INFO - Running setup.py install for mozlog 19:49:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:49:50 INFO - Running setup.py install for moznetwork 19:49:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:49:50 INFO - Running setup.py install for mozprocess 19:49:51 INFO - Running setup.py install for mozprofile 19:49:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:49:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:49:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:49:51 INFO - Running setup.py install for mozrunner 19:49:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:49:51 INFO - Running setup.py install for mozscreenshot 19:49:51 INFO - Running setup.py install for moztest 19:49:51 INFO - Running setup.py install for mozversion 19:49:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:49:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:49:51 INFO - Cleaning up... 19:49:51 INFO - Return code: 0 19:49:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:51 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 0x7fe00094ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1992ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ff60>, '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 0x1990d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19911d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', '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 19:49:51 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 19:49:51 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 19:49:51 INFO - Using env: {'DISPLAY': ':0', 19:49:51 INFO - 'HOME': '/home/cltbld', 19:49:51 INFO - 'LANG': 'en_US.UTF-8', 19:49:51 INFO - 'LANGUAGE': 'en_US:en', 19:49:51 INFO - 'LOGNAME': 'cltbld', 19:49:51 INFO - 'MAIL': '/var/mail/cltbld', 19:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:51 INFO - 'MOZ_NO_REMOTE': '1', 19:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:51 INFO - 'NO_EM_RESTART': '1', 19:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:51 INFO - 'PWD': '/builds/slave/test', 19:49:51 INFO - 'SHELL': '/bin/bash', 19:49:51 INFO - 'SHLVL': '1', 19:49:51 INFO - 'TERM': 'linux', 19:49:51 INFO - 'TMOUT': '86400', 19:49:51 INFO - 'USER': 'cltbld', 19:49:51 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', 19:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:51 INFO - '_': '/tools/buildbot/bin/python'} 19:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:49:51 INFO - Running setup.py (path:/tmp/pip-BLiS9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:49:51 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)) 19:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:49:51 INFO - Running setup.py (path:/tmp/pip-qbNgl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:49:51 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)) 19:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:49:51 INFO - Running setup.py (path:/tmp/pip-XAVe17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:49:52 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)) 19:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:49:52 INFO - Running setup.py (path:/tmp/pip-plYFm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:49:52 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)) 19:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:49:52 INFO - Running setup.py (path:/tmp/pip-7nApdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:49:52 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)) 19:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:49:52 INFO - Running setup.py (path:/tmp/pip-j2OUuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:49:52 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)) 19:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:49:52 INFO - Running setup.py (path:/tmp/pip-Tx_XlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:49:52 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)) 19:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:49:52 INFO - Running setup.py (path:/tmp/pip-HsUjQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:49:52 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)) 19:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:49:52 INFO - Running setup.py (path:/tmp/pip-DiOo0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:49:52 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)) 19:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:49:52 INFO - Running setup.py (path:/tmp/pip-Zwi7vQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:49:52 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)) 19:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:49:52 INFO - Running setup.py (path:/tmp/pip-bj1USG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:49:52 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)) 19:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:49:52 INFO - Running setup.py (path:/tmp/pip-E9O3R3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:49:52 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)) 19:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:49:52 INFO - Running setup.py (path:/tmp/pip-kqjjus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:49:52 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)) 19:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:49:52 INFO - Running setup.py (path:/tmp/pip-l3hSio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:49:52 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)) 19:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:49:52 INFO - Running setup.py (path:/tmp/pip-fjEujg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:49:52 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)) 19:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:49:52 INFO - Running setup.py (path:/tmp/pip-i1dezz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:49:52 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)) 19:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:49:52 INFO - Running setup.py (path:/tmp/pip-7LeqDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:49:53 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)) 19:49:53 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)) 19:49:53 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)) 19:49:53 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)) 19:49:53 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)) 19:49:53 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)) 19:49:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:54 INFO - Downloading blessings-1.6.tar.gz 19:49:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:49:55 INFO - Installing collected packages: blessings 19:49:55 INFO - Running setup.py install for blessings 19:49:55 INFO - Successfully installed blessings 19:49:55 INFO - Cleaning up... 19:49:55 INFO - Return code: 0 19:49:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:49:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:49:55 INFO - Reading from file tmpfile_stdout 19:49:55 INFO - Current package versions: 19:49:55 INFO - argparse == 1.2.1 19:49:55 INFO - blessings == 1.6 19:49:55 INFO - blobuploader == 1.2.4 19:49:55 INFO - docopt == 0.6.1 19:49:55 INFO - functools32 == 3.2.3-2 19:49:55 INFO - jsonschema == 2.5.1 19:49:55 INFO - manifestparser == 1.1 19:49:55 INFO - mozInstall == 1.12 19:49:55 INFO - mozcrash == 0.17 19:49:55 INFO - mozdebug == 0.1 19:49:55 INFO - mozdevice == 0.48 19:49:55 INFO - mozfile == 1.2 19:49:55 INFO - mozhttpd == 0.7 19:49:55 INFO - mozinfo == 0.9 19:49:55 INFO - mozleak == 0.1 19:49:55 INFO - mozlog == 3.4 19:49:55 INFO - moznetwork == 0.27 19:49:55 INFO - mozprocess == 0.23 19:49:55 INFO - mozprofile == 0.28 19:49:55 INFO - mozrunner == 6.12 19:49:55 INFO - mozscreenshot == 0.1 19:49:55 INFO - mozsystemmonitor == 0.3 19:49:55 INFO - moztest == 0.7 19:49:55 INFO - mozversion == 1.4 19:49:55 INFO - psutil == 3.1.1 19:49:55 INFO - requests == 1.2.3 19:49:55 INFO - wsgiref == 0.1.2 19:49:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:49:55 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')]} 19:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:55 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')]} 19:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:55 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 0x7fe00094ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1992ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ff60>, '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 0x1990d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19911d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', '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 19:49:55 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 19:49:55 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 19:49:55 INFO - Using env: {'DISPLAY': ':0', 19:49:55 INFO - 'HOME': '/home/cltbld', 19:49:55 INFO - 'LANG': 'en_US.UTF-8', 19:49:55 INFO - 'LANGUAGE': 'en_US:en', 19:49:55 INFO - 'LOGNAME': 'cltbld', 19:49:55 INFO - 'MAIL': '/var/mail/cltbld', 19:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:55 INFO - 'MOZ_NO_REMOTE': '1', 19:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:55 INFO - 'NO_EM_RESTART': '1', 19:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:55 INFO - 'PWD': '/builds/slave/test', 19:49:55 INFO - 'SHELL': '/bin/bash', 19:49:55 INFO - 'SHLVL': '1', 19:49:55 INFO - 'TERM': 'linux', 19:49:55 INFO - 'TMOUT': '86400', 19:49:55 INFO - 'USER': 'cltbld', 19:49:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', 19:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:55 INFO - '_': '/tools/buildbot/bin/python'} 19:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:55 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)) 19:49:55 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)) 19:49:55 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)) 19:49:55 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)) 19:49:55 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)) 19:49:55 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)) 19:49:55 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)) 19:49:55 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)) 19:49:55 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)) 19:49:55 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)) 19:49:55 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)) 19:49:55 INFO - Cleaning up... 19:49:55 INFO - Return code: 0 19:49:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:49:55 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')]} 19:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:55 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')]} 19:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:55 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 0x7fe00094ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1992ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x198ff60>, '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 0x1990d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19911d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', '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 19:49:55 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 19:49:55 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 19:49:55 INFO - Using env: {'DISPLAY': ':0', 19:49:55 INFO - 'HOME': '/home/cltbld', 19:49:55 INFO - 'LANG': 'en_US.UTF-8', 19:49:55 INFO - 'LANGUAGE': 'en_US:en', 19:49:55 INFO - 'LOGNAME': 'cltbld', 19:49:55 INFO - 'MAIL': '/var/mail/cltbld', 19:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:55 INFO - 'MOZ_NO_REMOTE': '1', 19:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:49:55 INFO - 'NO_EM_RESTART': '1', 19:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:55 INFO - 'PWD': '/builds/slave/test', 19:49:55 INFO - 'SHELL': '/bin/bash', 19:49:55 INFO - 'SHLVL': '1', 19:49:55 INFO - 'TERM': 'linux', 19:49:55 INFO - 'TMOUT': '86400', 19:49:55 INFO - 'USER': 'cltbld', 19:49:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', 19:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:55 INFO - '_': '/tools/buildbot/bin/python'} 19:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:49:55 INFO - Cleaning up... 19:49:55 INFO - Return code: 0 19:49:55 INFO - Running post-action listener: _resource_record_post_action 19:49:55 INFO - Running post-action listener: _start_resource_monitoring 19:49:55 INFO - Starting resource monitoring. 19:49:55 INFO - [mozharness: 2016-09-27 02:49:55.880348Z] Finished create-virtualenv step (success) 19:49:55 INFO - [mozharness: 2016-09-27 02:49:55.880803Z] Running install step. 19:49:55 INFO - Running pre-action listener: _resource_record_pre_action 19:49:55 INFO - Running main action method: install 19:49:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:49:56 INFO - Reading from file tmpfile_stdout 19:49:56 INFO - Detecting whether we're running mozinstall >=1.0... 19:49:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:49:56 INFO - Reading from file tmpfile_stdout 19:49:56 INFO - Output received: 19:49:56 INFO - Usage: mozinstall [options] installer 19:49:56 INFO - Options: 19:49:56 INFO - -h, --help show this help message and exit 19:49:56 INFO - -d DEST, --destination=DEST 19:49:56 INFO - Directory to install application into. [default: 19:49:56 INFO - "/builds/slave/test"] 19:49:56 INFO - --app=APP Application being installed. [default: firefox] 19:49:56 INFO - mkdir: /builds/slave/test/build/application 19:49:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:50:12 INFO - Reading from file tmpfile_stdout 19:50:12 INFO - Output received: 19:50:12 INFO - /builds/slave/test/build/application/firefox/firefox 19:50:12 INFO - Running post-action listener: _resource_record_post_action 19:50:12 INFO - [mozharness: 2016-09-27 02:50:12.122046Z] Finished install step (success) 19:50:12 INFO - [mozharness: 2016-09-27 02:50:12.122295Z] Running run-tests step. 19:50:12 INFO - Running pre-action listener: _resource_record_pre_action 19:50:12 INFO - Running main action method: run_tests 19:50:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:50:12 INFO - Python 2.7.3 19:50:12 INFO - Return code: 0 19:50:12 INFO - grabbing minidump binary from tooltool 19:50: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')]} 19:50:12 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 0x198ff60>, '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 0x1990d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19911d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:50:12 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 19:50:12 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 19:50:12 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 19:50:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:50:12 INFO - Return code: 0 19:50:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:50:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:50:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:50:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:50:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:50:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:50:12 INFO - Using env: {'DISPLAY': ':0', 19:50:12 INFO - 'HOME': '/home/cltbld', 19:50:12 INFO - 'LANG': 'en_US.UTF-8', 19:50:12 INFO - 'LANGUAGE': 'en_US:en', 19:50:12 INFO - 'LOGNAME': 'cltbld', 19:50:12 INFO - 'MAIL': '/var/mail/cltbld', 19:50:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:50:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:12 INFO - 'MOZ_NO_REMOTE': '1', 19:50:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:50:12 INFO - 'NO_EM_RESTART': '1', 19:50:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:12 INFO - 'PWD': '/builds/slave/test', 19:50:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:50:12 INFO - 'SHELL': '/bin/bash', 19:50:12 INFO - 'SHLVL': '1', 19:50:12 INFO - 'TERM': 'linux', 19:50:12 INFO - 'TMOUT': '86400', 19:50:12 INFO - 'USER': 'cltbld', 19:50:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053', 19:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:12 INFO - '_': '/tools/buildbot/bin/python'} 19:50:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:50:12 INFO - mozversion application_buildid: 20160926154649 19:50:12 INFO - mozversion application_changeset: 92d639e21ef43fff9aef06b039a4da3666ef1f93 19:50:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:50:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:50:12 INFO - mozversion application_name: Firefox 19:50:12 INFO - mozversion application_remotingname: firefox-dev 19:50:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:50:12 INFO - mozversion application_vendor: Mozilla 19:50:12 INFO - mozversion application_version: 51.0a2 19:50:12 INFO - mozversion platform_buildid: 20160926154649 19:50:12 INFO - mozversion platform_changeset: 92d639e21ef43fff9aef06b039a4da3666ef1f93 19:50:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:50:12 INFO - mozversion platform_version: 51.0a2 19:50:12 INFO - using testdate: 1474944612 19:50:12 INFO - actual date: 1474944612 19:50:12 INFO - starting webserver on 'localhost:41199' 19:50:12 INFO - SUITE-START | Running 2 tests 19:50:12 INFO - TEST-START | dromaeo_css 19:50:12 INFO - operating with platform_type : linux_ 19:50:12 INFO - Initialising browser for dromaeo_css test... 19:50:12 INFO - TEST-INFO | started process 13754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqhlIlg/profile http://localhost:41199/getInfo.html) 19:50:17 INFO - PROCESS | 13754 | __metrics Screen width/height:1600/1200 19:50:17 INFO - PROCESS | 13754 | colorDepth:24 19:50:17 INFO - PROCESS | 13754 | Browser inner width/height: 1024/697 19:50:17 INFO - PROCESS | 13754 | __metrics 19:50:18 INFO - PROCESS | 13754 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:50:18 INFO - PROCESS | 13754 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:50:18 INFO - PROCESS | 13754 | console.error: PushService: 19:50:18 INFO - PROCESS | 13754 | stateChangeProcessEnqueue: Error transitioning state 19:50:18 INFO - PROCESS | 13754 | UnknownError 19:50:19 INFO - TEST-INFO | 13754: exit 0 19:50:19 INFO - Browser initialized. 19:50:19 INFO - Running cycle 1/1 for dromaeo_css test... 19:50:19 INFO - TEST-INFO | started process 13843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqhlIlg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:50:31 INFO - PROCESS | 13843 | RSS: Main: 144760832 19:50:31 INFO - PROCESS | 13843 | 19:51:22 INFO - PROCESS | 13843 | 1474944682076 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] 19:53:31 INFO - PROCESS | 13843 | Cycle 1(1): loaded http://localhost:41199/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41199/tests/dromaeo/cssquery-ext.html) 19:53:32 INFO - PROCESS | 13843 | RSS: Main: 237412352 19:53:32 INFO - PROCESS | 13843 | 19:56:34 INFO - PROCESS | 13843 | Cycle 1(1): loaded http://localhost:41199/tests/dromaeo/cssquery-ext.html (next: http://localhost:41199/tests/dromaeo/cssquery-jquery.html) 19:56:35 INFO - PROCESS | 13843 | RSS: Main: 231149568 19:56:35 INFO - PROCESS | 13843 | 19:59:37 INFO - PROCESS | 13843 | Cycle 1(1): loaded http://localhost:41199/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41199/tests/dromaeo/cssquery-mootools.html) 19:59:37 INFO - PROCESS | 13843 | RSS: Main: 204955648 19:59:37 INFO - PROCESS | 13843 | 20:02:39 INFO - PROCESS | 13843 | Cycle 1(1): loaded http://localhost:41199/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41199/tests/dromaeo/cssquery-prototype.html) 20:02:40 INFO - PROCESS | 13843 | RSS: Main: 172830720 20:02:40 INFO - PROCESS | 13843 | 20:05:42 INFO - PROCESS | 13843 | Cycle 1(1): loaded http://localhost:41199/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41199/tests/dromaeo/cssquery-yui.html) 20:05:43 INFO - PROCESS | 13843 | RSS: Main: 175988736 20:05:43 INFO - PROCESS | 13843 | 20:08:46 INFO - PROCESS | 13843 | Cycle 1(1): loaded http://localhost:41199/tests/dromaeo/cssquery-yui.html (next: http://localhost:41199/tests/dromaeo/cssquery-dojo.html) 20:08:46 INFO - PROCESS | 13843 | RSS: Main: 259395584 20:08:46 INFO - PROCESS | 13843 | 20:08:46 INFO - PROCESS | 13843 | __start_tp_report 20:08:46 INFO - PROCESS | 13843 | _x_x_mozilla_page_load 20:08:46 INFO - PROCESS | 13843 | _x_x_mozilla_page_load_details 20:08:46 INFO - PROCESS | 13843 | |i|pagename|runs| 20:08:46 INFO - PROCESS | 13843 | |0;dojo.html;3116.657167711552;3146.874125034998;3165.540996555501;3181.5704879841214;3199.6960288772557;5551.888962220758;5599.804006859761;5626;5632.127020311848;5648.491635752782;5545.445455454453;5583.413741557139;5598.804041858536;5614.185943038257;5626.718664066801;5041;5069.188929771238;5101.438841727407;5147.1764517677175;5159.303494028314;4909.165441874872;4947.406311242656;5122.078025955345;5178.922316165242;5180.689158650474;4987.600991920638;4991.450940396553;5032.84901452957;5058.24126381044;5061.898762024757;5020.347354843865;5046.343975283226;5052.646314757969;5117.1556693145585;5135.948640513584;4962.330085438456;5048.14181589127;5065.39215294167;5073.3911930568565;5078.898422031539;5270.789168433296;5295.443978382292;5453.127499600085;5478.972605136989;5527.55779537636;5940.881182376328;5956.52347812174;5958.5828991970575;5963.821085367446;5974.402559744034;5984;5993.850153746148;6004.729787159588;6005.039193728982;6005.729742161569;5491.121420572689;5540.058190107651;5542.63972841764;5565.193047008162;5570.61005729595;6152.230971128609;6158.291796443376;6158.891399548124;6167.982282923267;6168.0439531872635;5900.675462849498;5911.822645320647;5914.9112763308585;5918.2898052234;5942.37605051472;5691.459311365414;5692.772289108472;5739.196512488255;5806.071028635398;5970.253718285215;5790.36306006339;5846.532277417797;5849;5876.529877609781;5887.587868849139;5863.2670916135485;5870.941290587125;5877.970610146922;5883.17635531026;5910.113482977587;4487.214737420938;4499.437570303712;4516.9774151129695;4518.367428560005;4528.547145285445;3975.6223158799867;4035.071933455322;4057.350823868226;4059.208454351432;4074.6943979201087;5515.503604675519;5515.61390702655;5516.558675305966;5518.365387980353;5529.585281103933;5818.0981947798155;5872.324682661463;5880.029795083763;5895.115732640138;5952.613080149863;5498.422665620133;5508.20131080991;5526.50261476469;5587.938291724559;5626.043572592669;5109.233614957786;5111.87857039332;5113.437521872591;5160.612954028463;5160.8967820643375;6003.879922401615;6156.107364432132;6161;6163.9383606163365;6167.105769663373;5799;5848.093545500455;5851.151583020353;5888.381719919518;5957.225560677084;6061.302950160788;6071.7571297147615;6073.969630151998;6085.786997455068;6087.57386982907;5727.914081288701;5788.392218817132;5806.593538452268;5811.4479124483105;5815.127730840408;5841.707914604338;5895.7052147393315;5937;5978.103284507185;5996.820095397145;5885.793997210077;5910.408959104056;5931.258592675916;5932.16949627044;5944.494717949023;5931.377205393372;5938.079597662369;5940.227770389822;5941.58408911372;5943.732532036155;5602.971985140048;5645.971770141123;5665.518430933252;5665.546756259407;5845.736941837543;5771.8557036074435;5773.018586840331;5784.421557844182;5809.651420914759;5812.709364531841;5611.943880561143;5653.802116925888;5672.290963629546;5674.74463649145;5679.858003549944 20:08:46 INFO - PROCESS | 13843 | |1;ext.html;588.7321268822686;611.1993288791685;612.5620181570176;623.7536173211579;648.147685793182;32946.67053329466;36751.81624091879;46442.07115857685;47166.52833471664;47463.288050679264;47982.76008619961;48558.271625925554;48677.75661121698;48745.26882096763;48774.51225487744;9164.633414663422;9309.534523273844;9315.161635452809;9316.487593182372;9319.720408387726;8416.495010299372;8634.179752923463;10819.78360432791;11064.944675276613;11079.224454288164;11280.323180609148;11300.265482743636;11357.148213883951;11366.488508017117;11373.033292170176;11104.888951110506;11157.442127893573;11173.664790056271;11185.32888026721;11209.831852522218;10943.4528273586;10951.561937522489;11034.779304413867;11034.944825275823;11039.944800275947;46006.53993460056;46075.53924460746;46383.30425043627;46420.30369544459;46426.53573464256;3903.355946268862;3916.138449541096;3929.3142403974057;4050.432939388488;4095.4471146395153;34001.48997765035;34058.659413405796;34297.31405371879;34380.14049648754;35043.64956350455;4285.271503844354;4316.762578058206;4326.351047342892;4367.410399596078;4411.051623900845;369755;371437;371791;371792;371827;64084.67957660182;64453.35546644474;64478;64481;64509.67745161244;40275.194496109914;41557.79221103875;67539.3246067543;67661.3233867655;67722.3227767716;16658.50024499267;17044.914775426292;17045.659086818196;17046.573835654206;17052.829471705125;10956.726081847859;11125.554977800959;12948.546800861925;13036;13043.956483481299;19671.721338112977;20462.181512739622;20594.176232950813;21350;21396.78603213948;7589.924100759032;7608.80977975544;7632.313091821763;7660.119086305146;7701.801284133187;1033.478093562761;1037.3775734559356;1038.8753349597946;1096.040964156363;1108.4236197177422;33765.83117084399;33809.32381352408;34071.31857362839;34375.31249375048;34640;1120.5741818109066;1132.230083543182;1132.750794825137;1171.988280117205;1197.5090213012622;18065.27738890456;18126.456206313833;18284.725729114074;18289.542761431072;18301.35945241937;607123;612896;613473;615455;617237;62471.687641561504;62774.37225627777;62922.37077629165;62945.685271574264;62998;1285.3573213393304;1338.2505796753849;1352.9458821647024;1411.301405804113;1413.780364827232;29563.40873182567;34852;35087;36527.634723653486;37445;58102.70948645399;58919.41080589139;59039.40960590339;59076.40923590881;59205.111923322045;505225;510431;511009;511479;512401;31295.687043129277;32501.187470312485;32650.83674581612;32745.34509309848;32750.836245818617;51968;51968.22047669212;52016.479835201164;52171.73914130405;52454;43877.56122438735;44679;44742.55257447384;45088;45366.54633453623;43321.13357732891;43647;44055.77972110247;45430.31854522251;45509;43022.11277814672;43783;43984;44649.55350446454;44658;35784.821075894455;38637.61362386453;39121.804390977864;39347.213055739296;39360.701664075845;29164.854175728986;29418.70581294245;29529.409411811215;29646.40707185801;29703.702962970092 20:08:46 INFO - PROCESS | 13843 | |2;jquery.html;398.986035488758;425.15931312934754;427.2331165557823;430.23418315398584;444.70427165934643;15801;20748.688769668468;20934.267300644482;20968.26611068613;21405.67891481629;19799.406017819452;20209.292674756387;20241.190352385926;20320.69518957217;20578;5673.971630141864;5753.5397168226655;5838.2994040715175;5882.911756323659;5892.528597712173;5790.334111577159;5866.853328666774;5867.442592953663;5867.76528938842;5870.794522191724;5603.859903502404;5715.2855893013375;5771.769129234825;5776.422357764232;5784.768609255625;5740.5981581289325;5771.278590176228;5774.97112514439;5780.9710951445395;5832.970835145839;5877.147813567009;6003.519718422559;6003.879922401571;6007.459328660441;6012.30858451275;15069.773953390708;19240.61518769631;19419.32032378874;23883.522329553485;24227.636585451233;2351.0830775997374;2512.0454227393657;2525.305540976228;2586.379268975451;2696.312440327704;11133.33200007994;11195.160362972729;11567.76864462706;11644.534218631245;14261.358238879275;1970.0839109814005;1992.3325685895243;2064.84513661476;2100.5168811173517;2149.0544160569298;84213.57893210556;88199;88654;90322.5483872583;90997.54501227518;12109.515619375303;12125.151239413333;12186.146969712036;12324;12343.814842777365;17423.47729568115;17426.651466970845;17437.302507899796;17458.563535911704;17502.124893755263;8067.3142782864115;8076;8122.837543249102;8229.670813167406;8400.957995209985;7686.116096648957;7764.534127952341;7769.339606133542;7945.443818932619;7958.602069896598;5161.406438259573;5169.819056333085;5224.764885580158;5287.682739035593;5360.785568577213;2091.9163233470795;2121.2681624839406;2133.605283022646;2158.6222411077997;2164.264150188912;969.6363863551169;1017.165923942375;1033.266380869576;1044.1229367331478;1082.7022568793645;20549.58900821975;20850.895745521175;21092.683609745865;21127.471813204793;21294.36116916495;1037.766502536923;1038.5949479702922;1059.6556119261118;1107.429673718036;1135.1089394825024;10980;11499.310041397543;11688;11688.766224675459;11697.2981621103;486353;520405;532958;534631;534736;88973;90231;92119.53940230256;94444.52777736068;95756.52121739487;1010.6361709784619;1024.1806554756165;1027.4913917610681;1032.6179313653995;1038.0501840815568;17694.91152544229;17897.642047159243;18366.908165459623;18490.537736556693;18717.906410467862;42486.78756606197;43193;43463.78268108639;44509.77745111254;44897.55102449065;58912;59817.401825981186;60226.39773602208;60385;60651.393486064575;8241.381896357918;8508.914910850812;8536;8568.400211985101;9349.298802589698;10521.894781052091;13115.868841311465;13825.930870345584;14189.148651080968;14199.29003549839;11077.889221108007;12203;12405.689857753629;12424.689382765504;12721.8091728626;5701.401352858056;9409.576569054272;11681;11771.823422648496;12076.758464830478;12096.45565949552;12279.815802763145;12336.568220112613;12396.628101156979;12679.556215532411;8256.752297431087;8473.195046470575;8676.175763302475;8816.250618697226;8879.778005549913;9648.179904707898;11404.771904562029;11610.071194304604;11853.5851245206;11930.880691192977 20:08:46 INFO - PROCESS | 13843 | |3;mootools.html;1436.0450300550135;1508.1177511155977;1534.294224656658;1692.3484458483488;1818.7726534183219;8535.359848011401;9311.301652376065;9665.710028699134;9679.080487353698;9933.900660993388;9643.469609171492;9717.514124293792;9723.611055557787;9727.756806079851;9728;2593.50723362561;2619.030958545341;2619.4630100829286;2630.88161032754;2637.1561100447866;2554.2848002559313;2611.947761044778;2615.293870654922;2638.1557901471538;2639.656844610198;2575.407656239066;2584.1601479519136;2616.7514086161877;2619.5546757051347;2620.5021046001293;2444.679872868649;2460.2004348586693;2515.421453065805;2517.5720127578265;2518.055729101587;2465.704115506133;2467.148833652387;2467.494163696438;2469.7283298837115;2509.1845150326035;8923.509206993613;9008.45949243041;9036.909630903672;9051.14014168653;9392.389494682891;5653.717314134276;5886.293644762656;5894.97052514739;5896.410358964112;5899.852503687399;3578.35589593873;3609.747317687763;3647.0882279430143;3660.871869484582;3670.2659468106217;1218.65268398506;1222.712662524315;1224.7060705430722;1246.9002479801684;1252.511520507003;12891.16207446513;12984.935075324658;13031.413586388635;13051.412686429134;13058.21650700961;4834.7824347904425;4836.540528649773;4892;4945.590506705644;5089.440161582223;10214;10216.693499195037;10219.7445063874;10224.437655928847;10236.129928955974;5586.55307575393;5586.748596313176;5594.300712410949;5594.692291923902;5599.636023658449;4663.766811659403;4835.685680430761;4869.878253043702;5252.632315737862;5256.08018596744;4085.7140000200293;4094.897627559335;4196.118815048874;4198.076423186894;4203.957960420356;1182.6570294614467;1188.0554958807768;1204.5181927229178;1214.4838443661408;1228.269179837995;1053.3627155570923;1056.8573242612304;1063.8510608514814;1065.872095348563;1074.140687450037;6293.685315734287;6525.249596296487;6599.076129341896;6790.694418751168;6902.171739391305;503.26523276017423;522.7151202594595;538.5234067849981;539.156220514893;556.1713047559108;4219.894502637398;4290.120525292307;4364.345348197796;4370.650347972155;4373.190959672407;11648.88351116495;11897.762044759056;12016.038716902627;12025.098117641212;12045.759084818255;11262.605808796652;11947.701307467383;11952;11965.282083075042;12258.938705306417;8723.520206388583;8846.734597962071;8852.070532594114;8904.73285801427;8911.643534258557;6589.901151482827;6762.154730658668;6790.558613690292;6812.591244525344;6850.965745171242;10611.734706632396;10619.893801061891;10820.5130769114;11156.832647510131;11270.154738394816;10077.949610252195;10113;10997.670069897917;11426.828597570877;11440.542378305108;8448.070712221528;8472.110428405174;8697.782555435911;8710;8715.564221788758;9124.224440922597;9151.130642588943;9158.496282704515;9166.129217724305;9188.540572971458;8154.877676834733;8246.216609422096;8307.335413166811;8393.160683931803;8570.74287771368;8324.500529968222;8382.958085209535;8421.95789021051;8503.23470887623;8648.913510864812;7669;7702.345300649507;7705.922940770521;7748;7801.96099019524;5849.356570777296;5951.226340575698;5961.493273071664;6035.5473339500595;6063.999440092335;5658.5473162147755;5760.913586296293;5845.912311315248;5847.912281315868;5871.324797648325 20:08:46 INFO - PROCESS | 13843 | |4;prototype.html;357.2426455913464;361.9457081437786;365.21478820535845;367.57545035484026;369.9334119858426;5554.389227124134;5580.441955804417;5610.214569960209;5624.184493248476;5633.577481688869;5360.303160589118;5473.452654734525;5571.637843540167;5582.487880453792;5598.580106492009;4371.628411585019;4372.234858899696;4373.715708478939;4374.92814260505;4385.956140438602;4356.4990026146925;4358.171947330013;4359.803808828595;4371.8688439346715;4372.672049596277;4325.783710814462;4331.198728235271;4341.261985462479;4349.652027837781;4376.343548467724;4222.408862759216;4323.4867796271365;4335.263005289108;4335.674824388152;4337.869863904072;3880.5925377835483;3884.941725874114;3885.5531613864487;3892.9026774330587;3895.610438956082;5369.7583608737705;5374.3013408256675;5383.515483606494;5389.730513474311;5390.6226564140525;4622.352870598119;4828.758562071883;4853.199222128344;4863.148948933923;4965.925511117336;5705.372409035002;5717;5729.255196824428;5739.856503587402;5760.337561180434;4152.501699796014;4166.354215096634;4166.458360413127;4172.374143878412;4173.478315210598;5699.857503562403;5811.593188476808;5818.2436283282905;5887.4406931341455;5909.172715819789;4165.97917010413;4285.185814695198;4287.849925252601;4292.506361768436;4297.044844595702;4338.370936214231;4343.652507799432;4349.478062632441;4378.642620787566;4400.713953593006;4608.35483032369;4633.2818413146015;4913.975430122898;4930.161872481615;4990.17662085759;5696.376532688164;5744.971275143681;5745.080787074048;5745.9712701437065;5792.507636850914;1490.6347944753604;1510.7960425342658;1512.4026009726097;1512.4252783942031;1516.219147139224;942.3733217410482;961.20700422152;973.8149751547184;974.3325821812082;994.9253805964437;4761.52384761528;4836.105320515716;4845.806167753321;4857.8299759508955;4869.518294419507;5130.230465430141;5154.690718556899;5158.6131040171385;5166.715830629276;5172.456892026358;4660.883477913011;4821.566059054702;4877;4878.707142607212;4883.731394773322;2740.725927407283;2751.5184842652457;2753.5731961545994;2755.875985580654;2767.1006922749784;5278.313819203479;5316.229146773696;5325.813596524103;5333.626646134733;5335.226392173113;4903.509649035068;5189.922151167735;5190.429052804188;5253.872181766391;5280.762365693553;5263.499967503081;5294.814681486129;5315.468453154731;5333.359996800409;5341;5135.897282054413;5152;5152.613553983391;5185.248139019896;5223.085959957069;5130.1018623109685;5459.918101228405;5843.912341314799;5891.440313170242;5902.940970590239;5831.271091113611;5831.970840145772;6007.8197654070445;6085.356953622586;6102.7253773579405;4217.261979153697;4224.662027037891;4249.766262855449;4261.360795880642;4268.18602094115;5898;5905.3681985579415;5920.141579470866;5935.554833387427;5936.525077993664;5662.924044431545;5706.514946229617;5754.6547207167705;5762.279715035621;5777.411211916757;5616.5787565931905;5703.401142879938;5741.74162162712;5766.740496677576;5769.394213607511;5507.586930980113;5670.461306175906;5672.4894759471845;5697.145428185805;5715.971420142872;5769.509591684754;5786.884262314646;5793.710314484343;5801.448862358069;5808.854778630568;5677.410325108976;5677.744501497526;5680.204771331934;5689.203511508309;5694.629849059798 20:08:46 INFO - PROCESS | 13843 | |5;yui.html;844.9831003379933;853.991460085399;860.74177746676;889.301898010062;915.0392088307276;14611.123332600038;15749.370025198978;15806;15820.841791582096;15824.208789560533;15593.064416135012;15646.84353156468;15711.21443927802;15719;15751.212439378014;690.0994202565649;710.9431245500348;837.8240569480416;857.5755001274347;859.4456575508793;858.8926384201975;860.9397342186049;861.1861790607878;861.7199410191681;862.995685021574;908.5321059654283;910.635745701718;910.6812615584558;911.3438324406417;912.5346073502495;728.7303697631884;770.3952397368067;838.3795990966702;897.3852910756087;908.3777612335538;673.8685956238536;674.0866126398757;674.9730010799562;675.3887731602907;676.0569006236321;14842.628934276729;14847.554573362817;14889.329980150811;14896.180710060942;14903.552893413214;14815.851841481555;15030.624234394118;15096.924515377354;15206.239688015556;15467.845321546753;13235.867641323559;13511.594652160451;13512.121712088683;13623.591292261248;13868.722625547534;4536.931946020813;4665.230237010889;4689.7655117244;4783.928241076386;4789.449213340441;90766.54616726941;91615;92285.07714922832;92377;94940;11444.599439019761;11680;11721.296722196696;11827.52689892412;11830.940845295718;23057.423564411023;23144;23145.3056408308;23169.420764480685;23208.3037508875;8112.594370281462;8123.79690507742;8257.42198046131;8381.23769325002;8648.221660050625;4704.764761761899;4860.586850117779;4873.293372460973;4947.455779864212;5115.590752739772;3735.6264373562426;3864.5555761087835;3897.785621790829;3913.4521167036637;3914.2954268231424;659.4032400677395;667.4793660944471;680.7004917836136;689.021589343134;699.9300069993062;677.7492327838632;700.3731660164226;711.8256027273351;760.1828034862544;782.2412260107686;9885.901140988499;9991.400515969066;10031.548580313758;10249.641262555775;10314.381137131797;712.7042277454798;714.4213187318185;766.5439063757055;787.2049230277461;796.6176235407037;4468.821247150077;5027.123690020674;5442.319710036246;5444.972775136099;5474.7262636868;121683.3915830433;126754;126879.36560317139;127325;129832.35083824709;106552.46723766487;109479.45260273648;111282;111379.44310278397;114689.4265528667;83670.58164709137;84573.57713211395;93800;94412.52793736124;94630.5268473667;9333.579988900652;9629.422234665943;9745.880209158522;10175.236857235588;10345.327553708985;42393.36409953792;48083;48863.755681221366;55911.720441397534;56697.43302566921;50312.245316321016;52167.2174917369;57266.7136664314;61029.694851525455;69821.30178698148;14251.928740356232;14442.061266017676;14461.49384771528;14496.202708850693;14505.202213878338;14673.92663036678;15344.769828452805;15373.846261537241;15418.768718469008;15855.365785368456;12838.743225135631;13695.645685976177;14437.927810360881;14454.927725361305;14862.777058344349;14368.281585920871;14629.70740585161;14833.406663733329;15456.072635641898;15585.766213507033;14203.076800007966;14345.354459049158;14676.119432834064;14763.557093287218;15299.311530981355;10370.896291036994;10621.203409744454;10822.67531974042;10914.836277455686;11296.548138074386;9684.225261979165;9820.214382849212;10614.363138211733;10800.621978230723;10848.566057357617 20:08:46 INFO - PROCESS | 13843 | __end_tp_report 20:08:46 INFO - PROCESS | 13843 | __start_cc_report 20:08:46 INFO - PROCESS | 13843 | _x_x_mozilla_cycle_collect,859 20:08:46 INFO - PROCESS | 13843 | __end_cc_report 20:08:46 INFO - PROCESS | 13843 | __startTimestamp1474945726522__endTimestamp 20:08:46 INFO - PROCESS | 13843 | 20:08:46 INFO - PROCESS | 13843 | ------- Summary: start ------- 20:08:46 INFO - PROCESS | 13843 | Number of tests: 6 20:08:46 INFO - PROCESS | 13843 | 20:08:46 INFO - PROCESS | 13843 | [#0] dojo.html Cycles:165 Average:5503.10 Median:5674.74 stddev:629.24 (11.1%) stddev-sans-first:602.68 20:08:46 INFO - PROCESS | 13843 | Values: 3116.7 3146.9 3165.5 3181.6 3199.7 5551.9 5599.8 5626.0 5632.1 5648.5 5545.4 5583.4 5598.8 5614.2 5626.7 5041.0 5069.2 5101.4 5147.2 5159.3 4909.2 4947.4 5122.1 5178.9 5180.7 4987.6 4991.5 5032.8 5058.2 5061.9 5020.3 5046.3 5052.6 5117.2 5135.9 4962.3 5048.1 5065.4 5073.4 5078.9 5270.8 5295.4 5453.1 5479.0 5527.6 5940.9 5956.5 5958.6 5963.8 5974.4 5984.0 5993.9 6004.7 6005.0 6005.7 5491.1 5540.1 5542.6 5565.2 5570.6 6152.2 6158.3 6158.9 6168.0 6168.0 5900.7 5911.8 5914.9 5918.3 5942.4 5691.5 5692.8 5739.2 5806.1 5970.3 5790.4 5846.5 5849.0 5876.5 5887.6 5863.3 5870.9 5878.0 5883.2 5910.1 4487.2 4499.4 4517.0 4518.4 4528.5 3975.6 4035.1 4057.4 4059.2 4074.7 5515.5 5515.6 5516.6 5518.4 5529.6 5818.1 5872.3 5880.0 5895.1 5952.6 5498.4 5508.2 5526.5 5587.9 5626.0 5109.2 5111.9 5113.4 5160.6 5160.9 6003.9 6156.1 6161.0 6163.9 6167.1 5799.0 5848.1 5851.2 5888.4 5957.2 6061.3 6071.8 6074.0 6085.8 6087.6 5727.9 5788.4 5806.6 5811.4 5815.1 5841.7 5895.7 5937.0 5978.1 5996.8 5885.8 5910.4 5931.3 5932.2 5944.5 5931.4 5938.1 5940.2 5941.6 5943.7 5603.0 5646.0 5665.5 5665.5 5845.7 5771.9 5773.0 5784.4 5809.7 5812.7 5611.9 5653.8 5672.3 5674.7 5679.9 20:08:46 INFO - PROCESS | 13843 | 20:08:46 INFO - PROCESS | 13843 | [#1] ext.html Cycles:180 Average:66791.91 Median:21638.26 stddev:134983.54 (623.8%) stddev-sans-first:135270.69 20:08:46 INFO - PROCESS | 13843 | Values: 588.7 611.2 612.6 623.8 648.1 32946.7 36751.8 46442.1 47166.5 47463.3 47982.8 48558.3 48677.8 48745.3 48774.5 9164.6 9309.5 9315.2 9316.5 9319.7 8416.5 8634.2 10819.8 11064.9 11079.2 11280.3 11300.3 11357.1 11366.5 11373.0 11104.9 11157.4 11173.7 11185.3 11209.8 10943.5 10951.6 11034.8 11034.9 11039.9 46006.5 46075.5 46383.3 46420.3 46426.5 3903.4 3916.1 3929.3 4050.4 4095.4 34001.5 34058.7 34297.3 34380.1 35043.6 4285.3 4316.8 4326.4 4367.4 4411.1 369755.0 371437.0 371791.0 371792.0 371827.0 64084.7 64453.4 64478.0 64481.0 64509.7 40275.2 41557.8 67539.3 67661.3 67722.3 16658.5 17044.9 17045.7 17046.6 17052.8 10956.7 11125.6 12948.5 13036.0 13044.0 19671.7 20462.2 20594.2 21350.0 21396.8 7589.9 7608.8 7632.3 7660.1 7701.8 1033.5 1037.4 1038.9 1096.0 1108.4 33765.8 33809.3 34071.3 34375.3 34640.0 1120.6 1132.2 1132.8 1172.0 1197.5 18065.3 18126.5 18284.7 18289.5 18301.4 607123.0 612896.0 613473.0 615455.0 617237.0 62471.7 62774.4 62922.4 62945.7 62998.0 1285.4 1338.3 1352.9 1411.3 1413.8 29563.4 34852.0 35087.0 36527.6 37445.0 58102.7 58919.4 59039.4 59076.4 59205.1 505225.0 510431.0 511009.0 511479.0 512401.0 31295.7 32501.2 32650.8 32745.3 32750.8 51968.0 51968.2 52016.5 52171.7 52454.0 43877.6 44679.0 44742.6 45088.0 45366.5 43321.1 43647.0 44055.8 45430.3 45509.0 43022.1 43783.0 43984.0 44649.6 44658.0 35784.8 38637.6 39121.8 39347.2 39360.7 29164.9 29418.7 29529.4 29646.4 29703.7 20:08:46 INFO - PROCESS | 13843 | 20:08:46 INFO - PROCESS | 13843 | [#2] jquery.html Cycles:180 Average:30452.32 Median:24055.58 stddev:86047.97 (357.7%) stddev-sans-first:86259.77 20:08:46 INFO - PROCESS | 13843 | Values: 399.0 425.2 427.2 430.2 444.7 15801.0 20748.7 20934.3 20968.3 21405.7 19799.4 20209.3 20241.2 20320.7 20578.0 5674.0 5753.5 5838.3 5882.9 5892.5 5790.3 5866.9 5867.4 5867.8 5870.8 5603.9 5715.3 5771.8 5776.4 5784.8 5740.6 5771.3 5775.0 5781.0 5833.0 5877.1 6003.5 6003.9 6007.5 6012.3 15069.8 19240.6 19419.3 23883.5 24227.6 2351.1 2512.0 2525.3 2586.4 2696.3 11133.3 11195.2 11567.8 11644.5 14261.4 1970.1 1992.3 2064.8 2100.5 2149.1 84213.6 88199.0 88654.0 90322.5 90997.5 12109.5 12125.2 12186.1 12324.0 12343.8 17423.5 17426.7 17437.3 17458.6 17502.1 8067.3 8076.0 8122.8 8229.7 8401.0 7686.1 7764.5 7769.3 7945.4 7958.6 5161.4 5169.8 5224.8 5287.7 5360.8 2091.9 2121.3 2133.6 2158.6 2164.3 969.6 1017.2 1033.3 1044.1 1082.7 20549.6 20850.9 21092.7 21127.5 21294.4 1037.8 1038.6 1059.7 1107.4 1135.1 10980.0 11499.3 11688.0 11688.8 11697.3 486353.0 520405.0 532958.0 534631.0 534736.0 88973.0 90231.0 92119.5 94444.5 95756.5 1010.6 1024.2 1027.5 1032.6 1038.1 17694.9 17897.6 18366.9 18490.5 18717.9 42486.8 43193.0 43463.8 44509.8 44897.6 58912.0 59817.4 60226.4 60385.0 60651.4 8241.4 8508.9 8536.0 8568.4 9349.3 10521.9 13115.9 13825.9 14189.1 14199.3 11077.9 12203.0 12405.7 12424.7 12721.8 5701.4 9409.6 11681.0 11771.8 12076.8 12096.5 12279.8 12336.6 12396.6 12679.6 8256.8 8473.2 8676.2 8816.3 8879.8 9648.2 11404.8 11610.1 11853.6 11930.9 20:08:46 INFO - PROCESS | 13843 | 20:08:46 INFO - PROCESS | 13843 | [#3] mootools.html Cycles:180 Average:6253.15 Median:4749.27 stddev:3547.48 (74.7%) stddev-sans-first:3538.96 20:08:46 INFO - PROCESS | 13843 | Values: 1436.0 1508.1 1534.3 1692.3 1818.8 8535.4 9311.3 9665.7 9679.1 9933.9 9643.5 9717.5 9723.6 9727.8 9728.0 2593.5 2619.0 2619.5 2630.9 2637.2 2554.3 2611.9 2615.3 2638.2 2639.7 2575.4 2584.2 2616.8 2619.6 2620.5 2444.7 2460.2 2515.4 2517.6 2518.1 2465.7 2467.1 2467.5 2469.7 2509.2 8923.5 9008.5 9036.9 9051.1 9392.4 5653.7 5886.3 5895.0 5896.4 5899.9 3578.4 3609.7 3647.1 3660.9 3670.3 1218.7 1222.7 1224.7 1246.9 1252.5 12891.2 12984.9 13031.4 13051.4 13058.2 4834.8 4836.5 4892.0 4945.6 5089.4 10214.0 10216.7 10219.7 10224.4 10236.1 5586.6 5586.7 5594.3 5594.7 5599.6 4663.8 4835.7 4869.9 5252.6 5256.1 4085.7 4094.9 4196.1 4198.1 4204.0 1182.7 1188.1 1204.5 1214.5 1228.3 1053.4 1056.9 1063.9 1065.9 1074.1 6293.7 6525.2 6599.1 6790.7 6902.2 503.3 522.7 538.5 539.2 556.2 4219.9 4290.1 4364.3 4370.7 4373.2 11648.9 11897.8 12016.0 12025.1 12045.8 11262.6 11947.7 11952.0 11965.3 12258.9 8723.5 8846.7 8852.1 8904.7 8911.6 6589.9 6762.2 6790.6 6812.6 6851.0 10611.7 10619.9 10820.5 11156.8 11270.2 10077.9 10113.0 10997.7 11426.8 11440.5 8448.1 8472.1 8697.8 8710.0 8715.6 9124.2 9151.1 9158.5 9166.1 9188.5 8154.9 8246.2 8307.3 8393.2 8570.7 8324.5 8383.0 8422.0 8503.2 8648.9 7669.0 7702.3 7705.9 7748.0 7802.0 5849.4 5951.2 5961.5 6035.5 6064.0 5658.5 5760.9 5845.9 5847.9 5871.3 20:08:46 INFO - PROCESS | 13843 | 20:08:46 INFO - PROCESS | 13843 | [#4] prototype.html Cycles:180 Average:4701.47 Median:5187.59 stddev:1345.84 (25.9%) stddev-sans-first:1309.52 20:08:46 INFO - PROCESS | 13843 | Values: 357.2 361.9 365.2 367.6 369.9 5554.4 5580.4 5610.2 5624.2 5633.6 5360.3 5473.5 5571.6 5582.5 5598.6 4371.6 4372.2 4373.7 4374.9 4386.0 4356.5 4358.2 4359.8 4371.9 4372.7 4325.8 4331.2 4341.3 4349.7 4376.3 4222.4 4323.5 4335.3 4335.7 4337.9 3880.6 3884.9 3885.6 3892.9 3895.6 5369.8 5374.3 5383.5 5389.7 5390.6 4622.4 4828.8 4853.2 4863.1 4965.9 5705.4 5717.0 5729.3 5739.9 5760.3 4152.5 4166.4 4166.5 4172.4 4173.5 5699.9 5811.6 5818.2 5887.4 5909.2 4166.0 4285.2 4287.8 4292.5 4297.0 4338.4 4343.7 4349.5 4378.6 4400.7 4608.4 4633.3 4914.0 4930.2 4990.2 5696.4 5745.0 5745.1 5746.0 5792.5 1490.6 1510.8 1512.4 1512.4 1516.2 942.4 961.2 973.8 974.3 994.9 4761.5 4836.1 4845.8 4857.8 4869.5 5130.2 5154.7 5158.6 5166.7 5172.5 4660.9 4821.6 4877.0 4878.7 4883.7 2740.7 2751.5 2753.6 2755.9 2767.1 5278.3 5316.2 5325.8 5333.6 5335.2 4903.5 5189.9 5190.4 5253.9 5280.8 5263.5 5294.8 5315.5 5333.4 5341.0 5135.9 5152.0 5152.6 5185.2 5223.1 5130.1 5459.9 5843.9 5891.4 5902.9 5831.3 5832.0 6007.8 6085.4 6102.7 4217.3 4224.7 4249.8 4261.4 4268.2 5898.0 5905.4 5920.1 5935.6 5936.5 5662.9 5706.5 5754.7 5762.3 5777.4 5616.6 5703.4 5741.7 5766.7 5769.4 5507.6 5670.5 5672.5 5697.1 5716.0 5769.5 5786.9 5793.7 5801.4 5808.9 5677.4 5677.7 5680.2 5689.2 5694.6 20:08:46 INFO - PROCESS | 13843 | 20:08:46 INFO - PROCESS | 13843 | [#5] yui.html Cycles:180 Average:21847.96 Median:4601.08 stddev:32252.15 (701.0%) stddev-sans-first:32304.07 20:08:46 INFO - PROCESS | 13843 | Values: 845.0 854.0 860.7 889.3 915.0 14611.1 15749.4 15806.0 15820.8 15824.2 15593.1 15646.8 15711.2 15719.0 15751.2 690.1 710.9 837.8 857.6 859.4 858.9 860.9 861.2 861.7 863.0 908.5 910.6 910.7 911.3 912.5 728.7 770.4 838.4 897.4 908.4 673.9 674.1 675.0 675.4 676.1 14842.6 14847.6 14889.3 14896.2 14903.6 14815.9 15030.6 15096.9 15206.2 15467.8 13235.9 13511.6 13512.1 13623.6 13868.7 4536.9 4665.2 4689.8 4783.9 4789.4 90766.5 91615.0 92285.1 92377.0 94940.0 11444.6 11680.0 11721.3 11827.5 11830.9 23057.4 23144.0 23145.3 23169.4 23208.3 8112.6 8123.8 8257.4 8381.2 8648.2 4704.8 4860.6 4873.3 4947.5 5115.6 3735.6 3864.6 3897.8 3913.5 3914.3 659.4 667.5 680.7 689.0 699.9 677.7 700.4 711.8 760.2 782.2 9885.9 9991.4 10031.5 10249.6 10314.4 712.7 714.4 766.5 787.2 796.6 4468.8 5027.1 5442.3 5445.0 5474.7 121683.4 126754.0 126879.4 127325.0 129832.4 106552.5 109479.5 111282.0 111379.4 114689.4 83670.6 84573.6 93800.0 94412.5 94630.5 9333.6 9629.4 9745.9 10175.2 10345.3 42393.4 48083.0 48863.8 55911.7 56697.4 50312.2 52167.2 57266.7 61029.7 69821.3 14251.9 14442.1 14461.5 14496.2 14505.2 14673.9 15344.8 15373.8 15418.8 15855.4 12838.7 13695.6 14437.9 14454.9 14862.8 14368.3 14629.7 14833.4 15456.1 15585.8 14203.1 14345.4 14676.1 14763.6 15299.3 10370.9 10621.2 10822.7 10914.8 11296.5 9684.2 9820.2 10614.4 10800.6 10848.6 20:08:46 INFO - PROCESS | 13843 | -------- Summary: end -------- 20:08:46 INFO - PROCESS | 13843 | 20:08:47 INFO - TEST-INFO | 13843: exit 0 20:08:47 INFO - TEST-OK | dromaeo_css | took 1114843ms 20:08:47 INFO - TEST-START | kraken 20:08:47 INFO - operating with platform_type : linux_ 20:08:47 INFO - Initialising browser for kraken test... 20:08:47 INFO - TEST-INFO | started process 14162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRekPyQ/profile http://localhost:41199/getInfo.html) 20:08:52 INFO - PROCESS | 14162 | __metrics Screen width/height:1600/1200 20:08:52 INFO - PROCESS | 14162 | colorDepth:24 20:08:52 INFO - PROCESS | 14162 | Browser inner width/height: 1024/697 20:08:52 INFO - PROCESS | 14162 | __metrics 20:08:52 INFO - PROCESS | 14162 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:08:52 INFO - PROCESS | 14162 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:08:53 INFO - PROCESS | 14162 | console.error: PushService: 20:08:53 INFO - PROCESS | 14162 | stateChangeProcessEnqueue: Error transitioning state 20:08:53 INFO - PROCESS | 14162 | UnknownError 20:08:53 INFO - TEST-INFO | 14162: exit 0 20:08:53 INFO - Browser initialized. 20:08:53 INFO - Running cycle 1/1 for kraken test... 20:08:53 INFO - TEST-INFO | started process 14254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRekPyQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:05 INFO - PROCESS | 14254 | RSS: Main: 144637952 20:09:05 INFO - PROCESS | 14254 | 20:09:08 INFO - PROCESS | 14254 | Cycle 1(1): loaded http://localhost:41199/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41199/tests/kraken/driver.html?testName=audio-beat-detection) 20:09:09 INFO - PROCESS | 14254 | RSS: Main: 187092992 20:09:09 INFO - PROCESS | 14254 | 20:09:11 INFO - PROCESS | 14254 | Cycle 1(1): loaded http://localhost:41199/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41199/tests/kraken/driver.html?testName=audio-dft) 20:09:12 INFO - PROCESS | 14254 | RSS: Main: 175616000 20:09:12 INFO - PROCESS | 14254 | 20:09:15 INFO - PROCESS | 14254 | Cycle 1(1): loaded http://localhost:41199/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41199/tests/kraken/driver.html?testName=audio-fft) 20:09:15 INFO - PROCESS | 14254 | RSS: Main: 267251712 20:09:15 INFO - PROCESS | 14254 | 20:09:17 INFO - PROCESS | 14254 | Cycle 1(1): loaded http://localhost:41199/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41199/tests/kraken/driver.html?testName=audio-oscillator) 20:09:18 INFO - PROCESS | 14254 | RSS: Main: 173195264 20:09:18 INFO - PROCESS | 14254 | 20:09:20 INFO - PROCESS | 14254 | Cycle 1(1): loaded http://localhost:41199/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41199/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:09:20 INFO - PROCESS | 14254 | RSS: Main: 174747648 20:09:20 INFO - PROCESS | 14254 | 20:09:23 INFO - PROCESS | 14254 | Cycle 1(1): loaded http://localhost:41199/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41199/tests/kraken/driver.html?testName=imaging-darkroom) 20:09:24 INFO - PROCESS | 14254 | RSS: Main: 210554880 20:09:24 INFO - PROCESS | 14254 | 20:09:27 INFO - PROCESS | 14254 | Cycle 1(1): loaded http://localhost:41199/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41199/tests/kraken/driver.html?testName=imaging-desaturate) 20:09:28 INFO - PROCESS | 14254 | RSS: Main: 209743872 20:09:28 INFO - PROCESS | 14254 | 20:09:31 INFO - PROCESS | 14254 | Cycle 1(1): loaded http://localhost:41199/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41199/tests/kraken/driver.html?testName=json-parse-financial) 20:09:31 INFO - PROCESS | 14254 | RSS: Main: 208883712 20:09:31 INFO - PROCESS | 14254 | 20:09:33 INFO - PROCESS | 14254 | Cycle 1(1): loaded http://localhost:41199/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41199/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:09:33 INFO - PROCESS | 14254 | RSS: Main: 171335680 20:09:33 INFO - PROCESS | 14254 | 20:09:35 INFO - PROCESS | 14254 | Cycle 1(1): loaded http://localhost:41199/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41199/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:09:36 INFO - PROCESS | 14254 | RSS: Main: 179372032 20:09:36 INFO - PROCESS | 14254 | 20:09:38 INFO - PROCESS | 14254 | Cycle 1(1): loaded http://localhost:41199/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41199/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:09:38 INFO - PROCESS | 14254 | RSS: Main: 183144448 20:09:38 INFO - PROCESS | 14254 | 20:09:41 INFO - PROCESS | 14254 | Cycle 1(1): loaded http://localhost:41199/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41199/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:09:42 INFO - PROCESS | 14254 | RSS: Main: 184836096 20:09:42 INFO - PROCESS | 14254 | 20:09:44 INFO - PROCESS | 14254 | Cycle 1(1): loaded http://localhost:41199/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41199/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:09:45 INFO - PROCESS | 14254 | RSS: Main: 182501376 20:09:45 INFO - PROCESS | 14254 | 20:09:46 INFO - PROCESS | 14254 | Cycle 1(1): loaded http://localhost:41199/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41199/tests/kraken/driver.html?testName=ai-astar) 20:09:47 INFO - PROCESS | 14254 | RSS: Main: 233074688 20:09:47 INFO - PROCESS | 14254 | 20:09:47 INFO - PROCESS | 14254 | __start_tp_report 20:09:47 INFO - PROCESS | 14254 | _x_x_mozilla_page_load 20:09:47 INFO - PROCESS | 14254 | _x_x_mozilla_page_load_details 20:09:47 INFO - PROCESS | 14254 | |i|pagename|runs| 20:09:47 INFO - PROCESS | 14254 | |0;ai-astar;110;112;112;111;112;112;111;111;111;111 20:09:47 INFO - PROCESS | 14254 | |1;audio-beat-detection;144;116;118;153;123;120;118;121;142;117 20:09:47 INFO - PROCESS | 14254 | |2;audio-dft;161;162;160;161;160;161;161;161;161;160 20:09:47 INFO - PROCESS | 14254 | |3;audio-fft;76;76;76;120;75;76;75;76;100;74 20:09:47 INFO - PROCESS | 14254 | |4;audio-oscillator;83;81;121;81;81;81;109;81;81;119 20:09:47 INFO - PROCESS | 14254 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;116;117;117 20:09:47 INFO - PROCESS | 14254 | |6;imaging-darkroom;145;146;146;145;146;146;145;145;145;145 20:09:47 INFO - PROCESS | 14254 | |7;imaging-desaturate;95;94;96;95;95;95;95;96;95;95 20:09:47 INFO - PROCESS | 14254 | |8;json-parse-financial;56;48;49;48;50;50;50;49;48;48 20:09:47 INFO - PROCESS | 14254 | |9;json-stringify-tinderbox;58;59;58;58;59;57;59;58;58;58 20:09:47 INFO - PROCESS | 14254 | |10;stanford-crypto-aes;74;73;73;73;73;72;73;73;79;81 20:09:47 INFO - PROCESS | 14254 | |11;stanford-crypto-ccm;119;122;119;119;117;117;114;117;162;133 20:09:47 INFO - PROCESS | 14254 | |12;stanford-crypto-pbkdf2;163;168;162;156;154;157;154;155;154;154 20:09:47 INFO - PROCESS | 14254 | |13;stanford-crypto-sha256-iterative;64;62;63;62;62;63;63;62;62;65 20:09:47 INFO - PROCESS | 14254 | __end_tp_report 20:09:47 INFO - PROCESS | 14254 | __start_cc_report 20:09:47 INFO - PROCESS | 14254 | _x_x_mozilla_cycle_collect,1614 20:09:47 INFO - PROCESS | 14254 | __end_cc_report 20:09:47 INFO - PROCESS | 14254 | __startTimestamp1474945787157__endTimestamp 20:09:47 INFO - PROCESS | 14254 | 20:09:47 INFO - PROCESS | 14254 | ------- Summary: start ------- 20:09:47 INFO - PROCESS | 14254 | Number of tests: 14 20:09:47 INFO - PROCESS | 14254 | 20:09:47 INFO - PROCESS | 14254 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.50 stddev:0.67 (0.6%) stddev-sans-first:0.53 20:09:47 INFO - PROCESS | 14254 | Values: 110.0 112.0 112.0 111.0 112.0 112.0 111.0 111.0 111.0 111.0 20:09:47 INFO - PROCESS | 14254 | 20:09:47 INFO - PROCESS | 14254 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:122.00 stddev:13.64 (11.2%) stddev-sans-first:13.04 20:09:47 INFO - PROCESS | 14254 | Values: 144.0 116.0 118.0 153.0 123.0 120.0 118.0 121.0 142.0 117.0 20:09:47 INFO - PROCESS | 14254 | 20:09:47 INFO - PROCESS | 14254 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 20:09:47 INFO - PROCESS | 14254 | Values: 161.0 162.0 160.0 161.0 160.0 161.0 161.0 161.0 161.0 160.0 20:09:47 INFO - PROCESS | 14254 | 20:09:47 INFO - PROCESS | 14254 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:15.31 (20.1%) stddev-sans-first:16.06 20:09:47 INFO - PROCESS | 14254 | Values: 76.0 76.0 76.0 120.0 75.0 76.0 75.0 76.0 100.0 74.0 20:09:47 INFO - PROCESS | 14254 | 20:09:47 INFO - PROCESS | 14254 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:81.00 stddev:17.21 (21.2%) stddev-sans-first:17.96 20:09:47 INFO - PROCESS | 14254 | Values: 83.0 81.0 121.0 81.0 81.0 81.0 109.0 81.0 81.0 119.0 20:09:47 INFO - PROCESS | 14254 | 20:09:47 INFO - PROCESS | 14254 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 20:09:47 INFO - PROCESS | 14254 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 20:09:47 INFO - PROCESS | 14254 | 20:09:47 INFO - PROCESS | 14254 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:09:47 INFO - PROCESS | 14254 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 145.0 20:09:47 INFO - PROCESS | 14254 | 20:09:47 INFO - PROCESS | 14254 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 20:09:47 INFO - PROCESS | 14254 | Values: 95.0 94.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 20:09:47 INFO - PROCESS | 14254 | 20:09:47 INFO - PROCESS | 14254 | [#8] json-parse-financial Cycles:10 Average:49.60 Median:49.50 stddev:2.41 (4.9%) stddev-sans-first:0.93 20:09:47 INFO - PROCESS | 14254 | Values: 56.0 48.0 49.0 48.0 50.0 50.0 50.0 49.0 48.0 48.0 20:09:47 INFO - PROCESS | 14254 | 20:09:47 INFO - PROCESS | 14254 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 20:09:47 INFO - PROCESS | 14254 | Values: 58.0 59.0 58.0 58.0 59.0 57.0 59.0 58.0 58.0 58.0 20:09:47 INFO - PROCESS | 14254 | 20:09:47 INFO - PROCESS | 14254 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:73.00 stddev:3.03 (4.1%) stddev-sans-first:3.21 20:09:47 INFO - PROCESS | 14254 | Values: 74.0 73.0 73.0 73.0 73.0 72.0 73.0 73.0 79.0 81.0 20:09:47 INFO - PROCESS | 14254 | 20:09:47 INFO - PROCESS | 14254 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:119.00 stddev:14.34 (12.1%) stddev-sans-first:15.10 20:09:47 INFO - PROCESS | 14254 | Values: 119.0 122.0 119.0 119.0 117.0 117.0 114.0 117.0 162.0 133.0 20:09:47 INFO - PROCESS | 14254 | 20:09:47 INFO - PROCESS | 14254 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:156.50 stddev:4.92 (3.1%) stddev-sans-first:4.83 20:09:47 INFO - PROCESS | 14254 | Values: 163.0 168.0 162.0 156.0 154.0 157.0 154.0 155.0 154.0 154.0 20:09:47 INFO - PROCESS | 14254 | 20:09:47 INFO - PROCESS | 14254 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.03 (1.6%) stddev-sans-first:1.00 20:09:47 INFO - PROCESS | 14254 | Values: 64.0 62.0 63.0 62.0 62.0 63.0 63.0 62.0 62.0 65.0 20:09:47 INFO - PROCESS | 14254 | -------- Summary: end -------- 20:09:47 INFO - PROCESS | 14254 | 20:09:48 INFO - TEST-INFO | 14254: exit 0 20:09:48 INFO - TEST-OK | kraken | took 60890ms 20:09:48 INFO - SUITE-END | took 1175s 20:09:48 INFO - Completed test suite (00:19:35) 20:09:48 INFO - javascript benchmark 20:09:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.657167711552, 3146.874125034998, 3165.540996555501, 3181.5704879841214, 3199.6960288772557, 5551.888962220758, 5599.804006859761, 5626.0, 5632.127020311848, 5648.491635752782, 5545.445455454453, 5583.413741557139, 5598.804041858536, 5614.185943038257, 5626.718664066801, 5041.0, 5069.188929771238, 5101.438841727407, 5147.1764517677175, 5159.303494028314, 4909.165441874872, 4947.406311242656, 5122.078025955345, 5178.922316165242, 5180.689158650474, 4987.600991920638, 4991.450940396553, 5032.84901452957, 5058.24126381044, 5061.898762024757, 5020.347354843865, 5046.343975283226, 5052.646314757969, 5117.1556693145585, 5135.948640513584, 4962.330085438456, 5048.14181589127, 5065.39215294167, 5073.3911930568565, 5078.898422031539, 5270.789168433296, 5295.443978382292, 5453.127499600085, 5478.972605136989, 5527.55779537636, 5940.881182376328, 5956.52347812174, 5958.5828991970575, 5963.821085367446, 5974.402559744034, 5984.0, 5993.850153746148, 6004.729787159588, 6005.039193728982, 6005.729742161569, 5491.121420572689, 5540.058190107651, 5542.63972841764, 5565.193047008162, 5570.61005729595, 6152.230971128609, 6158.291796443376, 6158.891399548124, 6167.982282923267, 6168.0439531872635, 5900.675462849498, 5911.822645320647, 5914.9112763308585, 5918.2898052234, 5942.37605051472, 5691.459311365414, 5692.772289108472, 5739.196512488255, 5806.071028635398, 5970.253718285215, 5790.36306006339, 5846.532277417797, 5849.0, 5876.529877609781, 5887.587868849139, 5863.2670916135485, 5870.941290587125, 5877.970610146922, 5883.17635531026, 5910.113482977587, 4487.214737420938, 4499.437570303712, 4516.9774151129695, 4518.367428560005, 4528.547145285445, 3975.6223158799867, 4035.071933455322, 4057.350823868226, 4059.208454351432, 4074.6943979201087, 5515.503604675519, 5515.61390702655, 5516.558675305966, 5518.365387980353, 5529.585281103933, 5818.0981947798155, 5872.324682661463, 5880.029795083763, 5895.115732640138, 5952.613080149863, 5498.422665620133, 5508.20131080991, 5526.50261476469, 5587.938291724559, 5626.043572592669, 5109.233614957786, 5111.87857039332, 5113.437521872591, 5160.612954028463, 5160.8967820643375, 6003.879922401615, 6156.107364432132, 6161.0, 6163.9383606163365, 6167.105769663373, 5799.0, 5848.093545500455, 5851.151583020353, 5888.381719919518, 5957.225560677084, 6061.302950160788, 6071.7571297147615, 6073.969630151998, 6085.786997455068, 6087.57386982907, 5727.914081288701, 5788.392218817132, 5806.593538452268, 5811.4479124483105, 5815.127730840408, 5841.707914604338, 5895.7052147393315, 5937.0, 5978.103284507185, 5996.820095397145, 5885.793997210077, 5910.408959104056, 5931.258592675916, 5932.16949627044, 5944.494717949023, 5931.377205393372, 5938.079597662369, 5940.227770389822, 5941.58408911372, 5943.732532036155, 5602.971985140048, 5645.971770141123, 5665.518430933252, 5665.546756259407, 5845.736941837543, 5771.8557036074435, 5773.018586840331, 5784.421557844182, 5809.651420914759, 5812.709364531841, 5611.943880561143, 5653.802116925888, 5672.290963629546, 5674.74463649145, 5679.858003549944], "value": 5459.971772862138, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.7321268822686, 611.1993288791685, 612.5620181570176, 623.7536173211579, 648.147685793182, 32946.67053329466, 36751.81624091879, 46442.07115857685, 47166.52833471664, 47463.288050679264, 47982.76008619961, 48558.271625925554, 48677.75661121698, 48745.26882096763, 48774.51225487744, 9164.633414663422, 9309.534523273844, 9315.161635452809, 9316.487593182372, 9319.720408387726, 8416.495010299372, 8634.179752923463, 10819.78360432791, 11064.944675276613, 11079.224454288164, 11280.323180609148, 11300.265482743636, 11357.148213883951, 11366.488508017117, 11373.033292170176, 11104.888951110506, 11157.442127893573, 11173.664790056271, 11185.32888026721, 11209.831852522218, 10943.4528273586, 10951.561937522489, 11034.779304413867, 11034.944825275823, 11039.944800275947, 46006.53993460056, 46075.53924460746, 46383.30425043627, 46420.30369544459, 46426.53573464256, 3903.355946268862, 3916.138449541096, 3929.3142403974057, 4050.432939388488, 4095.4471146395153, 34001.48997765035, 34058.659413405796, 34297.31405371879, 34380.14049648754, 35043.64956350455, 4285.271503844354, 4316.762578058206, 4326.351047342892, 4367.410399596078, 4411.051623900845, 369755.0, 371437.0, 371791.0, 371792.0, 371827.0, 64084.67957660182, 64453.35546644474, 64478.0, 64481.0, 64509.67745161244, 40275.194496109914, 41557.79221103875, 67539.3246067543, 67661.3233867655, 67722.3227767716, 16658.50024499267, 17044.914775426292, 17045.659086818196, 17046.573835654206, 17052.829471705125, 10956.726081847859, 11125.554977800959, 12948.546800861925, 13036.0, 13043.956483481299, 19671.721338112977, 20462.181512739622, 20594.176232950813, 21350.0, 21396.78603213948, 7589.924100759032, 7608.80977975544, 7632.313091821763, 7660.119086305146, 7701.801284133187, 1033.478093562761, 1037.3775734559356, 1038.8753349597946, 1096.040964156363, 1108.4236197177422, 33765.83117084399, 33809.32381352408, 34071.31857362839, 34375.31249375048, 34640.0, 1120.5741818109066, 1132.230083543182, 1132.750794825137, 1171.988280117205, 1197.5090213012622, 18065.27738890456, 18126.456206313833, 18284.725729114074, 18289.542761431072, 18301.35945241937, 607123.0, 612896.0, 613473.0, 615455.0, 617237.0, 62471.687641561504, 62774.37225627777, 62922.37077629165, 62945.685271574264, 62998.0, 1285.3573213393304, 1338.2505796753849, 1352.9458821647024, 1411.301405804113, 1413.780364827232, 29563.40873182567, 34852.0, 35087.0, 36527.634723653486, 37445.0, 58102.70948645399, 58919.41080589139, 59039.40960590339, 59076.40923590881, 59205.111923322045, 505225.0, 510431.0, 511009.0, 511479.0, 512401.0, 31295.687043129277, 32501.187470312485, 32650.83674581612, 32745.34509309848, 32750.836245818617, 51968.0, 51968.22047669212, 52016.479835201164, 52171.73914130405, 52454.0, 43877.56122438735, 44679.0, 44742.55257447384, 45088.0, 45366.54633453623, 43321.13357732891, 43647.0, 44055.77972110247, 45430.31854522251, 45509.0, 43022.11277814672, 43783.0, 43984.0, 44649.55350446454, 44658.0, 35784.821075894455, 38637.61362386453, 39121.804390977864, 39347.213055739296, 39360.701664075845, 29164.854175728986, 29418.70581294245, 29529.409411811215, 29646.40707185801, 29703.702962970092], "value": 21745.4375395424, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.986035488758, 425.15931312934754, 427.2331165557823, 430.23418315398584, 444.70427165934643, 15801.0, 20748.688769668468, 20934.267300644482, 20968.26611068613, 21405.67891481629, 19799.406017819452, 20209.292674756387, 20241.190352385926, 20320.69518957217, 20578.0, 5673.971630141864, 5753.5397168226655, 5838.2994040715175, 5882.911756323659, 5892.528597712173, 5790.334111577159, 5866.853328666774, 5867.442592953663, 5867.76528938842, 5870.794522191724, 5603.859903502404, 5715.2855893013375, 5771.769129234825, 5776.422357764232, 5784.768609255625, 5740.5981581289325, 5771.278590176228, 5774.97112514439, 5780.9710951445395, 5832.970835145839, 5877.147813567009, 6003.519718422559, 6003.879922401571, 6007.459328660441, 6012.30858451275, 15069.773953390708, 19240.61518769631, 19419.32032378874, 23883.522329553485, 24227.636585451233, 2351.0830775997374, 2512.0454227393657, 2525.305540976228, 2586.379268975451, 2696.312440327704, 11133.33200007994, 11195.160362972729, 11567.76864462706, 11644.534218631245, 14261.358238879275, 1970.0839109814005, 1992.3325685895243, 2064.84513661476, 2100.5168811173517, 2149.0544160569298, 84213.57893210556, 88199.0, 88654.0, 90322.5483872583, 90997.54501227518, 12109.515619375303, 12125.151239413333, 12186.146969712036, 12324.0, 12343.814842777365, 17423.47729568115, 17426.651466970845, 17437.302507899796, 17458.563535911704, 17502.124893755263, 8067.3142782864115, 8076.0, 8122.837543249102, 8229.670813167406, 8400.957995209985, 7686.116096648957, 7764.534127952341, 7769.339606133542, 7945.443818932619, 7958.602069896598, 5161.406438259573, 5169.819056333085, 5224.764885580158, 5287.682739035593, 5360.785568577213, 2091.9163233470795, 2121.2681624839406, 2133.605283022646, 2158.6222411077997, 2164.264150188912, 969.6363863551169, 1017.165923942375, 1033.266380869576, 1044.1229367331478, 1082.7022568793645, 20549.58900821975, 20850.895745521175, 21092.683609745865, 21127.471813204793, 21294.36116916495, 1037.766502536923, 1038.5949479702922, 1059.6556119261118, 1107.429673718036, 1135.1089394825024, 10980.0, 11499.310041397543, 11688.0, 11688.766224675459, 11697.2981621103, 486353.0, 520405.0, 532958.0, 534631.0, 534736.0, 88973.0, 90231.0, 92119.53940230256, 94444.52777736068, 95756.52121739487, 1010.6361709784619, 1024.1806554756165, 1027.4913917610681, 1032.6179313653995, 1038.0501840815568, 17694.91152544229, 17897.642047159243, 18366.908165459623, 18490.537736556693, 18717.906410467862, 42486.78756606197, 43193.0, 43463.78268108639, 44509.77745111254, 44897.55102449065, 58912.0, 59817.401825981186, 60226.39773602208, 60385.0, 60651.393486064575, 8241.381896357918, 8508.914910850812, 8536.0, 8568.400211985101, 9349.298802589698, 10521.894781052091, 13115.868841311465, 13825.930870345584, 14189.148651080968, 14199.29003549839, 11077.889221108007, 12203.0, 12405.689857753629, 12424.689382765504, 12721.8091728626, 5701.401352858056, 9409.576569054272, 11681.0, 11771.823422648496, 12076.758464830478, 12096.45565949552, 12279.815802763145, 12336.568220112613, 12396.628101156979, 12679.556215532411, 8256.752297431087, 8473.195046470575, 8676.175763302475, 8816.250618697226, 8879.778005549913, 9648.179904707898, 11404.771904562029, 11610.071194304604, 11853.5851245206, 11930.880691192977], "value": 9578.97410721386, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1436.0450300550135, 1508.1177511155977, 1534.294224656658, 1692.3484458483488, 1818.7726534183219, 8535.359848011401, 9311.301652376065, 9665.710028699134, 9679.080487353698, 9933.900660993388, 9643.469609171492, 9717.514124293792, 9723.611055557787, 9727.756806079851, 9728.0, 2593.50723362561, 2619.030958545341, 2619.4630100829286, 2630.88161032754, 2637.1561100447866, 2554.2848002559313, 2611.947761044778, 2615.293870654922, 2638.1557901471538, 2639.656844610198, 2575.407656239066, 2584.1601479519136, 2616.7514086161877, 2619.5546757051347, 2620.5021046001293, 2444.679872868649, 2460.2004348586693, 2515.421453065805, 2517.5720127578265, 2518.055729101587, 2465.704115506133, 2467.148833652387, 2467.494163696438, 2469.7283298837115, 2509.1845150326035, 8923.509206993613, 9008.45949243041, 9036.909630903672, 9051.14014168653, 9392.389494682891, 5653.717314134276, 5886.293644762656, 5894.97052514739, 5896.410358964112, 5899.852503687399, 3578.35589593873, 3609.747317687763, 3647.0882279430143, 3660.871869484582, 3670.2659468106217, 1218.65268398506, 1222.712662524315, 1224.7060705430722, 1246.9002479801684, 1252.511520507003, 12891.16207446513, 12984.935075324658, 13031.413586388635, 13051.412686429134, 13058.21650700961, 4834.7824347904425, 4836.540528649773, 4892.0, 4945.590506705644, 5089.440161582223, 10214.0, 10216.693499195037, 10219.7445063874, 10224.437655928847, 10236.129928955974, 5586.55307575393, 5586.748596313176, 5594.300712410949, 5594.692291923902, 5599.636023658449, 4663.766811659403, 4835.685680430761, 4869.878253043702, 5252.632315737862, 5256.08018596744, 4085.7140000200293, 4094.897627559335, 4196.118815048874, 4198.076423186894, 4203.957960420356, 1182.6570294614467, 1188.0554958807768, 1204.5181927229178, 1214.4838443661408, 1228.269179837995, 1053.3627155570923, 1056.8573242612304, 1063.8510608514814, 1065.872095348563, 1074.140687450037, 6293.685315734287, 6525.249596296487, 6599.076129341896, 6790.694418751168, 6902.171739391305, 503.26523276017423, 522.7151202594595, 538.5234067849981, 539.156220514893, 556.1713047559108, 4219.894502637398, 4290.120525292307, 4364.345348197796, 4370.650347972155, 4373.190959672407, 11648.88351116495, 11897.762044759056, 12016.038716902627, 12025.098117641212, 12045.759084818255, 11262.605808796652, 11947.701307467383, 11952.0, 11965.282083075042, 12258.938705306417, 8723.520206388583, 8846.734597962071, 8852.070532594114, 8904.73285801427, 8911.643534258557, 6589.901151482827, 6762.154730658668, 6790.558613690292, 6812.591244525344, 6850.965745171242, 10611.734706632396, 10619.893801061891, 10820.5130769114, 11156.832647510131, 11270.154738394816, 10077.949610252195, 10113.0, 10997.670069897917, 11426.828597570877, 11440.542378305108, 8448.070712221528, 8472.110428405174, 8697.782555435911, 8710.0, 8715.564221788758, 9124.224440922597, 9151.130642588943, 9158.496282704515, 9166.129217724305, 9188.540572971458, 8154.877676834733, 8246.216609422096, 8307.335413166811, 8393.160683931803, 8570.74287771368, 8324.500529968222, 8382.958085209535, 8421.95789021051, 8503.23470887623, 8648.913510864812, 7669.0, 7702.345300649507, 7705.922940770521, 7748.0, 7801.96099019524, 5849.356570777296, 5951.226340575698, 5961.493273071664, 6035.5473339500595, 6063.999440092335, 5658.5473162147755, 5760.913586296293, 5845.912311315248, 5847.912281315868, 5871.324797648325], "value": 4923.959634847954, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.2426455913464, 361.9457081437786, 365.21478820535845, 367.57545035484026, 369.9334119858426, 5554.389227124134, 5580.441955804417, 5610.214569960209, 5624.184493248476, 5633.577481688869, 5360.303160589118, 5473.452654734525, 5571.637843540167, 5582.487880453792, 5598.580106492009, 4371.628411585019, 4372.234858899696, 4373.715708478939, 4374.92814260505, 4385.956140438602, 4356.4990026146925, 4358.171947330013, 4359.803808828595, 4371.8688439346715, 4372.672049596277, 4325.783710814462, 4331.198728235271, 4341.261985462479, 4349.652027837781, 4376.343548467724, 4222.408862759216, 4323.4867796271365, 4335.263005289108, 4335.674824388152, 4337.869863904072, 3880.5925377835483, 3884.941725874114, 3885.5531613864487, 3892.9026774330587, 3895.610438956082, 5369.7583608737705, 5374.3013408256675, 5383.515483606494, 5389.730513474311, 5390.6226564140525, 4622.352870598119, 4828.758562071883, 4853.199222128344, 4863.148948933923, 4965.925511117336, 5705.372409035002, 5717.0, 5729.255196824428, 5739.856503587402, 5760.337561180434, 4152.501699796014, 4166.354215096634, 4166.458360413127, 4172.374143878412, 4173.478315210598, 5699.857503562403, 5811.593188476808, 5818.2436283282905, 5887.4406931341455, 5909.172715819789, 4165.97917010413, 4285.185814695198, 4287.849925252601, 4292.506361768436, 4297.044844595702, 4338.370936214231, 4343.652507799432, 4349.478062632441, 4378.642620787566, 4400.713953593006, 4608.35483032369, 4633.2818413146015, 4913.975430122898, 4930.161872481615, 4990.17662085759, 5696.376532688164, 5744.971275143681, 5745.080787074048, 5745.9712701437065, 5792.507636850914, 1490.6347944753604, 1510.7960425342658, 1512.4026009726097, 1512.4252783942031, 1516.219147139224, 942.3733217410482, 961.20700422152, 973.8149751547184, 974.3325821812082, 994.9253805964437, 4761.52384761528, 4836.105320515716, 4845.806167753321, 4857.8299759508955, 4869.518294419507, 5130.230465430141, 5154.690718556899, 5158.6131040171385, 5166.715830629276, 5172.456892026358, 4660.883477913011, 4821.566059054702, 4877.0, 4878.707142607212, 4883.731394773322, 2740.725927407283, 2751.5184842652457, 2753.5731961545994, 2755.875985580654, 2767.1006922749784, 5278.313819203479, 5316.229146773696, 5325.813596524103, 5333.626646134733, 5335.226392173113, 4903.509649035068, 5189.922151167735, 5190.429052804188, 5253.872181766391, 5280.762365693553, 5263.499967503081, 5294.814681486129, 5315.468453154731, 5333.359996800409, 5341.0, 5135.897282054413, 5152.0, 5152.613553983391, 5185.248139019896, 5223.085959957069, 5130.1018623109685, 5459.918101228405, 5843.912341314799, 5891.440313170242, 5902.940970590239, 5831.271091113611, 5831.970840145772, 6007.8197654070445, 6085.356953622586, 6102.7253773579405, 4217.261979153697, 4224.662027037891, 4249.766262855449, 4261.360795880642, 4268.18602094115, 5898.0, 5905.3681985579415, 5920.141579470866, 5935.554833387427, 5936.525077993664, 5662.924044431545, 5706.514946229617, 5754.6547207167705, 5762.279715035621, 5777.411211916757, 5616.5787565931905, 5703.401142879938, 5741.74162162712, 5766.740496677576, 5769.394213607511, 5507.586930980113, 5670.461306175906, 5672.4894759471845, 5697.145428185805, 5715.971420142872, 5769.509591684754, 5786.884262314646, 5793.710314484343, 5801.448862358069, 5808.854778630568, 5677.410325108976, 5677.744501497526, 5680.204771331934, 5689.203511508309, 5694.629849059798], "value": 4282.448244553277, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [844.9831003379933, 853.991460085399, 860.74177746676, 889.301898010062, 915.0392088307276, 14611.123332600038, 15749.370025198978, 15806.0, 15820.841791582096, 15824.208789560533, 15593.064416135012, 15646.84353156468, 15711.21443927802, 15719.0, 15751.212439378014, 690.0994202565649, 710.9431245500348, 837.8240569480416, 857.5755001274347, 859.4456575508793, 858.8926384201975, 860.9397342186049, 861.1861790607878, 861.7199410191681, 862.995685021574, 908.5321059654283, 910.635745701718, 910.6812615584558, 911.3438324406417, 912.5346073502495, 728.7303697631884, 770.3952397368067, 838.3795990966702, 897.3852910756087, 908.3777612335538, 673.8685956238536, 674.0866126398757, 674.9730010799562, 675.3887731602907, 676.0569006236321, 14842.628934276729, 14847.554573362817, 14889.329980150811, 14896.180710060942, 14903.552893413214, 14815.851841481555, 15030.624234394118, 15096.924515377354, 15206.239688015556, 15467.845321546753, 13235.867641323559, 13511.594652160451, 13512.121712088683, 13623.591292261248, 13868.722625547534, 4536.931946020813, 4665.230237010889, 4689.7655117244, 4783.928241076386, 4789.449213340441, 90766.54616726941, 91615.0, 92285.07714922832, 92377.0, 94940.0, 11444.599439019761, 11680.0, 11721.296722196696, 11827.52689892412, 11830.940845295718, 23057.423564411023, 23144.0, 23145.3056408308, 23169.420764480685, 23208.3037508875, 8112.594370281462, 8123.79690507742, 8257.42198046131, 8381.23769325002, 8648.221660050625, 4704.764761761899, 4860.586850117779, 4873.293372460973, 4947.455779864212, 5115.590752739772, 3735.6264373562426, 3864.5555761087835, 3897.785621790829, 3913.4521167036637, 3914.2954268231424, 659.4032400677395, 667.4793660944471, 680.7004917836136, 689.021589343134, 699.9300069993062, 677.7492327838632, 700.3731660164226, 711.8256027273351, 760.1828034862544, 782.2412260107686, 9885.901140988499, 9991.400515969066, 10031.548580313758, 10249.641262555775, 10314.381137131797, 712.7042277454798, 714.4213187318185, 766.5439063757055, 787.2049230277461, 796.6176235407037, 4468.821247150077, 5027.123690020674, 5442.319710036246, 5444.972775136099, 5474.7262636868, 121683.3915830433, 126754.0, 126879.36560317139, 127325.0, 129832.35083824709, 106552.46723766487, 109479.45260273648, 111282.0, 111379.44310278397, 114689.4265528667, 83670.58164709137, 84573.57713211395, 93800.0, 94412.52793736124, 94630.5268473667, 9333.579988900652, 9629.422234665943, 9745.880209158522, 10175.236857235588, 10345.327553708985, 42393.36409953792, 48083.0, 48863.755681221366, 55911.720441397534, 56697.43302566921, 50312.245316321016, 52167.2174917369, 57266.7136664314, 61029.694851525455, 69821.30178698148, 14251.928740356232, 14442.061266017676, 14461.49384771528, 14496.202708850693, 14505.202213878338, 14673.92663036678, 15344.769828452805, 15373.846261537241, 15418.768718469008, 15855.365785368456, 12838.743225135631, 13695.645685976177, 14437.927810360881, 14454.927725361305, 14862.777058344349, 14368.281585920871, 14629.70740585161, 14833.406663733329, 15456.072635641898, 15585.766213507033, 14203.076800007966, 14345.354459049158, 14676.119432834064, 14763.557093287218, 15299.311530981355, 10370.896291036994, 10621.203409744454, 10822.67531974042, 10914.836277455686, 11296.548138074386, 9684.225261979165, 9820.214382849212, 10614.363138211733, 10800.621978230723, 10848.566057357617], "value": 7921.455694489423, "unit": "score"}], "name": "dromaeo_css", "value": 7582.093330445516, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 112.0, 111.0, 112.0, 112.0, 111.0, 111.0, 111.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 118.0, 153.0, 123.0, 120.0, 118.0, 121.0, 142.0, 117.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 120.0, 75.0, 76.0, 75.0, 76.0, 100.0, 74.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 121.0, 81.0, 81.0, 81.0, 109.0, 81.0, 81.0, 119.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 48.0, 49.0, 48.0, 50.0, 50.0, 50.0, 49.0, 48.0, 48.0], "value": 49.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 59.0, 57.0, 59.0, 58.0, 58.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 73.0, 73.0, 72.0, 73.0, 73.0, 79.0, 81.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 122.0, 119.0, 119.0, 117.0, 117.0, 114.0, 117.0, 162.0, 133.0], "value": 123.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 162.0, 156.0, 154.0, 157.0, 154.0, 155.0, 154.0, 154.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 62.0, 62.0, 63.0, 63.0, 62.0, 62.0, 65.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1457.3000000000002, "alertThreshold": 2.0}]} 20:09:48 INFO - Return code: 0 20:09:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:09:48 INFO - # TBPL SUCCESS # 20:09:48 INFO - Running post-action listener: _resource_record_post_action 20:09:48 INFO - [mozharness: 2016-09-27 03:09:48.462295Z] Finished run-tests step (success) 20:09:48 INFO - Running post-run listener: _resource_record_post_run 20:09:48 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 1994752; Write bytes: 363933696; Read time: 112; Write time: 478004 20:09:48 INFO - TinderboxPrint: CPU usage
13.0% 20:09:48 INFO - TinderboxPrint: I/O read bytes / time
1,994,752 / 112 20:09:48 INFO - TinderboxPrint: I/O write bytes / time
363,933,696 / 478,004 20:09:48 INFO - TinderboxPrint: CPU idle
8,276.4 (87.0%) 20:09:48 INFO - TinderboxPrint: CPU user
1,187.9 (12.5%) 20:09:48 INFO - TinderboxPrint: Swap in / out
0 / 0 20:09:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118738944; Read time: 0; Write time: 149852 20:09:48 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 245194752; Read time: 32; Write time: 328152 20:09:49 INFO - Running post-run listener: _upload_blobber_files 20:09:49 INFO - Blob upload gear active. 20:09:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:09:49 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 20:09:49 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:09:49 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:09:49 INFO - (blobuploader) - INFO - Open directory for files ... 20:09:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:09:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:09:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:09:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:09:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:09:50 INFO - (blobuploader) - INFO - Done attempting. 20:09:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:09:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:09:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:09:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:09:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:09:51 INFO - (blobuploader) - INFO - Done attempting. 20:09:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:09:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:09:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:09:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:09:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:09:54 INFO - (blobuploader) - INFO - Done attempting. 20:09:54 INFO - (blobuploader) - INFO - Iteration through files over. 20:09:54 INFO - Return code: 0 20:09:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:09:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:09:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86e715225828724f0c40532595f8abcd628d309a61bcae433b76f96cccd298aa320b851b52ca71bac5403271390984626d9278e6529573287eb4f5acaf992418", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e434912d10017387c9d504a5b8d4fee9d7c3878ecd92c1ffbd18a422ca1ce7c072940730daa71e3b37720da1f58535b15d7c59daaeac7363325027533e874d60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f92de3bb2c47a53d3b520f00e5c567ee92748d500ad912f85e4ceaa102e5d5525449b1337c7034a12fde358041910a7a3f1cebdf01947eb1cb20f45a53d68bc"} 20:09:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:09:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:09:54 INFO - Contents: 20:09:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86e715225828724f0c40532595f8abcd628d309a61bcae433b76f96cccd298aa320b851b52ca71bac5403271390984626d9278e6529573287eb4f5acaf992418", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e434912d10017387c9d504a5b8d4fee9d7c3878ecd92c1ffbd18a422ca1ce7c072940730daa71e3b37720da1f58535b15d7c59daaeac7363325027533e874d60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f92de3bb2c47a53d3b520f00e5c567ee92748d500ad912f85e4ceaa102e5d5525449b1337c7034a12fde358041910a7a3f1cebdf01947eb1cb20f45a53d68bc"} 20:09:54 INFO - Running post-run listener: copy_logs_to_upload_dir 20:09:54 INFO - Copying logs to upload dir... 20:09:54 INFO - mkdir: /builds/slave/test/build/upload/logs 20:09:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.849915 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-09-26 20:09:54.055425) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 20:09:54.059082) ========= 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=5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86e715225828724f0c40532595f8abcd628d309a61bcae433b76f96cccd298aa320b851b52ca71bac5403271390984626d9278e6529573287eb4f5acaf992418", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e434912d10017387c9d504a5b8d4fee9d7c3878ecd92c1ffbd18a422ca1ce7c072940730daa71e3b37720da1f58535b15d7c59daaeac7363325027533e874d60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f92de3bb2c47a53d3b520f00e5c567ee92748d500ad912f85e4ceaa102e5d5525449b1337c7034a12fde358041910a7a3f1cebdf01947eb1cb20f45a53d68bc"} build_url:https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011422 build_url: 'https://queue.taskcluster.net/v1/task/A3pZMaxPQXi-PjYCLEsKYA/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86e715225828724f0c40532595f8abcd628d309a61bcae433b76f96cccd298aa320b851b52ca71bac5403271390984626d9278e6529573287eb4f5acaf992418", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e434912d10017387c9d504a5b8d4fee9d7c3878ecd92c1ffbd18a422ca1ce7c072940730daa71e3b37720da1f58535b15d7c59daaeac7363325027533e874d60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f92de3bb2c47a53d3b520f00e5c567ee92748d500ad912f85e4ceaa102e5d5525449b1337c7034a12fde358041910a7a3f1cebdf01947eb1cb20f45a53d68bc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 20:09:54.084892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 20:09:54.085271) ========= 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=5cf47e208febbcd81da23b2e0000026f-1474942172.526191-1514116053 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004770 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 20:09:54.168737) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 20:09:54.169105) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 20:09:54.169445) ========= ========= Total master_lag: 0.20 =========