builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1475246168.08 results: success (0) buildid: 20160930013320 builduid: aa5c9bca12eb4c9481f5747ff57287d7 revision: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:08.075568) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:08.076033) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:08.076477) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:08.211861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:08.212228) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-30 07:36:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.2K=0.3s 2016-09-30 07:36:10 (40.2 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.414710 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:08.644992) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:08.645350) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017435 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:08.695308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:08.695609) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 --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 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-30 07:36:10,337 truncating revision to first 12 chars 2016-09-30 07:36:10,337 Setting DEBUG logging. 2016-09-30 07:36:10,337 attempt 1/10 2016-09-30 07:36:10,337 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/805d5fc3d66c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 07:36:10,923 unpacking tar archive at: mozilla-aurora-805d5fc3d66c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.927503 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:09.636308) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:09.636609) ========= script_repo_revision: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:09.637056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:09.637359) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 07:36:09.646372) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-30 07:36:09.646641) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:36:11 INFO - MultiFileLogger online at 20160930 07:36:11 in /builds/slave/test 07:36:11 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 07:36:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:36:11 INFO - {'append_to_log': False, 07:36:11 INFO - 'base_work_dir': '/builds/slave/test', 07:36:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:36:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:36:11 INFO - 'branch': 'Mozilla-Aurora', 07:36:11 INFO - 'buildbot_json_path': 'buildprops.json', 07:36:11 INFO - 'config_files': ('talos/linux_config.py',), 07:36:11 INFO - 'default_actions': ('clobber', 07:36:11 INFO - 'read-buildbot-config', 07:36:11 INFO - 'download-and-extract', 07:36:11 INFO - 'populate-webroot', 07:36:11 INFO - 'create-virtualenv', 07:36:11 INFO - 'install', 07:36:11 INFO - 'run-tests'), 07:36:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:36:11 INFO - 'download_minidump_stackwalk': True, 07:36:11 INFO - 'download_symbols': 'ondemand', 07:36:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:36:11 INFO - 'tooltool.py': '/tools/tooltool.py', 07:36:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:36:11 INFO - '/tools/misc-python/virtualenv.py')}, 07:36:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:36:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:36:11 INFO - 'installer_path': 'installer.exe', 07:36:11 INFO - 'log_level': 'info', 07:36:11 INFO - 'log_name': 'talos', 07:36:11 INFO - 'log_to_console': True, 07:36:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:36:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:36:11 INFO - 'opt_config_files': (), 07:36:11 INFO - 'pip_index': False, 07:36:11 INFO - 'sps_profile': False, 07:36:11 INFO - 'sps_profile_interval': 0, 07:36:11 INFO - 'suite': 'dromaeojs', 07:36:11 INFO - 'system_bits': '32', 07:36:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:36:11 INFO - 'title': 'talos-linux64-ix-069', 07:36:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:36:11 INFO - 'use_talos_json': True, 07:36:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:36:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:36:11 INFO - 'work_dir': 'build'} 07:36:11 INFO - [mozharness: 2016-09-30 14:36:11.393359Z] Running clobber step. 07:36:11 INFO - Running pre-action listener: _resource_record_pre_action 07:36:11 INFO - Running main action method: clobber 07:36:11 INFO - rmtree: /builds/slave/test/build 07:36:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:36:12 INFO - Running post-action listener: _resource_record_post_action 07:36:12 INFO - [mozharness: 2016-09-30 14:36:12.377160Z] Finished clobber step (success) 07:36:12 INFO - [mozharness: 2016-09-30 14:36:12.377261Z] Running read-buildbot-config step. 07:36:12 INFO - Running pre-action listener: _resource_record_pre_action 07:36:12 INFO - Running main action method: read_buildbot_config 07:36:12 INFO - Using buildbot properties: 07:36:12 INFO - { 07:36:12 INFO - "project": "", 07:36:12 INFO - "product": "firefox", 07:36:12 INFO - "script_repo_revision": "production", 07:36:12 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:36:12 INFO - "repository": "", 07:36:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:36:12 INFO - "buildid": "20160930013320", 07:36:12 INFO - "pgo_build": "True", 07:36:12 INFO - "basedir": "/builds/slave/test", 07:36:12 INFO - "buildnumber": 542, 07:36:12 INFO - "slavename": "talos-linux64-ix-069", 07:36:12 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:36:12 INFO - "platform": "ubuntu64_hw", 07:36:12 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:36:12 INFO - "branch": "mozilla-aurora", 07:36:12 INFO - "repo_path": "releases/mozilla-aurora", 07:36:12 INFO - "revision": "805d5fc3d66c4fa585a3de407b1e0b055f78eb58", 07:36:12 INFO - "stage_platform": "linux64-pgo", 07:36:12 INFO - "builduid": "aa5c9bca12eb4c9481f5747ff57287d7", 07:36:12 INFO - "slavebuilddir": "test" 07:36:12 INFO - } 07:36:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 07:36:12 INFO - Running post-action listener: _resource_record_post_action 07:36:12 INFO - [mozharness: 2016-09-30 14:36:12.379727Z] Finished read-buildbot-config step (success) 07:36:12 INFO - [mozharness: 2016-09-30 14:36:12.379826Z] Running download-and-extract step. 07:36:12 INFO - Running pre-action listener: _resource_record_pre_action 07:36:12 INFO - Running main action method: download_and_extract 07:36:12 INFO - mkdir: /builds/slave/test/build/tests 07:36: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')]} 07:36:12 INFO - trying https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 07:36:12 INFO - Downloading https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/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 07:36:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/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 07:36:12 INFO - Downloaded 1361 bytes. 07:36:12 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 07:36:12 INFO - Using the following test package requirements: 07:36:12 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 07:36:12 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:36:12 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:36:12 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:36:12 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:36:12 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:36:12 INFO - u'jsshell-linux-x86_64.zip'], 07:36:12 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:36:12 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:36:12 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 07:36:12 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:36:12 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:36:12 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:36:12 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:36:12 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:36:12 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:36:12 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:36:12 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:36:12 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:36:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 07:36:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:36:12 INFO - Fetch https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:36:13 INFO - Expected file size: 21901358 07:36:18 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 07:36:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 07:36:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:36:18 INFO - Fetch https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:36:18 INFO - Expected file size: 21901358 07:36:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 07:36:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:36:23 INFO - Fetch https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 07:36:23 INFO - Expected file size: 14414059 07:36:24 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')]} 07:36:24 INFO - trying https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:36:24 INFO - Downloading https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/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 07:36:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/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 07:36:25 INFO - Downloaded 63921663 bytes. 07:36:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:36:25 INFO - mkdir: /builds/slave/test/properties 07:36:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:36:25 INFO - Writing to file /builds/slave/test/properties/build_url 07:36:25 INFO - Contents: 07:36:25 INFO - build_url:https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:36:26 INFO - Running post-action listener: _resource_record_post_action 07:36:26 INFO - Running post-action listener: set_extra_try_arguments 07:36:26 INFO - [mozharness: 2016-09-30 14:36:26.642164Z] Finished download-and-extract step (success) 07:36:26 INFO - [mozharness: 2016-09-30 14:36:26.642394Z] Running populate-webroot step. 07:36:26 INFO - Running pre-action listener: _resource_record_pre_action 07:36:26 INFO - Running main action method: populate_webroot 07:36:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:36:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:36:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:36:26 INFO - '--tppagecycles', 07:36:26 INFO - '7'], 07:36:26 INFO - 'tests': ['tsvgm']}}, 07:36:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:36:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:36:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:36:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:36:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:36:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:36:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:26 INFO - 'talos_options': ['--disable-e10s'], 07:36:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:26 INFO - 'talos_options': ['--disable-e10s'], 07:36:26 INFO - 'tests': ['damp', 'tps']}, 07:36:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:26 INFO - 'tests': ['damp', 'tps']}, 07:36:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:36:26 INFO - 'tests': ['dromaeo_dom']}, 07:36:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:36:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:36:26 INFO - 'tests': ['basic_compositor_video']}, 07:36:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:36:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:36:26 INFO - 'tests': ['a11yr', 07:36:26 INFO - 'ts_paint', 07:36:26 INFO - 'tpaint', 07:36:26 INFO - 'sessionrestore', 07:36:26 INFO - 'sessionrestore_no_auto_restore', 07:36:26 INFO - 'tabpaint']}, 07:36:26 INFO - 'other-e10s': {'tests': ['a11yr', 07:36:26 INFO - 'ts_paint', 07:36:26 INFO - 'tpaint', 07:36:26 INFO - 'sessionrestore', 07:36:26 INFO - 'sessionrestore_no_auto_restore', 07:36:26 INFO - 'tabpaint']}, 07:36:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:36:26 INFO - 'ts_paint', 07:36:26 INFO - 'tpaint', 07:36:26 INFO - 'sessionrestore', 07:36:26 INFO - 'sessionrestore_no_auto_restore', 07:36:26 INFO - 'tabpaint']}, 07:36:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:36:26 INFO - 'ts_paint', 07:36:26 INFO - 'tpaint', 07:36:26 INFO - 'sessionrestore', 07:36:26 INFO - 'sessionrestore_no_auto_restore', 07:36:26 INFO - 'tabpaint']}, 07:36:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:36:26 INFO - 'tests': ['a11yr', 07:36:26 INFO - 'ts_paint', 07:36:26 INFO - 'tpaint', 07:36:26 INFO - 'sessionrestore', 07:36:26 INFO - 'sessionrestore_no_auto_restore', 07:36:26 INFO - 'tabpaint']}, 07:36:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:36:26 INFO - 'tests': ['a11yr', 07:36:26 INFO - 'ts_paint', 07:36:26 INFO - 'tpaint', 07:36:26 INFO - 'sessionrestore', 07:36:26 INFO - 'sessionrestore_no_auto_restore', 07:36:26 INFO - 'tabpaint']}, 07:36:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:36:26 INFO - 'tests': ['tsvgx', 07:36:26 INFO - 'tsvgr_opacity', 07:36:26 INFO - 'tart', 07:36:26 INFO - 'tscrollx', 07:36:26 INFO - 'cart']}, 07:36:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:36:26 INFO - 'tsvgr_opacity', 07:36:26 INFO - 'tart', 07:36:26 INFO - 'tscrollx', 07:36:26 INFO - 'cart']}, 07:36:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:26 INFO - 'talos_options': ['--disable-e10s'], 07:36:26 INFO - 'tests': ['tp5o']}, 07:36:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:26 INFO - 'tests': ['tp5o']}, 07:36:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:26 INFO - 'talos_options': ['--disable-e10s', 07:36:26 INFO - '--xperf_path', 07:36:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:26 INFO - 'tests': ['tp5n']}, 07:36:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:26 INFO - 'talos_options': ['--xperf_path', 07:36:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:26 INFO - 'tests': ['tp5n']}}, 07:36:26 INFO - 'talos.zip': {'path': '', 07:36:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:36:26 INFO - Running post-action listener: _resource_record_post_action 07:36:26 INFO - [mozharness: 2016-09-30 14:36:26.664367Z] Finished populate-webroot step (success) 07:36:26 INFO - [mozharness: 2016-09-30 14:36:26.664456Z] Running create-virtualenv step. 07:36:26 INFO - Running pre-action listener: _resource_record_pre_action 07:36:26 INFO - Running main action method: create_virtualenv 07:36:26 INFO - Creating virtualenv /builds/slave/test/build/venv 07:36:26 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 07:36:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:36:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:36:26 INFO - Using real prefix '/usr' 07:36:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:36:27 INFO - Installing distribute.............................................................................................................................................................................................done. 07:36:29 INFO - Installing pip.................done. 07:36:29 INFO - Return code: 0 07:36:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:36:29 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')]} 07:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:29 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')]} 07:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:29 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 0x7f1421f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', '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 07:36:29 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 07:36:29 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 07:36:29 INFO - Using env: {'DISPLAY': ':0', 07:36:29 INFO - 'HOME': '/home/cltbld', 07:36:29 INFO - 'LANG': 'en_US.UTF-8', 07:36:29 INFO - 'LANGUAGE': 'en_US:en', 07:36:29 INFO - 'LOGNAME': 'cltbld', 07:36:29 INFO - 'MAIL': '/var/mail/cltbld', 07:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:29 INFO - 'MOZ_NO_REMOTE': '1', 07:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:29 INFO - 'NO_EM_RESTART': '1', 07:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:29 INFO - 'PWD': '/builds/slave/test', 07:36:29 INFO - 'SHELL': '/bin/bash', 07:36:29 INFO - 'SHLVL': '1', 07:36:29 INFO - 'TERM': 'linux', 07:36:29 INFO - 'TMOUT': '86400', 07:36:29 INFO - 'USER': 'cltbld', 07:36:29 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', 07:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:29 INFO - '_': '/tools/buildbot/bin/python'} 07:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:29 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 07:36:29 INFO - Cleaning up... 07:36:29 INFO - Return code: 0 07:36:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:36:29 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')]} 07:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:29 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')]} 07:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:29 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 0x7f1421f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', '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 07:36:29 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 07:36:29 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 07:36:29 INFO - Using env: {'DISPLAY': ':0', 07:36:29 INFO - 'HOME': '/home/cltbld', 07:36:29 INFO - 'LANG': 'en_US.UTF-8', 07:36:29 INFO - 'LANGUAGE': 'en_US:en', 07:36:29 INFO - 'LOGNAME': 'cltbld', 07:36:29 INFO - 'MAIL': '/var/mail/cltbld', 07:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:29 INFO - 'MOZ_NO_REMOTE': '1', 07:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:29 INFO - 'NO_EM_RESTART': '1', 07:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:29 INFO - 'PWD': '/builds/slave/test', 07:36:29 INFO - 'SHELL': '/bin/bash', 07:36:29 INFO - 'SHLVL': '1', 07:36:29 INFO - 'TERM': 'linux', 07:36:29 INFO - 'TMOUT': '86400', 07:36:29 INFO - 'USER': 'cltbld', 07:36:29 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', 07:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:29 INFO - '_': '/tools/buildbot/bin/python'} 07:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:29 INFO - Downloading/unpacking psutil>=3.1.1 07:36:29 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 07:36:29 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 07:36:29 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 07:36:29 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 07:36:29 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 07:36:29 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 07:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:36:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:31 INFO - Installing collected packages: psutil 07:36:31 INFO - Running setup.py install for psutil 07:36:31 INFO - building 'psutil._psutil_linux' extension 07:36:31 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 07:36:31 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 07:36:31 INFO - building 'psutil._psutil_posix' extension 07:36:31 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 07:36:32 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 07:36:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:32 INFO - Successfully installed psutil 07:36:32 INFO - Cleaning up... 07:36:32 INFO - Return code: 0 07:36:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:32 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 0x7f1421f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', '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 07:36:32 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 07:36:32 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 07:36:32 INFO - Using env: {'DISPLAY': ':0', 07:36:32 INFO - 'HOME': '/home/cltbld', 07:36:32 INFO - 'LANG': 'en_US.UTF-8', 07:36:32 INFO - 'LANGUAGE': 'en_US:en', 07:36:32 INFO - 'LOGNAME': 'cltbld', 07:36:32 INFO - 'MAIL': '/var/mail/cltbld', 07:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:32 INFO - 'MOZ_NO_REMOTE': '1', 07:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:32 INFO - 'NO_EM_RESTART': '1', 07:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:32 INFO - 'PWD': '/builds/slave/test', 07:36:32 INFO - 'SHELL': '/bin/bash', 07:36:32 INFO - 'SHLVL': '1', 07:36:32 INFO - 'TERM': 'linux', 07:36:32 INFO - 'TMOUT': '86400', 07:36:32 INFO - 'USER': 'cltbld', 07:36:32 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', 07:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:32 INFO - '_': '/tools/buildbot/bin/python'} 07:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:36:32 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 07:36:32 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 07:36:32 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 07:36:32 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 07:36:32 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 07:36:32 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 07:36:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:36:34 INFO - Installing collected packages: mozsystemmonitor 07:36:34 INFO - Running setup.py install for mozsystemmonitor 07:36:34 INFO - Successfully installed mozsystemmonitor 07:36:34 INFO - Cleaning up... 07:36:34 INFO - Return code: 0 07:36:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1421f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', '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 07:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:36:34 INFO - Using env: {'DISPLAY': ':0', 07:36:34 INFO - 'HOME': '/home/cltbld', 07:36:34 INFO - 'LANG': 'en_US.UTF-8', 07:36:34 INFO - 'LANGUAGE': 'en_US:en', 07:36:34 INFO - 'LOGNAME': 'cltbld', 07:36:34 INFO - 'MAIL': '/var/mail/cltbld', 07:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:34 INFO - 'MOZ_NO_REMOTE': '1', 07:36:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:34 INFO - 'NO_EM_RESTART': '1', 07:36:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:34 INFO - 'PWD': '/builds/slave/test', 07:36:34 INFO - 'SHELL': '/bin/bash', 07:36:34 INFO - 'SHLVL': '1', 07:36:34 INFO - 'TERM': 'linux', 07:36:34 INFO - 'TMOUT': '86400', 07:36:34 INFO - 'USER': 'cltbld', 07:36:34 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', 07:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:34 INFO - '_': '/tools/buildbot/bin/python'} 07:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:34 INFO - Downloading/unpacking jsonschema==2.5.1 07:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:36 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:36 INFO - warning: no files found matching '*.txt' 07:36:36 INFO - no previously-included directories found matching 'build' 07:36:36 INFO - no previously-included directories found matching 'dist' 07:36:36 INFO - no previously-included directories found matching '.git*' 07:36:36 INFO - Installing collected packages: jsonschema, functools32 07:36:36 INFO - Running setup.py install for functools32 07:36:37 INFO - warning: no files found matching '*.txt' 07:36:37 INFO - no previously-included directories found matching 'build' 07:36:37 INFO - no previously-included directories found matching 'dist' 07:36:37 INFO - no previously-included directories found matching '.git*' 07:36:37 INFO - Successfully installed jsonschema functools32 07:36:37 INFO - Cleaning up... 07:36:37 INFO - Return code: 0 07:36:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:36:37 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')]} 07:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:37 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')]} 07:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:37 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 0x7f1421f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', '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 07:36:37 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 07:36:37 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 07:36:37 INFO - Using env: {'DISPLAY': ':0', 07:36:37 INFO - 'HOME': '/home/cltbld', 07:36:37 INFO - 'LANG': 'en_US.UTF-8', 07:36:37 INFO - 'LANGUAGE': 'en_US:en', 07:36:37 INFO - 'LOGNAME': 'cltbld', 07:36:37 INFO - 'MAIL': '/var/mail/cltbld', 07:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:37 INFO - 'MOZ_NO_REMOTE': '1', 07:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:37 INFO - 'NO_EM_RESTART': '1', 07:36:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:37 INFO - 'PWD': '/builds/slave/test', 07:36:37 INFO - 'SHELL': '/bin/bash', 07:36:37 INFO - 'SHLVL': '1', 07:36:37 INFO - 'TERM': 'linux', 07:36:37 INFO - 'TMOUT': '86400', 07:36:37 INFO - 'USER': 'cltbld', 07:36:37 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', 07:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:37 INFO - '_': '/tools/buildbot/bin/python'} 07:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:36:37 INFO - Cleaning up... 07:36:37 INFO - Return code: 0 07:36:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36:37 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')]} 07:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:37 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')]} 07:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:37 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 0x7f1421f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', '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 07:36:37 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 07:36:37 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 07:36:37 INFO - Using env: {'DISPLAY': ':0', 07:36:37 INFO - 'HOME': '/home/cltbld', 07:36:37 INFO - 'LANG': 'en_US.UTF-8', 07:36:37 INFO - 'LANGUAGE': 'en_US:en', 07:36:37 INFO - 'LOGNAME': 'cltbld', 07:36:37 INFO - 'MAIL': '/var/mail/cltbld', 07:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:37 INFO - 'MOZ_NO_REMOTE': '1', 07:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:37 INFO - 'NO_EM_RESTART': '1', 07:36:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:37 INFO - 'PWD': '/builds/slave/test', 07:36:37 INFO - 'SHELL': '/bin/bash', 07:36:37 INFO - 'SHLVL': '1', 07:36:37 INFO - 'TERM': 'linux', 07:36:37 INFO - 'TMOUT': '86400', 07:36:37 INFO - 'USER': 'cltbld', 07:36:37 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', 07:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:37 INFO - '_': '/tools/buildbot/bin/python'} 07:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:37 INFO - Downloading/unpacking blobuploader==1.2.4 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36:39 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:40 INFO - Downloading docopt-0.6.1.tar.gz 07:36:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:40 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:40 INFO - Running setup.py install for blobuploader 07:36:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:40 INFO - Running setup.py install for requests 07:36:41 INFO - Running setup.py install for docopt 07:36:41 INFO - Successfully installed blobuploader requests docopt 07:36:41 INFO - Cleaning up... 07:36:41 INFO - Return code: 0 07:36:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:41 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')]} 07:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:41 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')]} 07:36:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:41 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 0x7f1421f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', '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 07:36:41 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 07:36:41 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 07:36:41 INFO - Using env: {'DISPLAY': ':0', 07:36:41 INFO - 'HOME': '/home/cltbld', 07:36:41 INFO - 'LANG': 'en_US.UTF-8', 07:36:41 INFO - 'LANGUAGE': 'en_US:en', 07:36:41 INFO - 'LOGNAME': 'cltbld', 07:36:41 INFO - 'MAIL': '/var/mail/cltbld', 07:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:41 INFO - 'MOZ_NO_REMOTE': '1', 07:36:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:41 INFO - 'NO_EM_RESTART': '1', 07:36:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:41 INFO - 'PWD': '/builds/slave/test', 07:36:41 INFO - 'SHELL': '/bin/bash', 07:36:41 INFO - 'SHLVL': '1', 07:36:41 INFO - 'TERM': 'linux', 07:36:41 INFO - 'TMOUT': '86400', 07:36:41 INFO - 'USER': 'cltbld', 07:36:41 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', 07:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:41 INFO - '_': '/tools/buildbot/bin/python'} 07:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:41 INFO - Running setup.py (path:/tmp/pip-Jrz2mD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:41 INFO - Running setup.py (path:/tmp/pip-bklVaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:41 INFO - Running setup.py (path:/tmp/pip-HAr2JQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:41 INFO - Running setup.py (path:/tmp/pip-LYNA1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:41 INFO - Running setup.py (path:/tmp/pip-vUhrgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:41 INFO - Running setup.py (path:/tmp/pip-Iyeu8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:41 INFO - Running setup.py (path:/tmp/pip-bccEYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:41 INFO - Running setup.py (path:/tmp/pip-Ig4spr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:42 INFO - Running setup.py (path:/tmp/pip-0mSf9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:42 INFO - Running setup.py (path:/tmp/pip-9ITY4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:42 INFO - Running setup.py (path:/tmp/pip-z_57km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:42 INFO - Running setup.py (path:/tmp/pip-IpNBPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:42 INFO - Running setup.py (path:/tmp/pip-76emaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:42 INFO - Running setup.py (path:/tmp/pip-dygOgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:42 INFO - Running setup.py (path:/tmp/pip-B4sP5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:42 INFO - Running setup.py (path:/tmp/pip-Ebyng4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:42 INFO - Running setup.py (path:/tmp/pip-IXi81b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:42 INFO - Running setup.py install for manifestparser 07:36:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:42 INFO - Running setup.py install for mozcrash 07:36:42 INFO - Running setup.py install for mozdebug 07:36:42 INFO - Running setup.py install for mozdevice 07:36:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Running setup.py install for mozfile 07:36:43 INFO - Running setup.py install for mozhttpd 07:36:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Running setup.py install for mozinfo 07:36:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Running setup.py install for mozInstall 07:36:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Running setup.py install for mozleak 07:36:43 INFO - Running setup.py install for mozlog 07:36:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Running setup.py install for moznetwork 07:36:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Running setup.py install for mozprocess 07:36:43 INFO - Running setup.py install for mozprofile 07:36:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:44 INFO - Running setup.py install for mozrunner 07:36:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:44 INFO - Running setup.py install for mozscreenshot 07:36:44 INFO - Running setup.py install for moztest 07:36:44 INFO - Running setup.py install for mozversion 07:36:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:44 INFO - Cleaning up... 07:36:44 INFO - Return code: 0 07:36:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:44 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 0x7f1421f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', '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 07:36:44 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 07:36:44 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 07:36:44 INFO - Using env: {'DISPLAY': ':0', 07:36:44 INFO - 'HOME': '/home/cltbld', 07:36:44 INFO - 'LANG': 'en_US.UTF-8', 07:36:44 INFO - 'LANGUAGE': 'en_US:en', 07:36:44 INFO - 'LOGNAME': 'cltbld', 07:36:44 INFO - 'MAIL': '/var/mail/cltbld', 07:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:44 INFO - 'MOZ_NO_REMOTE': '1', 07:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:44 INFO - 'NO_EM_RESTART': '1', 07:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:44 INFO - 'PWD': '/builds/slave/test', 07:36:44 INFO - 'SHELL': '/bin/bash', 07:36:44 INFO - 'SHLVL': '1', 07:36:44 INFO - 'TERM': 'linux', 07:36:44 INFO - 'TMOUT': '86400', 07:36:44 INFO - 'USER': 'cltbld', 07:36:44 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', 07:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:44 INFO - '_': '/tools/buildbot/bin/python'} 07:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:44 INFO - Running setup.py (path:/tmp/pip-1zFxeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:44 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)) 07:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:44 INFO - Running setup.py (path:/tmp/pip-ctNpSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:44 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)) 07:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:44 INFO - Running setup.py (path:/tmp/pip-8RwC36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:44 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)) 07:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:44 INFO - Running setup.py (path:/tmp/pip-zWKx6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:44 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)) 07:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:44 INFO - Running setup.py (path:/tmp/pip-c2kTdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:45 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)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:45 INFO - Running setup.py (path:/tmp/pip-Tu75hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:45 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)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:45 INFO - Running setup.py (path:/tmp/pip-iOzAi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:45 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)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:45 INFO - Running setup.py (path:/tmp/pip-1fivFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:45 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)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:45 INFO - Running setup.py (path:/tmp/pip-_U39of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:45 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)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:45 INFO - Running setup.py (path:/tmp/pip-4HRoPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:45 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)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:45 INFO - Running setup.py (path:/tmp/pip-3Gx_Un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:45 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)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:45 INFO - Running setup.py (path:/tmp/pip-1ygIyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:45 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)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:45 INFO - Running setup.py (path:/tmp/pip-JdsbYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:45 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)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:45 INFO - Running setup.py (path:/tmp/pip-TIHc8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:45 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)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:45 INFO - Running setup.py (path:/tmp/pip-tvOSoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:45 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)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:45 INFO - Running setup.py (path:/tmp/pip-lp7zyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:45 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)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:45 INFO - Running setup.py (path:/tmp/pip-QaMa4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:45 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)) 07:36:45 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)) 07:36:45 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)) 07:36:45 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)) 07:36:45 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)) 07:36:45 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)) 07:36:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36: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 07:36:47 INFO - Downloading blessings-1.6.tar.gz 07:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:47 INFO - Installing collected packages: blessings 07:36:47 INFO - Running setup.py install for blessings 07:36:47 INFO - Successfully installed blessings 07:36:47 INFO - Cleaning up... 07:36:48 INFO - Return code: 0 07:36:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:48 INFO - Reading from file tmpfile_stdout 07:36:48 INFO - Current package versions: 07:36:48 INFO - argparse == 1.2.1 07:36:48 INFO - blessings == 1.6 07:36:48 INFO - blobuploader == 1.2.4 07:36:48 INFO - docopt == 0.6.1 07:36:48 INFO - functools32 == 3.2.3-2 07:36:48 INFO - jsonschema == 2.5.1 07:36:48 INFO - manifestparser == 1.1 07:36:48 INFO - mozInstall == 1.12 07:36:48 INFO - mozcrash == 0.17 07:36:48 INFO - mozdebug == 0.1 07:36:48 INFO - mozdevice == 0.48 07:36:48 INFO - mozfile == 1.2 07:36:48 INFO - mozhttpd == 0.7 07:36:48 INFO - mozinfo == 0.9 07:36:48 INFO - mozleak == 0.1 07:36:48 INFO - mozlog == 3.4 07:36:48 INFO - moznetwork == 0.27 07:36:48 INFO - mozprocess == 0.23 07:36:48 INFO - mozprofile == 0.28 07:36:48 INFO - mozrunner == 6.12 07:36:48 INFO - mozscreenshot == 0.1 07:36:48 INFO - mozsystemmonitor == 0.3 07:36:48 INFO - moztest == 0.7 07:36:48 INFO - mozversion == 1.4 07:36:48 INFO - psutil == 3.1.1 07:36:48 INFO - requests == 1.2.3 07:36:48 INFO - wsgiref == 0.1.2 07:36:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:48 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 0x7f1421f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', '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 07:36:48 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 07:36:48 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 07:36:48 INFO - Using env: {'DISPLAY': ':0', 07:36:48 INFO - 'HOME': '/home/cltbld', 07:36:48 INFO - 'LANG': 'en_US.UTF-8', 07:36:48 INFO - 'LANGUAGE': 'en_US:en', 07:36:48 INFO - 'LOGNAME': 'cltbld', 07:36:48 INFO - 'MAIL': '/var/mail/cltbld', 07:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:48 INFO - 'MOZ_NO_REMOTE': '1', 07:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:48 INFO - 'NO_EM_RESTART': '1', 07:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:48 INFO - 'PWD': '/builds/slave/test', 07:36:48 INFO - 'SHELL': '/bin/bash', 07:36:48 INFO - 'SHLVL': '1', 07:36:48 INFO - 'TERM': 'linux', 07:36:48 INFO - 'TMOUT': '86400', 07:36:48 INFO - 'USER': 'cltbld', 07:36:48 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', 07:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:48 INFO - '_': '/tools/buildbot/bin/python'} 07:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:48 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)) 07:36:48 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)) 07:36:48 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)) 07:36:48 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)) 07:36:48 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)) 07:36:48 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)) 07:36:48 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)) 07:36:48 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)) 07:36:48 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)) 07:36:48 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)) 07:36:48 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)) 07:36:48 INFO - Cleaning up... 07:36:48 INFO - Return code: 0 07:36:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:48 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 0x7f1421f5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', '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 07:36:48 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 07:36:48 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 07:36:48 INFO - Using env: {'DISPLAY': ':0', 07:36:48 INFO - 'HOME': '/home/cltbld', 07:36:48 INFO - 'LANG': 'en_US.UTF-8', 07:36:48 INFO - 'LANGUAGE': 'en_US:en', 07:36:48 INFO - 'LOGNAME': 'cltbld', 07:36:48 INFO - 'MAIL': '/var/mail/cltbld', 07:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:48 INFO - 'MOZ_NO_REMOTE': '1', 07:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:48 INFO - 'NO_EM_RESTART': '1', 07:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:48 INFO - 'PWD': '/builds/slave/test', 07:36:48 INFO - 'SHELL': '/bin/bash', 07:36:48 INFO - 'SHLVL': '1', 07:36:48 INFO - 'TERM': 'linux', 07:36:48 INFO - 'TMOUT': '86400', 07:36:48 INFO - 'USER': 'cltbld', 07:36:48 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', 07:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:48 INFO - '_': '/tools/buildbot/bin/python'} 07:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:48 INFO - Cleaning up... 07:36:48 INFO - Return code: 0 07:36:48 INFO - Running post-action listener: _resource_record_post_action 07:36:48 INFO - Running post-action listener: _start_resource_monitoring 07:36:48 INFO - Starting resource monitoring. 07:36:48 INFO - [mozharness: 2016-09-30 14:36:48.763804Z] Finished create-virtualenv step (success) 07:36:48 INFO - [mozharness: 2016-09-30 14:36:48.764303Z] Running install step. 07:36:48 INFO - Running pre-action listener: _resource_record_pre_action 07:36:48 INFO - Running main action method: install 07:36:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:48 INFO - Reading from file tmpfile_stdout 07:36:48 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:49 INFO - Reading from file tmpfile_stdout 07:36:49 INFO - Output received: 07:36:49 INFO - Usage: mozinstall [options] installer 07:36:49 INFO - Options: 07:36:49 INFO - -h, --help show this help message and exit 07:36:49 INFO - -d DEST, --destination=DEST 07:36:49 INFO - Directory to install application into. [default: 07:36:49 INFO - "/builds/slave/test"] 07:36:49 INFO - --app=APP Application being installed. [default: firefox] 07:36:49 INFO - mkdir: /builds/slave/test/build/application 07:36:49 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'] 07:36:49 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 07:37:05 INFO - Reading from file tmpfile_stdout 07:37:05 INFO - Output received: 07:37:05 INFO - /builds/slave/test/build/application/firefox/firefox 07:37:05 INFO - Running post-action listener: _resource_record_post_action 07:37:05 INFO - [mozharness: 2016-09-30 14:37:05.023022Z] Finished install step (success) 07:37:05 INFO - [mozharness: 2016-09-30 14:37:05.023269Z] Running run-tests step. 07:37:05 INFO - Running pre-action listener: _resource_record_pre_action 07:37:05 INFO - Running main action method: run_tests 07:37:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:37:05 INFO - Python 2.7.3 07:37:05 INFO - Return code: 0 07:37:05 INFO - grabbing minidump binary from tooltool 07:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:05 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 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:37:05 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 07:37:05 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 07:37:05 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 07:37:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:37:05 INFO - Return code: 0 07:37:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:37:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:37:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:37:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:37:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:37:05 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/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 07:37:05 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/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 07:37:05 INFO - Using env: {'DISPLAY': ':0', 07:37:05 INFO - 'HOME': '/home/cltbld', 07:37:05 INFO - 'LANG': 'en_US.UTF-8', 07:37:05 INFO - 'LANGUAGE': 'en_US:en', 07:37:05 INFO - 'LOGNAME': 'cltbld', 07:37:05 INFO - 'MAIL': '/var/mail/cltbld', 07:37:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:05 INFO - 'MOZ_NO_REMOTE': '1', 07:37:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:05 INFO - 'NO_EM_RESTART': '1', 07:37:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:05 INFO - 'PWD': '/builds/slave/test', 07:37:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:05 INFO - 'SHELL': '/bin/bash', 07:37:05 INFO - 'SHLVL': '1', 07:37:05 INFO - 'TERM': 'linux', 07:37:05 INFO - 'TMOUT': '86400', 07:37:05 INFO - 'USER': 'cltbld', 07:37:05 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050', 07:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:05 INFO - '_': '/tools/buildbot/bin/python'} 07:37:05 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/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 07:37:05 INFO - mozversion application_buildid: 20160930013320 07:37:05 INFO - mozversion application_changeset: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 07:37:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:37:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:05 INFO - mozversion application_name: Firefox 07:37:05 INFO - mozversion application_remotingname: firefox-dev 07:37:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:37:05 INFO - mozversion application_vendor: Mozilla 07:37:05 INFO - mozversion application_version: 51.0a2 07:37:05 INFO - mozversion platform_buildid: 20160930013320 07:37:05 INFO - mozversion platform_changeset: 805d5fc3d66c4fa585a3de407b1e0b055f78eb58 07:37:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:37:05 INFO - mozversion platform_version: 51.0a2 07:37:05 INFO - using testdate: 1475246225 07:37:05 INFO - actual date: 1475246225 07:37:05 INFO - starting webserver on 'localhost:49306' 07:37:05 INFO - SUITE-START | Running 2 tests 07:37:05 INFO - TEST-START | dromaeo_css 07:37:05 INFO - operating with platform_type : linux_ 07:37:05 INFO - Initialising browser for dromaeo_css test... 07:37:05 INFO - TEST-INFO | started process 29240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUR2lA8/profile http://localhost:49306/getInfo.html) 07:37:09 INFO - PROCESS | 29240 | __metrics Screen width/height:1600/1200 07:37:09 INFO - PROCESS | 29240 | colorDepth:24 07:37:09 INFO - PROCESS | 29240 | Browser inner width/height: 1024/697 07:37:09 INFO - PROCESS | 29240 | __metrics 07:37:09 INFO - PROCESS | 29240 | 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" 07:37:09 INFO - PROCESS | 29240 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:37:10 INFO - PROCESS | 29240 | console.error: PushService: 07:37:10 INFO - PROCESS | 29240 | stateChangeProcessEnqueue: Error transitioning state 07:37:10 INFO - PROCESS | 29240 | UnknownError 07:37:10 INFO - TEST-INFO | 29240: exit 0 07:37:10 INFO - Browser initialized. 07:37:10 INFO - Running cycle 1/1 for dromaeo_css test... 07:37:10 INFO - TEST-INFO | started process 29331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUR2lA8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:22 INFO - PROCESS | 29331 | RSS: Main: 147537920 07:37:22 INFO - PROCESS | 29331 | 07:38:13 INFO - PROCESS | 29331 | 1475246293595 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] 07:40:22 INFO - PROCESS | 29331 | Cycle 1(1): loaded http://localhost:49306/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49306/tests/dromaeo/cssquery-ext.html) 07:40:23 INFO - PROCESS | 29331 | RSS: Main: 238833664 07:40:23 INFO - PROCESS | 29331 | 07:43:26 INFO - PROCESS | 29331 | Cycle 1(1): loaded http://localhost:49306/tests/dromaeo/cssquery-ext.html (next: http://localhost:49306/tests/dromaeo/cssquery-jquery.html) 07:43:26 INFO - PROCESS | 29331 | RSS: Main: 232869888 07:43:26 INFO - PROCESS | 29331 | 07:46:28 INFO - PROCESS | 29331 | Cycle 1(1): loaded http://localhost:49306/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49306/tests/dromaeo/cssquery-mootools.html) 07:46:29 INFO - PROCESS | 29331 | RSS: Main: 201891840 07:46:29 INFO - PROCESS | 29331 | 07:49:31 INFO - PROCESS | 29331 | Cycle 1(1): loaded http://localhost:49306/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49306/tests/dromaeo/cssquery-prototype.html) 07:49:31 INFO - PROCESS | 29331 | RSS: Main: 218988544 07:49:31 INFO - PROCESS | 29331 | 07:52:34 INFO - PROCESS | 29331 | Cycle 1(1): loaded http://localhost:49306/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49306/tests/dromaeo/cssquery-yui.html) 07:52:35 INFO - PROCESS | 29331 | RSS: Main: 175296512 07:52:35 INFO - PROCESS | 29331 | 07:55:37 INFO - PROCESS | 29331 | Cycle 1(1): loaded http://localhost:49306/tests/dromaeo/cssquery-yui.html (next: http://localhost:49306/tests/dromaeo/cssquery-dojo.html) 07:55:37 INFO - PROCESS | 29331 | RSS: Main: 265388032 07:55:37 INFO - PROCESS | 29331 | 07:55:37 INFO - PROCESS | 29331 | __start_tp_report 07:55:37 INFO - PROCESS | 29331 | _x_x_mozilla_page_load 07:55:37 INFO - PROCESS | 29331 | _x_x_mozilla_page_load_details 07:55:37 INFO - PROCESS | 29331 | |i|pagename|runs| 07:55:37 INFO - PROCESS | 29331 | |0;dojo.html;2966.599509066276;3063.3107550801064;3088.4286407014706;3097.7057179567933;3119.422906762249;5420.322459692538;5478.91781623276;5484.287042684446;5490.094134467813;5524.143757717555;5459.727013649312;5475.151351540508;5478.178273259013;5500.944990550093;5515.365732940713;4946.678465899714;4970.279309500121;5002.9499705002845;5033.395992480908;5036.169032109698;4943.802247910097;4997.750112494379;5040.6471546991725;5059.316992206061;5067.189249720045;4912.754362281889;4968.950310496903;5009.04828082665;5025.321581586476;5026.070177017245;5052.964142350827;5101.948980510203;5135.897282054338;5149.201873709581;5159.303494028296;5036.320096786923;5045.974770126162;5099.71951542665;5101.974490127525;5103.004914041763;5250.553702935217;5335.919961200585;5345;5365.517103460668;5409.918851217235;5789.739461724233;5883.558733095035;5906.911396329058;5907.468327850471;5911.822645320647;5898.115282707586;5902;5917.289925208959;5922.792702255443;5927.911081333784;5280.445553216895;5319.734013299359;5446.809361672362;5484.149956756629;5503.587230957694;5990.520758339322;5998.550108741862;6004.729787159501;6006.5495087868585;6013.54898382623;5768.567357448124;5769.394213607595;5770.913436298459;5787.247657804459;5789.739461724233;5659.971700141556;5719.28508936383;5781.88436231273;5819.650820950672;5823.359430462646;5838.766449341979;5838.824835254949;5839.562032847553;5841.503472204825;5862.70686465675;5780.682062486603;5831.037878750044;5844.707764611752;5846.649201047951;5875.059990401601;4406.008648054162;4449.911001779947;4500.257457519538;4543.432070991126;4559.498455169929;4008.819603117867;4052.0275133967634;4071.3689378146437;4072.3687828386646;4088.8160032798596;5549.833504994856;5579.46995035471;5582.637128586629;5598.692071936082;5611.298587676541;5713.971430142823;5763.827085187451;5848.064309710426;5921.378255283219;5948.643081415129;5559.193916882029;5610.49505544503;5617.915731264035;5633.295838020247;5658.0381335173115;5153.3558305211845;5158.38099428071;5159.406668233201;5160.251763494347;5181.844544663666;5764.798232061858;5874.882502350015;6117.541184411187;6135.417135372132;6136.754529818846;5898.557608179318;5953.613015154001;5954.851128721816;5967.880642387215;5983.162357270073;6175.320714721287;6179.412955769195;6185.690715464299;6186.381361863958;6187.628742275478;5593.412691667317;5880.617759845767;5880.676562789087;5883;5884.47039766423;5646.407127251579;5809.796657116981;5829.329627092939;5877.0302900021015;5939.584229103922;5737.168110624019;5786.42135786418;5792.275965504312;5795.623284486495;5796.478316951495;5777.364489906191;5779.624324418899;5782.624129431573;5783.306003279633;5786.942130578809;5543.307086614173;5550.861228469321;5562.610617256915;5572.052751032254;5594.049011668108;5699.686517241592;5719.742611582572;5720.227769251098;5736.885262294814;5741.282339707536;5489.368722596792;5575.637583557056;5578;5578.553715702815;5582.944170558405 07:55:37 INFO - PROCESS | 29331 | |1;ext.html;587.5387820560858;598.9011813050847;625.4339822460672;628.1206311164373;635.920509936258;34097.488537671925;37404.812975935114;45138.32292515615;46318.76840615801;46321.30518042232;47740.283895741595;48150.51849481504;48183.27725084127;48209.27686084703;48333.75833120829;9146.634134634607;9293.117153870371;9302.116298951589;9304.58129384176;9312.953435232814;8503.61733721984;8701.173388528112;10928.617498387557;11165.330080195214;11179.66461006171;11324.207305488619;11430.142739294544;11437.428128593538;11441.427928603578;11442.141839362039;11172.44137793111;11205.887941120565;11257.155713321452;11264.718382040433;11267.60563380282;8438.704645337384;8609.870851937227;8648.610812513389;8916.821663566758;10572.52423640938;41453;44867.775661121486;44943.32585011228;45018.54981450176;45042.32436513455;4045.5954404559307;4085.20338533986;4429.335599660045;4479.2609219478745;4571.26859702446;33138.33723325544;33829.49255761166;33947;33986;33999.4900076499;4544.113897789933;4615.538446155391;4666.766661666937;4704.482506924235;4795.928061079087;357316;359633;360397.19801401085;360661;361027;61123;61541;61547;61613.69193154005;61757;66161.66919165374;66191;66240.66879665667;66285.33714662792;66395;19320.71018934717;19770.30803921856;19781.901090494455;19787.604247914962;19790.802091979185;13906.652333691536;15606.531804045897;15647.530574082795;15658.530244092695;15677.451289204822;14898.404063837324;16116.838831611769;16520.75218871694;16829.41097061597;17342.739858902125;6595.977623468274;6715.5299129060495;6716.361945615256;6890.2420733719255;6898.724051037902;1006.3106771861152;1037.4984427556994;1085.2945585369573;1125.7804728077947;1145.484531960621;33905.83047084749;34797.47803782945;34828;34912.47568769098;35060.29879402398;1135.392564977733;1138.0694711118902;1183.71590818203;1224.4306397525193;1225.7977433723513;17682.381116660854;17859.285628574973;18069.27722891096;18131.730778845355;18138.72492028867;544787;546084;549654;550721;553362;60879.695601522595;61074;61075.38924610786;61125.69437152875;61261;1292.9935350323376;1347.3600039981127;1375.1474086066703;1420.978685319721;1428.8356838963443;31109.8444507776;35462.82268588641;35782.74760383374;35818;35923.82038089793;52737.20894186667;53491;53549.46450535601;53601;53649.463505364445;407614;408150;408470;408793;409201;29924.401511969205;30686.846565767028;30835.537466937567;32633;43963.34054989114;47803;50976.490235097175;51334.743326284624;51730.48269517407;55705.44294557002;43182.56817431786;43209.56790432055;43825.34261986009;44220;45327;44108.779456102515;44381.98062186721;45080.323795143755;45232.32151517796;45986.31020534762;43095.78452107719;43738;44688.77655611701;45170.096598068514;45211.773941130086;36988.6301136996;39082.03203003324;39244.74784145879;39406;39413;29442.705572943996;29486.705132948395;29720.108396747266;29735.107946761633;30019.849900750356 07:55:37 INFO - PROCESS | 29331 | |2;jquery.html;381.84344418788305;395.9230891973832;412.4205491284745;414.84650679248676;431.0710419046953;14510.492132775355;16387.18064096795;20370.796292037074;21069.15723371067;21979.450513737163;20237.797622023812;20452.69320960183;20667.276645317415;20890.268840590583;21264;5757.222774925373;5890.087036509348;5893.998020336531;5930.4366085222055;5945.04879219325;4244.257254980382;5678.716064196794;5864.73608687608;5868.853278668024;5870.442307980735;4303.419038429819;4433.467983841943;4529.094181163764;6479.287278399373;6499.220093588776;5650.237217975562;6448.419642232198;6450.193725784254;6452.387023232785;6460.257070436889;5709.914351284734;5796.159556864273;5808.506276966463;5838.474537291664;5841.211436456109;14037.22795246261;14232.501862434869;14251.643708907257;14376.92811535946;14500.78248826258;2522.545941730488;2731.3035176030185;2834.985825070882;3111.548825420324;3204.5513628092085;10491.370517768883;10684.038436540748;10689.625863094754;10695.572177112907;10767.623133190378;1949.6685563454246;1953.2089503751004;2010.7788143304224;2012.788657191003;2014.738084049079;83248;86924.56537717335;87630.12369876284;89011.55494222487;89788;11680.123990700562;11680.182387232982;11723.651780045233;11755;12104;17015.23431445588;17036.14819259032;17037.97772133676;17042.65914681724;17042.829571704373;9009.954950225207;9088.318376121817;9225.308101892251;9234.67678631258;9331.34680572367;8481.406301558955;8499.23506884371;8520.957395213109;8687.652493900174;9234.399764015317;5137.2037334213255;5150.27896094547;5152.587792976553;5155.458676838953;5241.973790131101;2086.3115171993204;2086.4158035750015;2090.874547527153;2129.914803407846;2165.166410931771;905.959231834569;937;963.6723514005272;1026.4500604087732;1058.1799105692996;20719.378418647466;20763.377098687062;20930.37208883736;20931.8953405232;21224.151033958467;958.4536814016084;971.946542940145;972.3922548407245;991.8065977134534;1002.5338217728792;10614.946925265478;11477.713057173638;11631.069514438825;11655.53377864876;11737.413129343498;444551;447296;449480;482458;504791;56117;57268.14097788536;76535.61732191303;91182;91225.54387228022;1024.4109636958779;1035.3942943378058;1054.7310435838813;1057.2176589324;1057.8201705710048;18658.626827463104;18733.71899421537;19037.619247614693;19088.427347179608;19131;40847.183056338115;42164.578354216064;44988.55011449844;45027.32459013052;45101.54898451105;55566.44433555612;55880.72059639676;61179;61293;61869;6736.663166841737;8730.388872778845;8951.925768907773;9036.954815226145;9719.85420218683;8086.595670216583;12164.209326393757;13997.44010239579;14156.50452234167;14440.566782996528;11855.525778968744;12352.814707779211;12503.499860005499;12749.87250127487;12893.48426062947;11715.472803723682;12028.63914082579;12172.2696638202;12184.57353992606;12480.937595311965;12309.876901230873;12325.75348493043;12563;12592;13072.673183170116;8826.161514656098;8832.779180520538;9014.233790127913;9292.117248861347;9685.12833844929;11260.662180134608;11997.160198786001;12305.630831075083;12360.876391235972;12468.750624987631 07:55:37 INFO - PROCESS | 29331 | |3;mootools.html;1488.2930607961216;1516.6663334066504;1645.5227983884674;1774.8846324988883;1776.538100093976;7908.209179082089;8495.15048495151;8497.617607207674;8502.829943401128;8510.914890851105;7428.851422971537;7659.961700191505;8009.399295052865;8266.29736472399;8362.163783621634;2313.930582082536;2333.9649905251435;2337.6493525971155;2340.5435939991708;2341.391238278043;2329.196427232602;2343.7773411525877;2392.0910054179476;2393.688820453339;2394.1859767678984;2030.8172264496193;2097.1401725292635;2097.224027109964;2105.221068204766;2278.931632051033;2293.036924491709;2319.489712263299;2321.58211521926;2322.988385058081;2326.3718795925092;2325.895334709925;2331.2773040357542;2353.670486131943;2353.9058437662475;2362.7282862470865;8451.704190353308;8489.95755021221;8492.872606910902;8496.745097647081;8527.74416767498;4890.70655760652;5003.349564556621;5011.824586139504;5021.246812978046;5024.547790698818;3205.759568032407;3307.6196237432764;3340.6492318306714;3349.7487688423466;3355.681210285019;1127;1179.1215544419376;1184.7689700508404;1216.045404357575;1235.2218102595307;11092.445377731081;11121.22151449399;11156;11168.944155279172;11172;4312.676549258818;4342.08816148606;4463.152001119777;4474.597286244189;4581.106684196549;9579.568919398644;9585;9606.27952903521;9606.903930960601;9609.279304052225;5151.175811870083;5163.97418012915;5174.068667639785;5178.663386879841;5179.715115668599;4652.464966528825;4757.429108506932;4796.5203479651755;4819.325294458778;4821.276808478756;3886.300465916162;3903.921921561553;3957.5448823385677;3990.880273591797;4003.4795476587856;1232.0451649971344;1240.8448943882015;1243.173289762298;1265.7341958188883;1267.8732126787431;803.1847674610275;964.3105179796479;1022.3712416863575;1022.5654097008742;1042.921780866438;5728.598998070179;5853.356130825606;5972.820815375546;6140.3552626974415;6148.323684394713;1017.2269075502671;1022.2895087913829;1029;1047.6490375724065;1050.558765318568;4213.515445723781;4242.17277630859;4369.628581570539;4416.293393057095;4491.528389519119;10026.69919902404;10149.34029288094;10199.796004080024;10225.181985441295;10278.845817312746;10133.645322413828;10149.543270552844;10151.64469243573;10163.085322321027;10169.084782369622;7478.065241844878;7623.733169339046;7796.337311328487;7823.29590336861;7830.921690783133;5883.0881213411985;5938.881222375442;6061.454469097803;6080.179175811209;6133;8992.415492992934;9201.401908875901;9362.20421264173;9415.717528474157;9441.055894410778;9374.062593740571;9401.294902882175;9431.434113953184;9579.089986451276;9632.90367096348;7529.548227106391;7577.5453472791805;7605.429592780453;7657.6554055066545;7659.348955338635;8051.557164356017;8078.071021832565;8087.63605637736;8089.271965523131;8102.918970810217;7274.418046556369;7440.144383395762;7456.701731930662;7473.103227612722;7477.289657482748;7239.601821899635;7346.485745997729;7379.446541509301;7381.852362952818;7399.889001664872;6717.462602991651;6847.828804279933;6907;7036.929630703832;7051.189113252041;4955.35580374549;5110.9488905110475;5124.897502050013;5183.585313175013;5204.115300399017;4983.975080124576;5071;5242.18746094356;5253.317068781034;5368 07:55:37 INFO - PROCESS | 29331 | |4;prototype.html;309.08664895234585;329.90267870978073;333.48809577298846;340.99488507672373;343.692395306201;5302.337207849019;5379.596530260232;5496.093144631136;5550.139728342103;5567.359753628334;5193.338696219166;5365.4976606550135;5381.408045115034;5446;5449.209864569635;4350.8912277193;4357.825686972517;4360.585744354281;4360.8909777255585;4361.236783562879;4138.881812596471;4173.937390939138;4261.616454519092;4315.935260971088;4317.654587632982;4274.572542745732;4277;4281.614654681078;4283.807228674717;4286.871393858174;4290.2706539888295;4292.356146578007;4293.3989241506215;4298.247806633826;4308.159908817782;3714.925701485955;3843.3658446356317;3860.837930758756;3868.3617203161443;3878.758797184902;5355.678659280456;5379.838604841861;5388.838334849922;5396.352437707461;5420.756065977041;5003.899922001539;5010.799568017275;5013.248012798073;5014.2979982802435;5021.874453138665;5470.835874923759;5675.262215911946;5754.165645981351;5787.826365209008;5819.592628516006;4259.616634502879;4261.616454519108;4267.039916018871;4282.957170428287;4316.48202215733;5947.851303717442;6082.452579267887;6087.538990642258;6130.908036379458;6142.477889379408;4324.372965919924;4324.740515569076;4347.152305300436;4365.170617582649;4367.759773212504;4426.424564806554;4458.799354029076;4459.219636563588;4463.062756821039;4464.084862603224;4760.285957106462;4819.445763737145;4875.58608003675;4954.133026720309;4960.503949605083;5800.24596802413;5813.389594092644;5814.186013958049;5821.18503409523;5834.316214541273;1469.4930249064055;1517.924103794828;1530.8009958705297;1543.2515230113386;1545.412743157593;972.7179118055826;996.2826764729529;1003.9196864250843;1005.4319309590059;1007.415698894654;4852.296417019513;4962.280469331927;4966.404031516241;4981.701097934136;4999.75001249936;5199.8820253645645;5227.242049902743;5258.237555554423;5268.841934741964;5276.208568714724;4771.856844294677;4942;4949.554540091337;4966.970148209589;4967.584238492084;2768.29408500831;2814.3395396716037;2833.730795574458;2856.3858770364473;2864.8854045838348;5374.5700343972385;5400.866657670277;5424.83725488236;5433.375161856437;5436.320459942507;5114.43741188469;5257.447967963385;5310.654807437504;5317.441668624816;5396.325459317585;5254.868628284324;5349.759260833272;5371.113766228528;5373.973130134403;5381.408045115034;5206.453322401093;5244.370675518962;5299.873074885836;5341.679499230058;5375.274337964324;4927.3247095987535;5164.354455693038;5181.844544663666;5193.662411943212;5269;5382.9192562112385;5405.162199858871;5405.648587853037;5425.321834770653;5431.945680543144;4000.4999375078114;4008.2183974124764;4013.2174226025645;4020.4170395291935;4040.8887555922356;5416.2688037114485;5632.295963004624;5669.5180909621495;5907.9704601476715;5962.821115366546;5824.592278540462;5831;5831.95881441509;5868.415527807383;5869.413058694267;5602.187682785891;5825.854353641193;5831.650100993954;5895.55558888058;5941.1088336749835;5800.303963524404;5805.3614102447855;5808.796692115756;5812.273465816773;5814.244148260699;5833.416658334302;5893.086571581412;5903.645781253139;5944.138099975393;5957.76168953237;5496.367917689517;5752.482276595127;5772.480476757112;5779.595428319977;5826.533877289891 07:55:37 INFO - PROCESS | 29331 | |5;yui.html;791.2008871040248;794.5272562825118;825.6037102190949;881.264144439393;888.773362792488;16052.11713355765;17384.56538586536;17416.912915435405;17418.912905435456;17419.738703919436;16449.506514804547;16547.25537350819;16586.75119873203;16598.83401165988;16645.16774161293;703.539181835897;727.0403067950308;853.4068822168596;869.026690107081;873.3668090634303;860.178529504325;861.1474640106281;862.9266512346458;864.0236532718051;868.1578868497547;924.4638109896277;933.7198840347902;933.9906600934006;934.028610245344;934.9345545811796;759.6088014672448;777.7705576854842;879.3053487744673;895.7223260789176;921.5668635741191;664.4219529009744;664.8404382948106;665.451002922586;665.710415969055;665.963372014539;16676.082815445145;16739.07935063571;16741.581460463465;16745.07902065386;16754.66490670192;15811.762823557656;15933.521994340188;15969;16035.438759643357;16276.674466510603;14463.710725785531;14550.854491455057;14570.92714536431;14656.193909334983;14764.26178691072;4884.365032545782;4916.287138364953;4919.458859525449;4930.852074437773;4993.525615066563;79269.20730792676;84096;84236.57881710552;84331;84902.57548712278;12750.426230819636;13552.390142443417;13554.457821687021;13789.103708258932;13890.166590004632;22943.541129177658;23712.64431033536;23717.16989905345;24822.627660585105;24914.377140571632;9596.856047159297;9760.511974401252;9778.804423911482;9791.559379827924;10039.196864250842;4992.251162325608;5119.97440012805;5176.81881134166;5187.662801917939;5443.564514838803;3608.1701208722143;3779.7354185206773;3808.0670235791854;3815.904602384963;3817.904552386157;609.5276160975191;610.5298919831794;617.6417677746986;624.1916717850304;634.9523785715998;735.7792662201425;755.2221212151493;777.0442355902159;785.2853902948403;785.6896525872248;10149.188064954786;10626.574937002433;11172.44137793107;11197.49611267495;11464.54141834334;694.3126304958156;708.2634060576943;779.2013186483899;824.4558591329694;829.6473998550592;5292.655977361459;5328.946710532922;5360.3031605891765;5574.9721251393485;5629.324481062299;110174;115858;116843;120296.3985180086;122617.38691306664;75305;104890.47554762177;105290;106381.46809265904;107290;69150.81368897353;91622;93718.99999999863;94840.52579737057;95051.52474237584;10635.680929572125;10854.67435976922;10874.238803283693;10895.564177432814;11587.130965177814;55790;56789.71605142113;56874;57067.71466142643;58228;82023;82950.5852470758;84283;84999;86364;13118.111723678474;13226;13403.262820544574;13668;14017.088889222168;14763.483278085216;14788.260586970824;15344.232788360314;15853.920730396274;16298.022118672918;14637.560873173821;14943.178125203218;15008.174550399834;15068.849311507183;15959.840401595835;15019.249037548298;15440.691186176438;15874.365025398854;16161.4343497977;16734.916325418297;14974.401023959355;15049.849501504845;15077.54767356981;15494.295627481193;16283.918580407022;12098.637040888787;12750.489980401051;12953.681170138841;12969.610911672666;13356.99822513296;12608.154527804345;12888.355582221038;12888.613341599766;13123.737525249633;13284.53504127351 07:55:37 INFO - PROCESS | 29331 | __end_tp_report 07:55:37 INFO - PROCESS | 29331 | __start_cc_report 07:55:37 INFO - PROCESS | 29331 | _x_x_mozilla_cycle_collect,798 07:55:37 INFO - PROCESS | 29331 | __end_cc_report 07:55:37 INFO - PROCESS | 29331 | __startTimestamp1475247337964__endTimestamp 07:55:37 INFO - PROCESS | 29331 | 07:55:37 INFO - PROCESS | 29331 | ------- Summary: start ------- 07:55:37 INFO - PROCESS | 29331 | Number of tests: 6 07:55:37 INFO - PROCESS | 29331 | 07:55:37 INFO - PROCESS | 29331 | [#0] dojo.html Cycles:165 Average:5453.05 Median:5611.30 stddev:621.73 (11.1%) stddev-sans-first:592.25 07:55:37 INFO - PROCESS | 29331 | Values: 2966.6 3063.3 3088.4 3097.7 3119.4 5420.3 5478.9 5484.3 5490.1 5524.1 5459.7 5475.2 5478.2 5500.9 5515.4 4946.7 4970.3 5002.9 5033.4 5036.2 4943.8 4997.8 5040.6 5059.3 5067.2 4912.8 4969.0 5009.0 5025.3 5026.1 5053.0 5101.9 5135.9 5149.2 5159.3 5036.3 5046.0 5099.7 5102.0 5103.0 5250.6 5335.9 5345.0 5365.5 5409.9 5789.7 5883.6 5906.9 5907.5 5911.8 5898.1 5902.0 5917.3 5922.8 5927.9 5280.4 5319.7 5446.8 5484.1 5503.6 5990.5 5998.6 6004.7 6006.5 6013.5 5768.6 5769.4 5770.9 5787.2 5789.7 5660.0 5719.3 5781.9 5819.7 5823.4 5838.8 5838.8 5839.6 5841.5 5862.7 5780.7 5831.0 5844.7 5846.6 5875.1 4406.0 4449.9 4500.3 4543.4 4559.5 4008.8 4052.0 4071.4 4072.4 4088.8 5549.8 5579.5 5582.6 5598.7 5611.3 5714.0 5763.8 5848.1 5921.4 5948.6 5559.2 5610.5 5617.9 5633.3 5658.0 5153.4 5158.4 5159.4 5160.3 5181.8 5764.8 5874.9 6117.5 6135.4 6136.8 5898.6 5953.6 5954.9 5967.9 5983.2 6175.3 6179.4 6185.7 6186.4 6187.6 5593.4 5880.6 5880.7 5883.0 5884.5 5646.4 5809.8 5829.3 5877.0 5939.6 5737.2 5786.4 5792.3 5795.6 5796.5 5777.4 5779.6 5782.6 5783.3 5786.9 5543.3 5550.9 5562.6 5572.1 5594.0 5699.7 5719.7 5720.2 5736.9 5741.3 5489.4 5575.6 5578.0 5578.6 5582.9 07:55:37 INFO - PROCESS | 29331 | 07:55:37 INFO - PROCESS | 29331 | [#1] ext.html Cycles:180 Average:61784.96 Median:408997.00 stddev:118005.66 (28.9%) stddev-sans-first:118247.24 07:55:37 INFO - PROCESS | 29331 | Values: 587.5 598.9 625.4 628.1 635.9 34097.5 37404.8 45138.3 46318.8 46321.3 47740.3 48150.5 48183.3 48209.3 48333.8 9146.6 9293.1 9302.1 9304.6 9313.0 8503.6 8701.2 10928.6 11165.3 11179.7 11324.2 11430.1 11437.4 11441.4 11442.1 11172.4 11205.9 11257.2 11264.7 11267.6 8438.7 8609.9 8648.6 8916.8 10572.5 41453.0 44867.8 44943.3 45018.5 45042.3 4045.6 4085.2 4429.3 4479.3 4571.3 33138.3 33829.5 33947.0 33986.0 33999.5 4544.1 4615.5 4666.8 4704.5 4795.9 357316.0 359633.0 360397.2 360661.0 361027.0 61123.0 61541.0 61547.0 61613.7 61757.0 66161.7 66191.0 66240.7 66285.3 66395.0 19320.7 19770.3 19781.9 19787.6 19790.8 13906.7 15606.5 15647.5 15658.5 15677.5 14898.4 16116.8 16520.8 16829.4 17342.7 6596.0 6715.5 6716.4 6890.2 6898.7 1006.3 1037.5 1085.3 1125.8 1145.5 33905.8 34797.5 34828.0 34912.5 35060.3 1135.4 1138.1 1183.7 1224.4 1225.8 17682.4 17859.3 18069.3 18131.7 18138.7 544787.0 546084.0 549654.0 550721.0 553362.0 60879.7 61074.0 61075.4 61125.7 61261.0 1293.0 1347.4 1375.1 1421.0 1428.8 31109.8 35462.8 35782.7 35818.0 35923.8 52737.2 53491.0 53549.5 53601.0 53649.5 407614.0 408150.0 408470.0 408793.0 409201.0 29924.4 30686.8 30835.5 32633.0 43963.3 47803.0 50976.5 51334.7 51730.5 55705.4 43182.6 43209.6 43825.3 44220.0 45327.0 44108.8 44382.0 45080.3 45232.3 45986.3 43095.8 43738.0 44688.8 45170.1 45211.8 36988.6 39082.0 39244.7 39406.0 39413.0 29442.7 29486.7 29720.1 29735.1 30019.8 07:55:37 INFO - PROCESS | 29331 | 07:55:37 INFO - PROCESS | 29331 | [#2] jquery.html Cycles:180 Average:28239.18 Median:3158.05 stddev:76835.43 (2433.0%) stddev-sans-first:77022.51 07:55:37 INFO - PROCESS | 29331 | Values: 381.8 395.9 412.4 414.8 431.1 14510.5 16387.2 20370.8 21069.2 21979.5 20237.8 20452.7 20667.3 20890.3 21264.0 5757.2 5890.1 5894.0 5930.4 5945.0 4244.3 5678.7 5864.7 5868.9 5870.4 4303.4 4433.5 4529.1 6479.3 6499.2 5650.2 6448.4 6450.2 6452.4 6460.3 5709.9 5796.2 5808.5 5838.5 5841.2 14037.2 14232.5 14251.6 14376.9 14500.8 2522.5 2731.3 2835.0 3111.5 3204.6 10491.4 10684.0 10689.6 10695.6 10767.6 1949.7 1953.2 2010.8 2012.8 2014.7 83248.0 86924.6 87630.1 89011.6 89788.0 11680.1 11680.2 11723.7 11755.0 12104.0 17015.2 17036.1 17038.0 17042.7 17042.8 9010.0 9088.3 9225.3 9234.7 9331.3 8481.4 8499.2 8521.0 8687.7 9234.4 5137.2 5150.3 5152.6 5155.5 5242.0 2086.3 2086.4 2090.9 2129.9 2165.2 906.0 937.0 963.7 1026.5 1058.2 20719.4 20763.4 20930.4 20931.9 21224.2 958.5 971.9 972.4 991.8 1002.5 10614.9 11477.7 11631.1 11655.5 11737.4 444551.0 447296.0 449480.0 482458.0 504791.0 56117.0 57268.1 76535.6 91182.0 91225.5 1024.4 1035.4 1054.7 1057.2 1057.8 18658.6 18733.7 19037.6 19088.4 19131.0 40847.2 42164.6 44988.6 45027.3 45101.5 55566.4 55880.7 61179.0 61293.0 61869.0 6736.7 8730.4 8951.9 9037.0 9719.9 8086.6 12164.2 13997.4 14156.5 14440.6 11855.5 12352.8 12503.5 12749.9 12893.5 11715.5 12028.6 12172.3 12184.6 12480.9 12309.9 12325.8 12563.0 12592.0 13072.7 8826.2 8832.8 9014.2 9292.1 9685.1 11260.7 11997.2 12305.6 12360.9 12468.8 07:55:37 INFO - PROCESS | 29331 | 07:55:37 INFO - PROCESS | 29331 | [#3] mootools.html Cycles:180 Average:5571.37 Median:4993.66 stddev:3015.39 (60.4%) stddev-sans-first:3008.23 07:55:37 INFO - PROCESS | 29331 | Values: 1488.3 1516.7 1645.5 1774.9 1776.5 7908.2 8495.2 8497.6 8502.8 8510.9 7428.9 7660.0 8009.4 8266.3 8362.2 2313.9 2334.0 2337.6 2340.5 2341.4 2329.2 2343.8 2392.1 2393.7 2394.2 2030.8 2097.1 2097.2 2105.2 2278.9 2293.0 2319.5 2321.6 2323.0 2326.4 2325.9 2331.3 2353.7 2353.9 2362.7 8451.7 8490.0 8492.9 8496.7 8527.7 4890.7 5003.3 5011.8 5021.2 5024.5 3205.8 3307.6 3340.6 3349.7 3355.7 1127.0 1179.1 1184.8 1216.0 1235.2 11092.4 11121.2 11156.0 11168.9 11172.0 4312.7 4342.1 4463.2 4474.6 4581.1 9579.6 9585.0 9606.3 9606.9 9609.3 5151.2 5164.0 5174.1 5178.7 5179.7 4652.5 4757.4 4796.5 4819.3 4821.3 3886.3 3903.9 3957.5 3990.9 4003.5 1232.0 1240.8 1243.2 1265.7 1267.9 803.2 964.3 1022.4 1022.6 1042.9 5728.6 5853.4 5972.8 6140.4 6148.3 1017.2 1022.3 1029.0 1047.6 1050.6 4213.5 4242.2 4369.6 4416.3 4491.5 10026.7 10149.3 10199.8 10225.2 10278.8 10133.6 10149.5 10151.6 10163.1 10169.1 7478.1 7623.7 7796.3 7823.3 7830.9 5883.1 5938.9 6061.5 6080.2 6133.0 8992.4 9201.4 9362.2 9415.7 9441.1 9374.1 9401.3 9431.4 9579.1 9632.9 7529.5 7577.5 7605.4 7657.7 7659.3 8051.6 8078.1 8087.6 8089.3 8102.9 7274.4 7440.1 7456.7 7473.1 7477.3 7239.6 7346.5 7379.4 7381.9 7399.9 6717.5 6847.8 6907.0 7036.9 7051.2 4955.4 5110.9 5124.9 5183.6 5204.1 4984.0 5071.0 5242.2 5253.3 5368.0 07:55:37 INFO - PROCESS | 29331 | 07:55:37 INFO - PROCESS | 29331 | [#4] prototype.html Cycles:180 Average:4703.08 Median:5216.85 stddev:1343.89 (25.8%) stddev-sans-first:1306.56 07:55:37 INFO - PROCESS | 29331 | Values: 309.1 329.9 333.5 341.0 343.7 5302.3 5379.6 5496.1 5550.1 5567.4 5193.3 5365.5 5381.4 5446.0 5449.2 4350.9 4357.8 4360.6 4360.9 4361.2 4138.9 4173.9 4261.6 4315.9 4317.7 4274.6 4277.0 4281.6 4283.8 4286.9 4290.3 4292.4 4293.4 4298.2 4308.2 3714.9 3843.4 3860.8 3868.4 3878.8 5355.7 5379.8 5388.8 5396.4 5420.8 5003.9 5010.8 5013.2 5014.3 5021.9 5470.8 5675.3 5754.2 5787.8 5819.6 4259.6 4261.6 4267.0 4283.0 4316.5 5947.9 6082.5 6087.5 6130.9 6142.5 4324.4 4324.7 4347.2 4365.2 4367.8 4426.4 4458.8 4459.2 4463.1 4464.1 4760.3 4819.4 4875.6 4954.1 4960.5 5800.2 5813.4 5814.2 5821.2 5834.3 1469.5 1517.9 1530.8 1543.3 1545.4 972.7 996.3 1003.9 1005.4 1007.4 4852.3 4962.3 4966.4 4981.7 4999.8 5199.9 5227.2 5258.2 5268.8 5276.2 4771.9 4942.0 4949.6 4967.0 4967.6 2768.3 2814.3 2833.7 2856.4 2864.9 5374.6 5400.9 5424.8 5433.4 5436.3 5114.4 5257.4 5310.7 5317.4 5396.3 5254.9 5349.8 5371.1 5374.0 5381.4 5206.5 5244.4 5299.9 5341.7 5375.3 4927.3 5164.4 5181.8 5193.7 5269.0 5382.9 5405.2 5405.6 5425.3 5431.9 4000.5 4008.2 4013.2 4020.4 4040.9 5416.3 5632.3 5669.5 5908.0 5962.8 5824.6 5831.0 5832.0 5868.4 5869.4 5602.2 5825.9 5831.7 5895.6 5941.1 5800.3 5805.4 5808.8 5812.3 5814.2 5833.4 5893.1 5903.6 5944.1 5957.8 5496.4 5752.5 5772.5 5779.6 5826.5 07:55:37 INFO - PROCESS | 29331 | 07:55:37 INFO - PROCESS | 29331 | [#5] yui.html Cycles:180 Average:22444.69 Median:3693.95 stddev:31260.81 (846.3%) stddev-sans-first:31306.23 07:55:37 INFO - PROCESS | 29331 | Values: 791.2 794.5 825.6 881.3 888.8 16052.1 17384.6 17416.9 17418.9 17419.7 16449.5 16547.3 16586.8 16598.8 16645.2 703.5 727.0 853.4 869.0 873.4 860.2 861.1 862.9 864.0 868.2 924.5 933.7 934.0 934.0 934.9 759.6 777.8 879.3 895.7 921.6 664.4 664.8 665.5 665.7 666.0 16676.1 16739.1 16741.6 16745.1 16754.7 15811.8 15933.5 15969.0 16035.4 16276.7 14463.7 14550.9 14570.9 14656.2 14764.3 4884.4 4916.3 4919.5 4930.9 4993.5 79269.2 84096.0 84236.6 84331.0 84902.6 12750.4 13552.4 13554.5 13789.1 13890.2 22943.5 23712.6 23717.2 24822.6 24914.4 9596.9 9760.5 9778.8 9791.6 10039.2 4992.3 5120.0 5176.8 5187.7 5443.6 3608.2 3779.7 3808.1 3815.9 3817.9 609.5 610.5 617.6 624.2 635.0 735.8 755.2 777.0 785.3 785.7 10149.2 10626.6 11172.4 11197.5 11464.5 694.3 708.3 779.2 824.5 829.6 5292.7 5328.9 5360.3 5575.0 5629.3 110174.0 115858.0 116843.0 120296.4 122617.4 75305.0 104890.5 105290.0 106381.5 107290.0 69150.8 91622.0 93719.0 94840.5 95051.5 10635.7 10854.7 10874.2 10895.6 11587.1 55790.0 56789.7 56874.0 57067.7 58228.0 82023.0 82950.6 84283.0 84999.0 86364.0 13118.1 13226.0 13403.3 13668.0 14017.1 14763.5 14788.3 15344.2 15853.9 16298.0 14637.6 14943.2 15008.2 15068.8 15959.8 15019.2 15440.7 15874.4 16161.4 16734.9 14974.4 15049.8 15077.5 15494.3 16283.9 12098.6 12750.5 12953.7 12969.6 13357.0 12608.2 12888.4 12888.6 13123.7 13284.5 07:55:37 INFO - PROCESS | 29331 | -------- Summary: end -------- 07:55:37 INFO - PROCESS | 29331 | 07:55:38 INFO - TEST-INFO | 29331: exit 0 07:55:38 INFO - TEST-OK | dromaeo_css | took 1113412ms 07:55:38 INFO - TEST-START | kraken 07:55:38 INFO - operating with platform_type : linux_ 07:55:38 INFO - Initialising browser for kraken test... 07:55:38 INFO - TEST-INFO | started process 29647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiTOaOm/profile http://localhost:49306/getInfo.html) 07:55:42 INFO - PROCESS | 29647 | __metrics Screen width/height:1600/1200 07:55:42 INFO - PROCESS | 29647 | colorDepth:24 07:55:42 INFO - PROCESS | 29647 | Browser inner width/height: 1024/697 07:55:42 INFO - PROCESS | 29647 | __metrics 07:55:43 INFO - PROCESS | 29647 | 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" 07:55:43 INFO - PROCESS | 29647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:55:43 INFO - PROCESS | 29647 | console.error: PushService: 07:55:43 INFO - PROCESS | 29647 | stateChangeProcessEnqueue: Error transitioning state 07:55:43 INFO - PROCESS | 29647 | UnknownError 07:55:44 INFO - TEST-INFO | 29647: exit 0 07:55:44 INFO - Browser initialized. 07:55:44 INFO - Running cycle 1/1 for kraken test... 07:55:44 INFO - TEST-INFO | started process 29744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiTOaOm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:56 INFO - PROCESS | 29744 | RSS: Main: 144691200 07:55:56 INFO - PROCESS | 29744 | 07:55:58 INFO - PROCESS | 29744 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49306/tests/kraken/driver.html?testName=audio-beat-detection) 07:55:59 INFO - PROCESS | 29744 | RSS: Main: 186130432 07:55:59 INFO - PROCESS | 29744 | 07:56:01 INFO - PROCESS | 29744 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49306/tests/kraken/driver.html?testName=audio-dft) 07:56:02 INFO - PROCESS | 29744 | RSS: Main: 175431680 07:56:02 INFO - PROCESS | 29744 | 07:56:05 INFO - PROCESS | 29744 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49306/tests/kraken/driver.html?testName=audio-fft) 07:56:06 INFO - PROCESS | 29744 | RSS: Main: 266928128 07:56:06 INFO - PROCESS | 29744 | 07:56:08 INFO - PROCESS | 29744 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49306/tests/kraken/driver.html?testName=audio-oscillator) 07:56:08 INFO - PROCESS | 29744 | RSS: Main: 172814336 07:56:08 INFO - PROCESS | 29744 | 07:56:10 INFO - PROCESS | 29744 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49306/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:11 INFO - PROCESS | 29744 | RSS: Main: 173924352 07:56:11 INFO - PROCESS | 29744 | 07:56:14 INFO - PROCESS | 29744 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49306/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:14 INFO - PROCESS | 29744 | RSS: Main: 210108416 07:56:14 INFO - PROCESS | 29744 | 07:56:18 INFO - PROCESS | 29744 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49306/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:18 INFO - PROCESS | 29744 | RSS: Main: 209125376 07:56:18 INFO - PROCESS | 29744 | 07:56:21 INFO - PROCESS | 29744 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49306/tests/kraken/driver.html?testName=json-parse-financial) 07:56:22 INFO - PROCESS | 29744 | RSS: Main: 208711680 07:56:22 INFO - PROCESS | 29744 | 07:56:23 INFO - PROCESS | 29744 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49306/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:24 INFO - PROCESS | 29744 | RSS: Main: 170795008 07:56:24 INFO - PROCESS | 29744 | 07:56:26 INFO - PROCESS | 29744 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49306/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:26 INFO - PROCESS | 29744 | RSS: Main: 178544640 07:56:26 INFO - PROCESS | 29744 | 07:56:28 INFO - PROCESS | 29744 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49306/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:29 INFO - PROCESS | 29744 | RSS: Main: 183164928 07:56:29 INFO - PROCESS | 29744 | 07:56:31 INFO - PROCESS | 29744 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:32 INFO - PROCESS | 29744 | RSS: Main: 184623104 07:56:32 INFO - PROCESS | 29744 | 07:56:35 INFO - PROCESS | 29744 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:35 INFO - PROCESS | 29744 | RSS: Main: 182063104 07:56:35 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | Cycle 1(1): loaded http://localhost:49306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49306/tests/kraken/driver.html?testName=ai-astar) 07:56:37 INFO - PROCESS | 29744 | RSS: Main: 232996864 07:56:37 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | __start_tp_report 07:56:37 INFO - PROCESS | 29744 | _x_x_mozilla_page_load 07:56:37 INFO - PROCESS | 29744 | _x_x_mozilla_page_load_details 07:56:37 INFO - PROCESS | 29744 | |i|pagename|runs| 07:56:37 INFO - PROCESS | 29744 | |0;ai-astar;110;111;111;111;111;111;109;112;110;110 07:56:37 INFO - PROCESS | 29744 | |1;audio-beat-detection;146;120;118;170;116;118;117;124;165;117 07:56:37 INFO - PROCESS | 29744 | |2;audio-dft;160;161;162;161;160;160;160;161;160;161 07:56:37 INFO - PROCESS | 29744 | |3;audio-fft;75;75;76;112;75;75;76;74;102;75 07:56:37 INFO - PROCESS | 29744 | |4;audio-oscillator;82;82;126;81;84;82;99;82;82;109 07:56:37 INFO - PROCESS | 29744 | |5;imaging-gaussian-blur;117;116;117;117;117;116;116;118;117;117 07:56:37 INFO - PROCESS | 29744 | |6;imaging-darkroom;146;145;146;147;147;146;145;147;146;146 07:56:37 INFO - PROCESS | 29744 | |7;imaging-desaturate;95;96;96;95;95;96;96;95;95;95 07:56:37 INFO - PROCESS | 29744 | |8;json-parse-financial;49;48;53;49;48;49;48;50;49;49 07:56:37 INFO - PROCESS | 29744 | |9;json-stringify-tinderbox;58;59;58;58;59;60;59;59;59;59 07:56:37 INFO - PROCESS | 29744 | |10;stanford-crypto-aes;74;81;77;87;73;74;72;73;74;73 07:56:37 INFO - PROCESS | 29744 | |11;stanford-crypto-ccm;118;117;127;119;117;116;116;125;158;116 07:56:37 INFO - PROCESS | 29744 | |12;stanford-crypto-pbkdf2;155;158;160;150;152;157;152;154;148;153 07:56:37 INFO - PROCESS | 29744 | |13;stanford-crypto-sha256-iterative;65;62;62;62;60;69;63;64;63;61 07:56:37 INFO - PROCESS | 29744 | __end_tp_report 07:56:37 INFO - PROCESS | 29744 | __start_cc_report 07:56:37 INFO - PROCESS | 29744 | _x_x_mozilla_cycle_collect,1616 07:56:37 INFO - PROCESS | 29744 | __end_cc_report 07:56:37 INFO - PROCESS | 29744 | __startTimestamp1475247397497__endTimestamp 07:56:37 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | ------- Summary: start ------- 07:56:37 INFO - PROCESS | 29744 | Number of tests: 14 07:56:37 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:0.84 (0.8%) stddev-sans-first:0.87 07:56:37 INFO - PROCESS | 29744 | Values: 110.0 111.0 111.0 111.0 111.0 111.0 109.0 112.0 110.0 110.0 07:56:37 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | [#1] audio-beat-detection Cycles:10 Average:131.10 Median:122.00 stddev:21.15 (17.3%) stddev-sans-first:21.74 07:56:37 INFO - PROCESS | 29744 | Values: 146.0 120.0 118.0 170.0 116.0 118.0 117.0 124.0 165.0 117.0 07:56:37 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 07:56:37 INFO - PROCESS | 29744 | Values: 160.0 161.0 162.0 161.0 160.0 160.0 160.0 161.0 160.0 161.0 07:56:37 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.00 stddev:13.66 (18.2%) stddev-sans-first:14.28 07:56:37 INFO - PROCESS | 29744 | Values: 75.0 75.0 76.0 112.0 75.0 75.0 76.0 74.0 102.0 75.0 07:56:37 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:82.00 stddev:15.52 (18.9%) stddev-sans-first:16.12 07:56:37 INFO - PROCESS | 29744 | Values: 82.0 82.0 126.0 81.0 84.0 82.0 99.0 82.0 82.0 109.0 07:56:37 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 07:56:37 INFO - PROCESS | 29744 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 116.0 118.0 117.0 117.0 07:56:37 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 07:56:37 INFO - PROCESS | 29744 | Values: 146.0 145.0 146.0 147.0 147.0 146.0 145.0 147.0 146.0 146.0 07:56:37 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:56:37 INFO - PROCESS | 29744 | Values: 95.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 07:56:37 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | [#8] json-parse-financial Cycles:10 Average:49.20 Median:49.00 stddev:1.48 (3.0%) stddev-sans-first:1.56 07:56:37 INFO - PROCESS | 29744 | Values: 49.0 48.0 53.0 49.0 48.0 49.0 48.0 50.0 49.0 49.0 07:56:37 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 07:56:37 INFO - PROCESS | 29744 | Values: 58.0 59.0 58.0 58.0 59.0 60.0 59.0 59.0 59.0 59.0 07:56:37 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:74.00 stddev:4.73 (6.4%) stddev-sans-first:4.97 07:56:37 INFO - PROCESS | 29744 | Values: 74.0 81.0 77.0 87.0 73.0 74.0 72.0 73.0 74.0 73.0 07:56:37 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:118.50 stddev:12.93 (10.9%) stddev-sans-first:13.59 07:56:37 INFO - PROCESS | 29744 | Values: 118.0 117.0 127.0 119.0 117.0 116.0 116.0 125.0 158.0 116.0 07:56:37 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:154.50 stddev:3.70 (2.4%) stddev-sans-first:3.90 07:56:37 INFO - PROCESS | 29744 | Values: 155.0 158.0 160.0 150.0 152.0 157.0 152.0 154.0 148.0 153.0 07:56:37 INFO - PROCESS | 29744 | 07:56:37 INFO - PROCESS | 29744 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:2.51 (4.0%) stddev-sans-first:2.57 07:56:37 INFO - PROCESS | 29744 | Values: 65.0 62.0 62.0 62.0 60.0 69.0 63.0 64.0 63.0 61.0 07:56:37 INFO - PROCESS | 29744 | -------- Summary: end -------- 07:56:37 INFO - PROCESS | 29744 | 07:56:38 INFO - TEST-INFO | 29744: exit 0 07:56:38 INFO - TEST-OK | kraken | took 59891ms 07:56:38 INFO - SUITE-END | took 1173s 07:56:38 INFO - Completed test suite (00:19:33) 07:56:38 INFO - javascript benchmark 07:56:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2966.599509066276, 3063.3107550801064, 3088.4286407014706, 3097.7057179567933, 3119.422906762249, 5420.322459692538, 5478.91781623276, 5484.287042684446, 5490.094134467813, 5524.143757717555, 5459.727013649312, 5475.151351540508, 5478.178273259013, 5500.944990550093, 5515.365732940713, 4946.678465899714, 4970.279309500121, 5002.9499705002845, 5033.395992480908, 5036.169032109698, 4943.802247910097, 4997.750112494379, 5040.6471546991725, 5059.316992206061, 5067.189249720045, 4912.754362281889, 4968.950310496903, 5009.04828082665, 5025.321581586476, 5026.070177017245, 5052.964142350827, 5101.948980510203, 5135.897282054338, 5149.201873709581, 5159.303494028296, 5036.320096786923, 5045.974770126162, 5099.71951542665, 5101.974490127525, 5103.004914041763, 5250.553702935217, 5335.919961200585, 5345.0, 5365.517103460668, 5409.918851217235, 5789.739461724233, 5883.558733095035, 5906.911396329058, 5907.468327850471, 5911.822645320647, 5898.115282707586, 5902.0, 5917.289925208959, 5922.792702255443, 5927.911081333784, 5280.445553216895, 5319.734013299359, 5446.809361672362, 5484.149956756629, 5503.587230957694, 5990.520758339322, 5998.550108741862, 6004.729787159501, 6006.5495087868585, 6013.54898382623, 5768.567357448124, 5769.394213607595, 5770.913436298459, 5787.247657804459, 5789.739461724233, 5659.971700141556, 5719.28508936383, 5781.88436231273, 5819.650820950672, 5823.359430462646, 5838.766449341979, 5838.824835254949, 5839.562032847553, 5841.503472204825, 5862.70686465675, 5780.682062486603, 5831.037878750044, 5844.707764611752, 5846.649201047951, 5875.059990401601, 4406.008648054162, 4449.911001779947, 4500.257457519538, 4543.432070991126, 4559.498455169929, 4008.819603117867, 4052.0275133967634, 4071.3689378146437, 4072.3687828386646, 4088.8160032798596, 5549.833504994856, 5579.46995035471, 5582.637128586629, 5598.692071936082, 5611.298587676541, 5713.971430142823, 5763.827085187451, 5848.064309710426, 5921.378255283219, 5948.643081415129, 5559.193916882029, 5610.49505544503, 5617.915731264035, 5633.295838020247, 5658.0381335173115, 5153.3558305211845, 5158.38099428071, 5159.406668233201, 5160.251763494347, 5181.844544663666, 5764.798232061858, 5874.882502350015, 6117.541184411187, 6135.417135372132, 6136.754529818846, 5898.557608179318, 5953.613015154001, 5954.851128721816, 5967.880642387215, 5983.162357270073, 6175.320714721287, 6179.412955769195, 6185.690715464299, 6186.381361863958, 6187.628742275478, 5593.412691667317, 5880.617759845767, 5880.676562789087, 5883.0, 5884.47039766423, 5646.407127251579, 5809.796657116981, 5829.329627092939, 5877.0302900021015, 5939.584229103922, 5737.168110624019, 5786.42135786418, 5792.275965504312, 5795.623284486495, 5796.478316951495, 5777.364489906191, 5779.624324418899, 5782.624129431573, 5783.306003279633, 5786.942130578809, 5543.307086614173, 5550.861228469321, 5562.610617256915, 5572.052751032254, 5594.049011668108, 5699.686517241592, 5719.742611582572, 5720.227769251098, 5736.885262294814, 5741.282339707536, 5489.368722596792, 5575.637583557056, 5578.0, 5578.553715702815, 5582.944170558405], "value": 5410.126818171588, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.5387820560858, 598.9011813050847, 625.4339822460672, 628.1206311164373, 635.920509936258, 34097.488537671925, 37404.812975935114, 45138.32292515615, 46318.76840615801, 46321.30518042232, 47740.283895741595, 48150.51849481504, 48183.27725084127, 48209.27686084703, 48333.75833120829, 9146.634134634607, 9293.117153870371, 9302.116298951589, 9304.58129384176, 9312.953435232814, 8503.61733721984, 8701.173388528112, 10928.617498387557, 11165.330080195214, 11179.66461006171, 11324.207305488619, 11430.142739294544, 11437.428128593538, 11441.427928603578, 11442.141839362039, 11172.44137793111, 11205.887941120565, 11257.155713321452, 11264.718382040433, 11267.60563380282, 8438.704645337384, 8609.870851937227, 8648.610812513389, 8916.821663566758, 10572.52423640938, 41453.0, 44867.775661121486, 44943.32585011228, 45018.54981450176, 45042.32436513455, 4045.5954404559307, 4085.20338533986, 4429.335599660045, 4479.2609219478745, 4571.26859702446, 33138.33723325544, 33829.49255761166, 33947.0, 33986.0, 33999.4900076499, 4544.113897789933, 4615.538446155391, 4666.766661666937, 4704.482506924235, 4795.928061079087, 357316.0, 359633.0, 360397.19801401085, 360661.0, 361027.0, 61123.0, 61541.0, 61547.0, 61613.69193154005, 61757.0, 66161.66919165374, 66191.0, 66240.66879665667, 66285.33714662792, 66395.0, 19320.71018934717, 19770.30803921856, 19781.901090494455, 19787.604247914962, 19790.802091979185, 13906.652333691536, 15606.531804045897, 15647.530574082795, 15658.530244092695, 15677.451289204822, 14898.404063837324, 16116.838831611769, 16520.75218871694, 16829.41097061597, 17342.739858902125, 6595.977623468274, 6715.5299129060495, 6716.361945615256, 6890.2420733719255, 6898.724051037902, 1006.3106771861152, 1037.4984427556994, 1085.2945585369573, 1125.7804728077947, 1145.484531960621, 33905.83047084749, 34797.47803782945, 34828.0, 34912.47568769098, 35060.29879402398, 1135.392564977733, 1138.0694711118902, 1183.71590818203, 1224.4306397525193, 1225.7977433723513, 17682.381116660854, 17859.285628574973, 18069.27722891096, 18131.730778845355, 18138.72492028867, 544787.0, 546084.0, 549654.0, 550721.0, 553362.0, 60879.695601522595, 61074.0, 61075.38924610786, 61125.69437152875, 61261.0, 1292.9935350323376, 1347.3600039981127, 1375.1474086066703, 1420.978685319721, 1428.8356838963443, 31109.8444507776, 35462.82268588641, 35782.74760383374, 35818.0, 35923.82038089793, 52737.20894186667, 53491.0, 53549.46450535601, 53601.0, 53649.463505364445, 407614.0, 408150.0, 408470.0, 408793.0, 409201.0, 29924.401511969205, 30686.846565767028, 30835.537466937567, 32633.0, 43963.34054989114, 47803.0, 50976.490235097175, 51334.743326284624, 51730.48269517407, 55705.44294557002, 43182.56817431786, 43209.56790432055, 43825.34261986009, 44220.0, 45327.0, 44108.779456102515, 44381.98062186721, 45080.323795143755, 45232.32151517796, 45986.31020534762, 43095.78452107719, 43738.0, 44688.77655611701, 45170.096598068514, 45211.773941130086, 36988.6301136996, 39082.03203003324, 39244.74784145879, 39406.0, 39413.0, 29442.705572943996, 29486.705132948395, 29720.108396747266, 29735.107946761633, 30019.849900750356], "value": 21524.737742447745, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.84344418788305, 395.9230891973832, 412.4205491284745, 414.84650679248676, 431.0710419046953, 14510.492132775355, 16387.18064096795, 20370.796292037074, 21069.15723371067, 21979.450513737163, 20237.797622023812, 20452.69320960183, 20667.276645317415, 20890.268840590583, 21264.0, 5757.222774925373, 5890.087036509348, 5893.998020336531, 5930.4366085222055, 5945.04879219325, 4244.257254980382, 5678.716064196794, 5864.73608687608, 5868.853278668024, 5870.442307980735, 4303.419038429819, 4433.467983841943, 4529.094181163764, 6479.287278399373, 6499.220093588776, 5650.237217975562, 6448.419642232198, 6450.193725784254, 6452.387023232785, 6460.257070436889, 5709.914351284734, 5796.159556864273, 5808.506276966463, 5838.474537291664, 5841.211436456109, 14037.22795246261, 14232.501862434869, 14251.643708907257, 14376.92811535946, 14500.78248826258, 2522.545941730488, 2731.3035176030185, 2834.985825070882, 3111.548825420324, 3204.5513628092085, 10491.370517768883, 10684.038436540748, 10689.625863094754, 10695.572177112907, 10767.623133190378, 1949.6685563454246, 1953.2089503751004, 2010.7788143304224, 2012.788657191003, 2014.738084049079, 83248.0, 86924.56537717335, 87630.12369876284, 89011.55494222487, 89788.0, 11680.123990700562, 11680.182387232982, 11723.651780045233, 11755.0, 12104.0, 17015.23431445588, 17036.14819259032, 17037.97772133676, 17042.65914681724, 17042.829571704373, 9009.954950225207, 9088.318376121817, 9225.308101892251, 9234.67678631258, 9331.34680572367, 8481.406301558955, 8499.23506884371, 8520.957395213109, 8687.652493900174, 9234.399764015317, 5137.2037334213255, 5150.27896094547, 5152.587792976553, 5155.458676838953, 5241.973790131101, 2086.3115171993204, 2086.4158035750015, 2090.874547527153, 2129.914803407846, 2165.166410931771, 905.959231834569, 937.0, 963.6723514005272, 1026.4500604087732, 1058.1799105692996, 20719.378418647466, 20763.377098687062, 20930.37208883736, 20931.8953405232, 21224.151033958467, 958.4536814016084, 971.946542940145, 972.3922548407245, 991.8065977134534, 1002.5338217728792, 10614.946925265478, 11477.713057173638, 11631.069514438825, 11655.53377864876, 11737.413129343498, 444551.0, 447296.0, 449480.0, 482458.0, 504791.0, 56117.0, 57268.14097788536, 76535.61732191303, 91182.0, 91225.54387228022, 1024.4109636958779, 1035.3942943378058, 1054.7310435838813, 1057.2176589324, 1057.8201705710048, 18658.626827463104, 18733.71899421537, 19037.619247614693, 19088.427347179608, 19131.0, 40847.183056338115, 42164.578354216064, 44988.55011449844, 45027.32459013052, 45101.54898451105, 55566.44433555612, 55880.72059639676, 61179.0, 61293.0, 61869.0, 6736.663166841737, 8730.388872778845, 8951.925768907773, 9036.954815226145, 9719.85420218683, 8086.595670216583, 12164.209326393757, 13997.44010239579, 14156.50452234167, 14440.566782996528, 11855.525778968744, 12352.814707779211, 12503.499860005499, 12749.87250127487, 12893.48426062947, 11715.472803723682, 12028.63914082579, 12172.2696638202, 12184.57353992606, 12480.937595311965, 12309.876901230873, 12325.75348493043, 12563.0, 12592.0, 13072.673183170116, 8826.161514656098, 8832.779180520538, 9014.233790127913, 9292.117248861347, 9685.12833844929, 11260.662180134608, 11997.160198786001, 12305.630831075083, 12360.876391235972, 12468.750624987631], "value": 9431.83532813178, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1488.2930607961216, 1516.6663334066504, 1645.5227983884674, 1774.8846324988883, 1776.538100093976, 7908.209179082089, 8495.15048495151, 8497.617607207674, 8502.829943401128, 8510.914890851105, 7428.851422971537, 7659.961700191505, 8009.399295052865, 8266.29736472399, 8362.163783621634, 2313.930582082536, 2333.9649905251435, 2337.6493525971155, 2340.5435939991708, 2341.391238278043, 2329.196427232602, 2343.7773411525877, 2392.0910054179476, 2393.688820453339, 2394.1859767678984, 2030.8172264496193, 2097.1401725292635, 2097.224027109964, 2105.221068204766, 2278.931632051033, 2293.036924491709, 2319.489712263299, 2321.58211521926, 2322.988385058081, 2326.3718795925092, 2325.895334709925, 2331.2773040357542, 2353.670486131943, 2353.9058437662475, 2362.7282862470865, 8451.704190353308, 8489.95755021221, 8492.872606910902, 8496.745097647081, 8527.74416767498, 4890.70655760652, 5003.349564556621, 5011.824586139504, 5021.246812978046, 5024.547790698818, 3205.759568032407, 3307.6196237432764, 3340.6492318306714, 3349.7487688423466, 3355.681210285019, 1127.0, 1179.1215544419376, 1184.7689700508404, 1216.045404357575, 1235.2218102595307, 11092.445377731081, 11121.22151449399, 11156.0, 11168.944155279172, 11172.0, 4312.676549258818, 4342.08816148606, 4463.152001119777, 4474.597286244189, 4581.106684196549, 9579.568919398644, 9585.0, 9606.27952903521, 9606.903930960601, 9609.279304052225, 5151.175811870083, 5163.97418012915, 5174.068667639785, 5178.663386879841, 5179.715115668599, 4652.464966528825, 4757.429108506932, 4796.5203479651755, 4819.325294458778, 4821.276808478756, 3886.300465916162, 3903.921921561553, 3957.5448823385677, 3990.880273591797, 4003.4795476587856, 1232.0451649971344, 1240.8448943882015, 1243.173289762298, 1265.7341958188883, 1267.8732126787431, 803.1847674610275, 964.3105179796479, 1022.3712416863575, 1022.5654097008742, 1042.921780866438, 5728.598998070179, 5853.356130825606, 5972.820815375546, 6140.3552626974415, 6148.323684394713, 1017.2269075502671, 1022.2895087913829, 1029.0, 1047.6490375724065, 1050.558765318568, 4213.515445723781, 4242.17277630859, 4369.628581570539, 4416.293393057095, 4491.528389519119, 10026.69919902404, 10149.34029288094, 10199.796004080024, 10225.181985441295, 10278.845817312746, 10133.645322413828, 10149.543270552844, 10151.64469243573, 10163.085322321027, 10169.084782369622, 7478.065241844878, 7623.733169339046, 7796.337311328487, 7823.29590336861, 7830.921690783133, 5883.0881213411985, 5938.881222375442, 6061.454469097803, 6080.179175811209, 6133.0, 8992.415492992934, 9201.401908875901, 9362.20421264173, 9415.717528474157, 9441.055894410778, 9374.062593740571, 9401.294902882175, 9431.434113953184, 9579.089986451276, 9632.90367096348, 7529.548227106391, 7577.5453472791805, 7605.429592780453, 7657.6554055066545, 7659.348955338635, 8051.557164356017, 8078.071021832565, 8087.63605637736, 8089.271965523131, 8102.918970810217, 7274.418046556369, 7440.144383395762, 7456.701731930662, 7473.103227612722, 7477.289657482748, 7239.601821899635, 7346.485745997729, 7379.446541509301, 7381.852362952818, 7399.889001664872, 6717.462602991651, 6847.828804279933, 6907.0, 7036.929630703832, 7051.189113252041, 4955.35580374549, 5110.9488905110475, 5124.897502050013, 5183.585313175013, 5204.115300399017, 4983.975080124576, 5071.0, 5242.18746094356, 5253.317068781034, 5368.0], "value": 4540.9814287344525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.08664895234585, 329.90267870978073, 333.48809577298846, 340.99488507672373, 343.692395306201, 5302.337207849019, 5379.596530260232, 5496.093144631136, 5550.139728342103, 5567.359753628334, 5193.338696219166, 5365.4976606550135, 5381.408045115034, 5446.0, 5449.209864569635, 4350.8912277193, 4357.825686972517, 4360.585744354281, 4360.8909777255585, 4361.236783562879, 4138.881812596471, 4173.937390939138, 4261.616454519092, 4315.935260971088, 4317.654587632982, 4274.572542745732, 4277.0, 4281.614654681078, 4283.807228674717, 4286.871393858174, 4290.2706539888295, 4292.356146578007, 4293.3989241506215, 4298.247806633826, 4308.159908817782, 3714.925701485955, 3843.3658446356317, 3860.837930758756, 3868.3617203161443, 3878.758797184902, 5355.678659280456, 5379.838604841861, 5388.838334849922, 5396.352437707461, 5420.756065977041, 5003.899922001539, 5010.799568017275, 5013.248012798073, 5014.2979982802435, 5021.874453138665, 5470.835874923759, 5675.262215911946, 5754.165645981351, 5787.826365209008, 5819.592628516006, 4259.616634502879, 4261.616454519108, 4267.039916018871, 4282.957170428287, 4316.48202215733, 5947.851303717442, 6082.452579267887, 6087.538990642258, 6130.908036379458, 6142.477889379408, 4324.372965919924, 4324.740515569076, 4347.152305300436, 4365.170617582649, 4367.759773212504, 4426.424564806554, 4458.799354029076, 4459.219636563588, 4463.062756821039, 4464.084862603224, 4760.285957106462, 4819.445763737145, 4875.58608003675, 4954.133026720309, 4960.503949605083, 5800.24596802413, 5813.389594092644, 5814.186013958049, 5821.18503409523, 5834.316214541273, 1469.4930249064055, 1517.924103794828, 1530.8009958705297, 1543.2515230113386, 1545.412743157593, 972.7179118055826, 996.2826764729529, 1003.9196864250843, 1005.4319309590059, 1007.415698894654, 4852.296417019513, 4962.280469331927, 4966.404031516241, 4981.701097934136, 4999.75001249936, 5199.8820253645645, 5227.242049902743, 5258.237555554423, 5268.841934741964, 5276.208568714724, 4771.856844294677, 4942.0, 4949.554540091337, 4966.970148209589, 4967.584238492084, 2768.29408500831, 2814.3395396716037, 2833.730795574458, 2856.3858770364473, 2864.8854045838348, 5374.5700343972385, 5400.866657670277, 5424.83725488236, 5433.375161856437, 5436.320459942507, 5114.43741188469, 5257.447967963385, 5310.654807437504, 5317.441668624816, 5396.325459317585, 5254.868628284324, 5349.759260833272, 5371.113766228528, 5373.973130134403, 5381.408045115034, 5206.453322401093, 5244.370675518962, 5299.873074885836, 5341.679499230058, 5375.274337964324, 4927.3247095987535, 5164.354455693038, 5181.844544663666, 5193.662411943212, 5269.0, 5382.9192562112385, 5405.162199858871, 5405.648587853037, 5425.321834770653, 5431.945680543144, 4000.4999375078114, 4008.2183974124764, 4013.2174226025645, 4020.4170395291935, 4040.8887555922356, 5416.2688037114485, 5632.295963004624, 5669.5180909621495, 5907.9704601476715, 5962.821115366546, 5824.592278540462, 5831.0, 5831.95881441509, 5868.415527807383, 5869.413058694267, 5602.187682785891, 5825.854353641193, 5831.650100993954, 5895.55558888058, 5941.1088336749835, 5800.303963524404, 5805.3614102447855, 5808.796692115756, 5812.273465816773, 5814.244148260699, 5833.416658334302, 5893.086571581412, 5903.645781253139, 5944.138099975393, 5957.76168953237, 5496.367917689517, 5752.482276595127, 5772.480476757112, 5779.595428319977, 5826.533877289891], "value": 4277.5704238052895, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.2008871040248, 794.5272562825118, 825.6037102190949, 881.264144439393, 888.773362792488, 16052.11713355765, 17384.56538586536, 17416.912915435405, 17418.912905435456, 17419.738703919436, 16449.506514804547, 16547.25537350819, 16586.75119873203, 16598.83401165988, 16645.16774161293, 703.539181835897, 727.0403067950308, 853.4068822168596, 869.026690107081, 873.3668090634303, 860.178529504325, 861.1474640106281, 862.9266512346458, 864.0236532718051, 868.1578868497547, 924.4638109896277, 933.7198840347902, 933.9906600934006, 934.028610245344, 934.9345545811796, 759.6088014672448, 777.7705576854842, 879.3053487744673, 895.7223260789176, 921.5668635741191, 664.4219529009744, 664.8404382948106, 665.451002922586, 665.710415969055, 665.963372014539, 16676.082815445145, 16739.07935063571, 16741.581460463465, 16745.07902065386, 16754.66490670192, 15811.762823557656, 15933.521994340188, 15969.0, 16035.438759643357, 16276.674466510603, 14463.710725785531, 14550.854491455057, 14570.92714536431, 14656.193909334983, 14764.26178691072, 4884.365032545782, 4916.287138364953, 4919.458859525449, 4930.852074437773, 4993.525615066563, 79269.20730792676, 84096.0, 84236.57881710552, 84331.0, 84902.57548712278, 12750.426230819636, 13552.390142443417, 13554.457821687021, 13789.103708258932, 13890.166590004632, 22943.541129177658, 23712.64431033536, 23717.16989905345, 24822.627660585105, 24914.377140571632, 9596.856047159297, 9760.511974401252, 9778.804423911482, 9791.559379827924, 10039.196864250842, 4992.251162325608, 5119.97440012805, 5176.81881134166, 5187.662801917939, 5443.564514838803, 3608.1701208722143, 3779.7354185206773, 3808.0670235791854, 3815.904602384963, 3817.904552386157, 609.5276160975191, 610.5298919831794, 617.6417677746986, 624.1916717850304, 634.9523785715998, 735.7792662201425, 755.2221212151493, 777.0442355902159, 785.2853902948403, 785.6896525872248, 10149.188064954786, 10626.574937002433, 11172.44137793107, 11197.49611267495, 11464.54141834334, 694.3126304958156, 708.2634060576943, 779.2013186483899, 824.4558591329694, 829.6473998550592, 5292.655977361459, 5328.946710532922, 5360.3031605891765, 5574.9721251393485, 5629.324481062299, 110174.0, 115858.0, 116843.0, 120296.3985180086, 122617.38691306664, 75305.0, 104890.47554762177, 105290.0, 106381.46809265904, 107290.0, 69150.81368897353, 91622.0, 93718.99999999863, 94840.52579737057, 95051.52474237584, 10635.680929572125, 10854.67435976922, 10874.238803283693, 10895.564177432814, 11587.130965177814, 55790.0, 56789.71605142113, 56874.0, 57067.71466142643, 58228.0, 82023.0, 82950.5852470758, 84283.0, 84999.0, 86364.0, 13118.111723678474, 13226.0, 13403.262820544574, 13668.0, 14017.088889222168, 14763.483278085216, 14788.260586970824, 15344.232788360314, 15853.920730396274, 16298.022118672918, 14637.560873173821, 14943.178125203218, 15008.174550399834, 15068.849311507183, 15959.840401595835, 15019.249037548298, 15440.691186176438, 15874.365025398854, 16161.4343497977, 16734.916325418297, 14974.401023959355, 15049.849501504845, 15077.54767356981, 15494.295627481193, 16283.918580407022, 12098.637040888787, 12750.489980401051, 12953.681170138841, 12969.610911672666, 13356.99822513296, 12608.154527804345, 12888.355582221038, 12888.613341599766, 13123.737525249633, 13284.53504127351], "value": 8316.855875884285, "unit": "score"}], "name": "dromaeo_css", "value": 7496.340581840247, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 111.0, 111.0, 111.0, 111.0, 109.0, 112.0, 110.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 120.0, 118.0, 170.0, 116.0, 118.0, 117.0, 124.0, 165.0, 117.0], "value": 131.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 161.0, 160.0, 160.0, 160.0, 161.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 112.0, 75.0, 75.0, 76.0, 74.0, 102.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 126.0, 81.0, 84.0, 82.0, 99.0, 82.0, 82.0, 109.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 118.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 147.0, 147.0, 146.0, 145.0, 147.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 53.0, 49.0, 48.0, 49.0, 48.0, 50.0, 49.0, 49.0], "value": 49.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 81.0, 77.0, 87.0, 73.0, 74.0, 72.0, 73.0, 74.0, 73.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 127.0, 119.0, 117.0, 116.0, 116.0, 125.0, 158.0, 116.0], "value": 122.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 158.0, 160.0, 150.0, 152.0, 157.0, 152.0, 154.0, 148.0, 153.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 62.0, 60.0, 69.0, 63.0, 64.0, 63.0, 61.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1456.7, "alertThreshold": 2.0}]} 07:56:38 INFO - Return code: 0 07:56:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:38 INFO - # TBPL SUCCESS # 07:56:38 INFO - Running post-action listener: _resource_record_post_action 07:56:38 INFO - [mozharness: 2016-09-30 14:56:38.821726Z] Finished run-tests step (success) 07:56:38 INFO - Running post-run listener: _resource_record_post_run 07:56:38 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 353832960; Read time: 0; Write time: 423148 07:56:38 INFO - TinderboxPrint: CPU usage
13.0% 07:56:38 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:56:38 INFO - TinderboxPrint: I/O write bytes / time
353,832,960 / 423,148 07:56:38 INFO - TinderboxPrint: CPU idle
8,252.0 (87.0%) 07:56:38 INFO - TinderboxPrint: CPU user
1,192.1 (12.6%) 07:56:38 INFO - TinderboxPrint: Swap in / out
0 / 0 07:56:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107270144; Read time: 0; Write time: 120664 07:56:38 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 245719040; Read time: 0; Write time: 302476 07:56:39 INFO - Running post-run listener: _upload_blobber_files 07:56:39 INFO - Blob upload gear active. 07:56:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:39 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 07:56:39 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'] 07:56:39 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 07:56:39 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:56:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:56:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:40 INFO - (blobuploader) - INFO - Done attempting. 07:56:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:48 INFO - (blobuploader) - INFO - Done attempting. 07:56:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:56:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:56:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:48 INFO - (blobuploader) - INFO - Done attempting. 07:56:48 INFO - (blobuploader) - INFO - Iteration through files over. 07:56:49 INFO - Return code: 0 07:56:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:56:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:56:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab4eff010b64c64cf3e4d81d71455244305c3cb9c0675d82754a10d09b8173e00b4b3cc1c8f2078fb787d2e9244fbc02be60130598d50e9a2528ae2f711dda02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0cb6e8e926aeabb0450954d0550bdce0b12b9df6121ba058742b5f54133b420b6e73d77258bcff22fae1aa3995275c886f2af680376e9a776ea950c14f749007", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dc3186de082b18904d286afd4c1bd30bfd42b74a11c203e63df000a7d75bff4131eb987065a8c0c6467d3143557b830c70e79db2c7edde471694810dd90d691"} 07:56:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:56:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:56:49 INFO - Contents: 07:56:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab4eff010b64c64cf3e4d81d71455244305c3cb9c0675d82754a10d09b8173e00b4b3cc1c8f2078fb787d2e9244fbc02be60130598d50e9a2528ae2f711dda02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0cb6e8e926aeabb0450954d0550bdce0b12b9df6121ba058742b5f54133b420b6e73d77258bcff22fae1aa3995275c886f2af680376e9a776ea950c14f749007", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dc3186de082b18904d286afd4c1bd30bfd42b74a11c203e63df000a7d75bff4131eb987065a8c0c6467d3143557b830c70e79db2c7edde471694810dd90d691"} 07:56:49 INFO - Running post-run listener: copy_logs_to_upload_dir 07:56:49 INFO - Copying logs to upload dir... 07:56:49 INFO - mkdir: /builds/slave/test/build/upload/logs 07:56:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.788470 ========= master_lag: 2.85 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-30 07:56:50.282268) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 07:56:50.289089) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050 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/ab4eff010b64c64cf3e4d81d71455244305c3cb9c0675d82754a10d09b8173e00b4b3cc1c8f2078fb787d2e9244fbc02be60130598d50e9a2528ae2f711dda02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0cb6e8e926aeabb0450954d0550bdce0b12b9df6121ba058742b5f54133b420b6e73d77258bcff22fae1aa3995275c886f2af680376e9a776ea950c14f749007", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dc3186de082b18904d286afd4c1bd30bfd42b74a11c203e63df000a7d75bff4131eb987065a8c0c6467d3143557b830c70e79db2c7edde471694810dd90d691"} build_url:https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/BIWz9CtSSRKSlfmg2m3New/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/ab4eff010b64c64cf3e4d81d71455244305c3cb9c0675d82754a10d09b8173e00b4b3cc1c8f2078fb787d2e9244fbc02be60130598d50e9a2528ae2f711dda02", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0cb6e8e926aeabb0450954d0550bdce0b12b9df6121ba058742b5f54133b420b6e73d77258bcff22fae1aa3995275c886f2af680376e9a776ea950c14f749007", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dc3186de082b18904d286afd4c1bd30bfd42b74a11c203e63df000a7d75bff4131eb987065a8c0c6467d3143557b830c70e79db2c7edde471694810dd90d691"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 07:56:50.402639) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:56:50.404979) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1475243539.707466-1451268050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004779 ========= master_lag: 0.89 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 07:56:51.298386) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 07:56:51.304717) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 07:56:51.329292) ========= ========= Total master_lag: 3.90 =========